builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0215 starttime: 1471349697.75 results: success (0) buildid: 20160816031824 builduid: ffddcfbe512d4f0182f44f9fb9ba8604 revision: bc160abe215baed95384cb10e17118b168caa05a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:57.747937) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:57.748350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:57.748636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:57.773628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:57.774022) ========= 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.OWj3pUk2yf/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.sqCiGamkOk/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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-16 05:14:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-08-16 05:14:57 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130148 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:57.930278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:57.930601) ========= 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.OWj3pUk2yf/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.sqCiGamkOk/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.025720 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:57.980449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 05:14:57.980981) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bc160abe215baed95384cb10e17118b168caa05a --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 bc160abe215baed95384cb10e17118b168caa05a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OWj3pUk2yf/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.sqCiGamkOk/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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-16 05:14:58,065 truncating revision to first 12 chars 2016-08-16 05:14:58,065 Setting DEBUG logging. 2016-08-16 05:14:58,065 attempt 1/10 2016-08-16 05:14:58,065 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bc160abe215b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 05:14:59,125 unpacking tar archive at: fx-team-bc160abe215b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 05:14:59.352153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:59.352892) ========= script_repo_revision: bc160abe215baed95384cb10e17118b168caa05a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:59.353859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:59.354522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:14:59.373281) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-16 05:14:59.373942) ========= /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.OWj3pUk2yf/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.sqCiGamkOk/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:14:59 INFO - MultiFileLogger online at 20160816 05:14:59 in /builds/slave/test 05:14:59 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:14:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:14:59 INFO - {'append_to_log': False, 05:14:59 INFO - 'base_work_dir': '/builds/slave/test', 05:14:59 INFO - 'blob_upload_branch': 'Fx-Team', 05:14:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:14:59 INFO - 'branch': 'Fx-Team', 05:14:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:14:59 INFO - 'config_files': ('talos/mac_config.py',), 05:14:59 INFO - 'default_actions': ('clobber', 05:14:59 INFO - 'read-buildbot-config', 05:14:59 INFO - 'download-and-extract', 05:14:59 INFO - 'populate-webroot', 05:14:59 INFO - 'create-virtualenv', 05:14:59 INFO - 'install', 05:14:59 INFO - 'run-tests'), 05:14:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:14:59 INFO - 'download_minidump_stackwalk': True, 05:14:59 INFO - 'download_symbols': 'ondemand', 05:14:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:14:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:14:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:14:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:14:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:14:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:14:59 INFO - 'installer_path': 'installer.exe', 05:14:59 INFO - 'log_level': 'info', 05:14:59 INFO - 'log_name': 'talos', 05:14:59 INFO - 'log_to_console': True, 05:14:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:14:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:14:59 INFO - 'opt_config_files': (), 05:14:59 INFO - 'pip_index': False, 05:14:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:14:59 INFO - 'cmd': ('bash', 05:14:59 INFO - '-c', 05:14:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:14:59 INFO - 'enabled': True, 05:14:59 INFO - 'halt_on_failure': False, 05:14:59 INFO - 'name': 'check_screen_resolution'},), 05:14:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:14:59 INFO - 'cmd': ('bash', 05:14:59 INFO - '-c', 05:14:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:14:59 INFO - 'enabled': True, 05:14:59 INFO - 'halt_on_failure': False, 05:14:59 INFO - 'name': 'check_screen_resolution'},), 05:14:59 INFO - 'run_cmd_checks_enabled': True, 05:14:59 INFO - 'sps_profile': False, 05:14:59 INFO - 'sps_profile_interval': 0, 05:14:59 INFO - 'suite': 'dromaeojs', 05:14:59 INFO - 'system_bits': '32', 05:14:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:14:59 INFO - 'title': 't-yosemite-r7-0215', 05:14:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:14:59 INFO - 'use_talos_json': True, 05:14:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:14:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:14:59 INFO - 'work_dir': 'build'} 05:14:59 INFO - [mozharness: 2016-08-16 12:14:59.569292Z] Running clobber step. 05:14:59 INFO - Running pre-action listener: _resource_record_pre_action 05:14:59 INFO - Running main action method: clobber 05:14:59 INFO - rmtree: /builds/slave/test/build 05:14:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:01 INFO - Running post-action listener: _resource_record_post_action 05:15:01 INFO - [mozharness: 2016-08-16 12:15:01.566143Z] Finished clobber step (success) 05:15:01 INFO - [mozharness: 2016-08-16 12:15:01.566301Z] Running read-buildbot-config step. 05:15:01 INFO - Running pre-action listener: _resource_record_pre_action 05:15:01 INFO - Running main action method: read_buildbot_config 05:15:01 INFO - Using buildbot properties: 05:15:01 INFO - { 05:15:01 INFO - "project": "", 05:15:01 INFO - "product": "firefox", 05:15:01 INFO - "script_repo_revision": "production", 05:15:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:15:01 INFO - "repository": "", 05:15:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:15:01 INFO - "buildid": "20160816031824", 05:15:01 INFO - "pgo_build": "False", 05:15:01 INFO - "basedir": "/builds/slave/test", 05:15:01 INFO - "buildnumber": 91, 05:15:01 INFO - "slavename": "t-yosemite-r7-0215", 05:15:01 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:15:01 INFO - "platform": "yosemite_r7", 05:15:01 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:15:01 INFO - "branch": "fx-team", 05:15:01 INFO - "repo_path": "integration/fx-team", 05:15:01 INFO - "revision": "bc160abe215baed95384cb10e17118b168caa05a", 05:15:01 INFO - "stage_platform": "macosx64", 05:15:01 INFO - "builduid": "ffddcfbe512d4f0182f44f9fb9ba8604", 05:15:01 INFO - "slavebuilddir": "test" 05:15:01 INFO - } 05:15:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:15:01 INFO - Running post-action listener: _resource_record_post_action 05:15:01 INFO - [mozharness: 2016-08-16 12:15:01.569558Z] Finished read-buildbot-config step (success) 05:15:01 INFO - [mozharness: 2016-08-16 12:15:01.569692Z] Running download-and-extract step. 05:15:01 INFO - Running pre-action listener: _resource_record_pre_action 05:15:01 INFO - Running main action method: download_and_extract 05:15:01 INFO - mkdir: /builds/slave/test/build/tests 05:15: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:15:01 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:03 INFO - Downloaded 1199 bytes. 05:15:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:15:03 INFO - Using the following test package requirements: 05:15:03 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:15:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:03 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:15:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:03 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:15:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:03 INFO - u'jsshell-mac.zip'], 05:15:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:03 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:15:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:15:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:03 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:15:03 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:03 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:15:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:03 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:15:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:15:03 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:15:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:15:03 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:15:03 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:15:03 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:04 INFO - Downloaded 16332055 bytes. 05:15:04 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:15:11 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:15:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:11 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:15:11 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:12 INFO - Downloaded 16332055 bytes. 05:15:12 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:15: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:15:18 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:15:18 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:20 INFO - Downloaded 14413719 bytes. 05:15:20 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:15:21 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:15:21 INFO - trying https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:15:21 INFO - Downloading https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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:15:24 INFO - Downloaded 111109788 bytes. 05:15:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:15:24 INFO - mkdir: /builds/slave/test/properties 05:15:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:24 INFO - Contents: 05:15:24 INFO - build_url:https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:15:25 INFO - Running post-action listener: _resource_record_post_action 05:15:25 INFO - Running post-action listener: set_extra_try_arguments 05:15:25 INFO - [mozharness: 2016-08-16 12:15:25.316606Z] Finished download-and-extract step (success) 05:15:25 INFO - [mozharness: 2016-08-16 12:15:25.316755Z] Running populate-webroot step. 05:15:25 INFO - Running pre-action listener: _resource_record_pre_action 05:15:25 INFO - Running main action method: populate_webroot 05:15:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:25 INFO - '--tppagecycles', 05:15:25 INFO - '7'], 05:15:25 INFO - 'tests': ['tsvgm']}}, 05:15:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:15:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:15:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:25 INFO - 'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:25 INFO - 'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['damp', 'tps']}, 05:15:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:25 INFO - 'tests': ['damp', 'tps']}, 05:15:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['dromaeo_dom']}, 05:15:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['basic_compositor_video']}, 05:15:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:15:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['a11yr', 05:15:25 INFO - 'ts_paint', 05:15:25 INFO - 'tpaint', 05:15:25 INFO - 'sessionrestore', 05:15:25 INFO - 'sessionrestore_no_auto_restore', 05:15:25 INFO - 'tabpaint']}, 05:15:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:15:25 INFO - 'ts_paint', 05:15:25 INFO - 'tpaint', 05:15:25 INFO - 'sessionrestore', 05:15:25 INFO - 'sessionrestore_no_auto_restore', 05:15:25 INFO - 'tabpaint']}, 05:15:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:15:25 INFO - 'ts_paint', 05:15:25 INFO - 'tpaint', 05:15:25 INFO - 'sessionrestore', 05:15:25 INFO - 'sessionrestore_no_auto_restore', 05:15:25 INFO - 'tabpaint']}, 05:15:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:15:25 INFO - 'ts_paint', 05:15:25 INFO - 'tpaint', 05:15:25 INFO - 'sessionrestore', 05:15:25 INFO - 'sessionrestore_no_auto_restore', 05:15:25 INFO - 'tabpaint']}, 05:15:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['a11yr', 05:15:25 INFO - 'ts_paint', 05:15:25 INFO - 'tpaint', 05:15:25 INFO - 'sessionrestore', 05:15:25 INFO - 'sessionrestore_no_auto_restore', 05:15:25 INFO - 'tabpaint']}, 05:15:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['a11yr', 05:15:25 INFO - 'ts_paint', 05:15:25 INFO - 'tpaint', 05:15:25 INFO - 'sessionrestore', 05:15:25 INFO - 'sessionrestore_no_auto_restore', 05:15:25 INFO - 'tabpaint']}, 05:15:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['tsvgx', 05:15:25 INFO - 'tsvgr_opacity', 05:15:25 INFO - 'tart', 05:15:25 INFO - 'tscrollx', 05:15:25 INFO - 'cart']}, 05:15:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:15:25 INFO - 'tsvgr_opacity', 05:15:25 INFO - 'tart', 05:15:25 INFO - 'tscrollx', 05:15:25 INFO - 'cart']}, 05:15:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:25 INFO - 'talos_options': ['--disable-e10s'], 05:15:25 INFO - 'tests': ['tp5o']}, 05:15:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:25 INFO - 'tests': ['tp5o']}, 05:15:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:25 INFO - 'talos_options': ['--disable-e10s', 05:15:25 INFO - '--xperf_path', 05:15:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:25 INFO - 'tests': ['tp5n']}, 05:15:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:25 INFO - 'talos_options': ['--xperf_path', 05:15:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:25 INFO - 'tests': ['tp5n']}}, 05:15:25 INFO - 'talos.zip': {'path': '', 05:15:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:25 INFO - Running post-action listener: _resource_record_post_action 05:15:25 INFO - [mozharness: 2016-08-16 12:15:25.335601Z] Finished populate-webroot step (success) 05:15:25 INFO - [mozharness: 2016-08-16 12:15:25.335742Z] Running create-virtualenv step. 05:15:25 INFO - Running pre-action listener: _resource_record_pre_action 05:15:25 INFO - Running main action method: create_virtualenv 05:15:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:25 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:15:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:25 INFO - Using real prefix '/tools/python27' 05:15:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:29 INFO - Installing pip.................done. 05:15:29 INFO - Return code: 0 05:15:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:29 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:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:29 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:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:29 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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15:29 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:15:29 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:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:29 INFO - 'HOME': '/Users/cltbld', 05:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:29 INFO - 'LOGNAME': 'cltbld', 05:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:29 INFO - 'MOZ_NO_REMOTE': '1', 05:15:29 INFO - 'NO_EM_RESTART': '1', 05:15:29 INFO - 'PAGER': '/bin/cat', 05:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:29 INFO - 'PWD': '/builds/slave/test', 05:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:29 INFO - 'SHELL': '/bin/bash', 05:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:29 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:29 INFO - 'USER': 'cltbld', 05:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:29 INFO - 'XPC_FLAGS': '0x0', 05:15:29 INFO - 'XPC_SERVICE_NAME': '0', 05:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:29 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:15:29 INFO - Cleaning up... 05:15:29 INFO - Return code: 0 05:15:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:15:29 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:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:29 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:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:29 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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15:29 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:15:29 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:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:29 INFO - 'HOME': '/Users/cltbld', 05:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:29 INFO - 'LOGNAME': 'cltbld', 05:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:29 INFO - 'MOZ_NO_REMOTE': '1', 05:15:29 INFO - 'NO_EM_RESTART': '1', 05:15:29 INFO - 'PAGER': '/bin/cat', 05:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:29 INFO - 'PWD': '/builds/slave/test', 05:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:29 INFO - 'SHELL': '/bin/bash', 05:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:29 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:29 INFO - 'USER': 'cltbld', 05:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:29 INFO - 'XPC_FLAGS': '0x0', 05:15:29 INFO - 'XPC_SERVICE_NAME': '0', 05:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:29 INFO - Downloading/unpacking psutil>=3.1.1 05:15:29 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:15:29 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:15:29 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:15:29 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:15:29 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:15:29 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:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:32 INFO - Installing collected packages: psutil 05:15:32 INFO - Running setup.py install for psutil 05:15:32 INFO - building 'psutil._psutil_osx' extension 05:15:32 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:15:33 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:15:33 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:15:33 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:15:33 INFO - building 'psutil._psutil_posix' extension 05:15:33 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:15:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:15:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:15:33 INFO - ^ 05:15:33 INFO - 1 warning generated. 05:15:33 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:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:34 INFO - Successfully installed psutil 05:15:34 INFO - Cleaning up... 05:15:34 INFO - Return code: 0 05:15:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:34 INFO - 'HOME': '/Users/cltbld', 05:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:34 INFO - 'LOGNAME': 'cltbld', 05:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:34 INFO - 'MOZ_NO_REMOTE': '1', 05:15:34 INFO - 'NO_EM_RESTART': '1', 05:15:34 INFO - 'PAGER': '/bin/cat', 05:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:34 INFO - 'PWD': '/builds/slave/test', 05:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:34 INFO - 'SHELL': '/bin/bash', 05:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:34 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:34 INFO - 'USER': 'cltbld', 05:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:34 INFO - 'XPC_FLAGS': '0x0', 05:15:34 INFO - 'XPC_SERVICE_NAME': '0', 05:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:34 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:15:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:15:36 INFO - Installing collected packages: mozsystemmonitor 05:15:36 INFO - Running setup.py install for mozsystemmonitor 05:15:36 INFO - Successfully installed mozsystemmonitor 05:15:36 INFO - Cleaning up... 05:15:37 INFO - Return code: 0 05:15:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:15: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:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:37 INFO - 'HOME': '/Users/cltbld', 05:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:37 INFO - 'LOGNAME': 'cltbld', 05:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:37 INFO - 'MOZ_NO_REMOTE': '1', 05:15:37 INFO - 'NO_EM_RESTART': '1', 05:15:37 INFO - 'PAGER': '/bin/cat', 05:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:37 INFO - 'PWD': '/builds/slave/test', 05:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:37 INFO - 'SHELL': '/bin/bash', 05:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:37 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:37 INFO - 'USER': 'cltbld', 05:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:37 INFO - 'XPC_FLAGS': '0x0', 05:15:37 INFO - 'XPC_SERVICE_NAME': '0', 05:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:37 INFO - Downloading/unpacking jsonschema==2.5.1 05:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:40 INFO - warning: no files found matching '*.txt' 05:15:40 INFO - no previously-included directories found matching 'build' 05:15:40 INFO - no previously-included directories found matching 'dist' 05:15:40 INFO - no previously-included directories found matching '.git*' 05:15:40 INFO - Installing collected packages: jsonschema, functools32 05:15:40 INFO - Running setup.py install for functools32 05:15:40 INFO - warning: no files found matching '*.txt' 05:15:40 INFO - no previously-included directories found matching 'build' 05:15:40 INFO - no previously-included directories found matching 'dist' 05:15:40 INFO - no previously-included directories found matching '.git*' 05:15:40 INFO - Successfully installed jsonschema functools32 05:15:40 INFO - Cleaning up... 05:15:40 INFO - Return code: 0 05:15:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:15: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:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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', '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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:15: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 functools32==3.2.3-2 05:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:40 INFO - 'HOME': '/Users/cltbld', 05:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:40 INFO - 'LOGNAME': 'cltbld', 05:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:40 INFO - 'MOZ_NO_REMOTE': '1', 05:15:40 INFO - 'NO_EM_RESTART': '1', 05:15:40 INFO - 'PAGER': '/bin/cat', 05:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:40 INFO - 'PWD': '/builds/slave/test', 05:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:40 INFO - 'SHELL': '/bin/bash', 05:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:40 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:40 INFO - 'USER': 'cltbld', 05:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:40 INFO - 'XPC_FLAGS': '0x0', 05:15:40 INFO - 'XPC_SERVICE_NAME': '0', 05:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:15:40 INFO - Cleaning up... 05:15:40 INFO - Return code: 0 05:15:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15: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:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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', '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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:15: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 blobuploader==1.2.4 05:15:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:40 INFO - 'HOME': '/Users/cltbld', 05:15:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:40 INFO - 'LOGNAME': 'cltbld', 05:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:40 INFO - 'MOZ_NO_REMOTE': '1', 05:15:40 INFO - 'NO_EM_RESTART': '1', 05:15:40 INFO - 'PAGER': '/bin/cat', 05:15:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:40 INFO - 'PWD': '/builds/slave/test', 05:15:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:40 INFO - 'SHELL': '/bin/bash', 05:15:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:40 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:40 INFO - 'USER': 'cltbld', 05:15:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:40 INFO - 'XPC_FLAGS': '0x0', 05:15:40 INFO - 'XPC_SERVICE_NAME': '0', 05:15:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:15:41 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:15:41 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:15:41 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:15:41 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:15:41 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:15:41 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:15:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15: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:15: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:15: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:15: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:15: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:15: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:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:44 INFO - Downloading docopt-0.6.1.tar.gz 05:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:44 INFO - Running setup.py install for blobuploader 05:15:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:44 INFO - Running setup.py install for requests 05:15:45 INFO - Running setup.py install for docopt 05:15:45 INFO - Successfully installed blobuploader requests docopt 05:15:45 INFO - Cleaning up... 05:15:45 INFO - Return code: 0 05:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:45 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:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:45 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:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:45 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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15:45 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:15:45 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:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:45 INFO - 'HOME': '/Users/cltbld', 05:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:45 INFO - 'LOGNAME': 'cltbld', 05:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:45 INFO - 'MOZ_NO_REMOTE': '1', 05:15:45 INFO - 'NO_EM_RESTART': '1', 05:15:45 INFO - 'PAGER': '/bin/cat', 05:15:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:45 INFO - 'PWD': '/builds/slave/test', 05:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:45 INFO - 'SHELL': '/bin/bash', 05:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:45 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:45 INFO - 'USER': 'cltbld', 05:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:45 INFO - 'XPC_FLAGS': '0x0', 05:15:45 INFO - 'XPC_SERVICE_NAME': '0', 05:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:45 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-_PFx5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-g_2nhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-gylIvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-hJqSNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-thbFSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-q3wk__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-IMiiGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-UmTj_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-qX0ZWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-2GbqoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:46 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-W7d6s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-k26tq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-FqIEoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-bhcrUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-wm6NX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-_OFlNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-XbEpMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:47 INFO - Running setup.py install for manifestparser 05:15:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:47 INFO - Running setup.py install for mozcrash 05:15:47 INFO - Running setup.py install for mozdebug 05:15:48 INFO - Running setup.py install for mozdevice 05:15:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:48 INFO - Running setup.py install for mozfile 05:15:48 INFO - Running setup.py install for mozhttpd 05:15:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:48 INFO - Running setup.py install for mozinfo 05:15:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:48 INFO - Running setup.py install for mozInstall 05:15:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:48 INFO - Running setup.py install for mozleak 05:15:48 INFO - Running setup.py install for mozlog 05:15:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:49 INFO - Running setup.py install for moznetwork 05:15:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:49 INFO - Running setup.py install for mozprocess 05:15:49 INFO - Running setup.py install for mozprofile 05:15:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:49 INFO - Running setup.py install for mozrunner 05:15:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:49 INFO - Running setup.py install for mozscreenshot 05:15:49 INFO - Running setup.py install for moztest 05:15:50 INFO - Running setup.py install for mozversion 05:15:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:50 INFO - Cleaning up... 05:15:50 INFO - Return code: 0 05:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:50 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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15:50 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:15:50 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:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:50 INFO - 'HOME': '/Users/cltbld', 05:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:50 INFO - 'LOGNAME': 'cltbld', 05:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:50 INFO - 'MOZ_NO_REMOTE': '1', 05:15:50 INFO - 'NO_EM_RESTART': '1', 05:15:50 INFO - 'PAGER': '/bin/cat', 05:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:50 INFO - 'PWD': '/builds/slave/test', 05:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:50 INFO - 'SHELL': '/bin/bash', 05:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:50 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:50 INFO - 'USER': 'cltbld', 05:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:50 INFO - 'XPC_FLAGS': '0x0', 05:15:50 INFO - 'XPC_SERVICE_NAME': '0', 05:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:50 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-GIJP3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:50 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-tmkbYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:50 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-MmSjZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:50 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-GyWgD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:50 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:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:50 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-hNoJya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-RwBrHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-PyvQP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-XzvrOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-VWCxlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-lDt1xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-dqvzAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-Bniz8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-bzRVaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:51 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:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-871d0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-vh9X1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-atbpM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:52 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:15:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-lCpvTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:52 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:15:52 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:15:52 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:15:52 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:15:52 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:15:52 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:15:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:52 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:15:52 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:15:52 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:15:52 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:15:52 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:15:52 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:15:55 INFO - Downloading blessings-1.6.tar.gz 05:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:55 INFO - Installing collected packages: blessings 05:15:55 INFO - Running setup.py install for blessings 05:15:55 INFO - Successfully installed blessings 05:15:55 INFO - Cleaning up... 05:15:55 INFO - Return code: 0 05:15:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:55 INFO - Reading from file tmpfile_stdout 05:15:55 INFO - Current package versions: 05:15:55 INFO - blessings == 1.6 05:15:55 INFO - blobuploader == 1.2.4 05:15:55 INFO - docopt == 0.6.1 05:15:55 INFO - functools32 == 3.2.3-2 05:15:55 INFO - jsonschema == 2.5.1 05:15:55 INFO - manifestparser == 1.1 05:15:55 INFO - mozInstall == 1.12 05:15:55 INFO - mozcrash == 0.17 05:15:55 INFO - mozdebug == 0.1 05:15:55 INFO - mozdevice == 0.48 05:15:55 INFO - mozfile == 1.2 05:15:55 INFO - mozhttpd == 0.7 05:15:55 INFO - mozinfo == 0.9 05:15:55 INFO - mozleak == 0.1 05:15:55 INFO - mozlog == 3.3 05:15:55 INFO - moznetwork == 0.27 05:15:55 INFO - mozprocess == 0.23 05:15:55 INFO - mozprofile == 0.28 05:15:55 INFO - mozrunner == 6.12 05:15:55 INFO - mozscreenshot == 0.1 05:15:55 INFO - mozsystemmonitor == 0.3 05:15:55 INFO - moztest == 0.7 05:15:55 INFO - mozversion == 1.4 05:15:55 INFO - psutil == 3.1.1 05:15:55 INFO - requests == 1.2.3 05:15:55 INFO - wsgiref == 0.1.2 05:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:55 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:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:56 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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15:56 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:15:56 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:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:56 INFO - 'HOME': '/Users/cltbld', 05:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:56 INFO - 'LOGNAME': 'cltbld', 05:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:56 INFO - 'MOZ_NO_REMOTE': '1', 05:15:56 INFO - 'NO_EM_RESTART': '1', 05:15:56 INFO - 'PAGER': '/bin/cat', 05:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:56 INFO - 'PWD': '/builds/slave/test', 05:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:56 INFO - 'SHELL': '/bin/bash', 05:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:56 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:56 INFO - 'USER': 'cltbld', 05:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:56 INFO - 'XPC_FLAGS': '0x0', 05:15:56 INFO - 'XPC_SERVICE_NAME': '0', 05:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 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:15:56 INFO - Cleaning up... 05:15:56 INFO - Return code: 0 05:15:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15: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:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:56 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 0x105851a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058e6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f058cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, '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.OWj3pUk2yf/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.sqCiGamkOk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:15:56 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:15:56 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:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:56 INFO - 'HOME': '/Users/cltbld', 05:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:56 INFO - 'LOGNAME': 'cltbld', 05:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:56 INFO - 'MOZ_NO_REMOTE': '1', 05:15:56 INFO - 'NO_EM_RESTART': '1', 05:15:56 INFO - 'PAGER': '/bin/cat', 05:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:56 INFO - 'PWD': '/builds/slave/test', 05:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:56 INFO - 'SHELL': '/bin/bash', 05:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:15:56 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:56 INFO - 'USER': 'cltbld', 05:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:56 INFO - 'XPC_FLAGS': '0x0', 05:15:56 INFO - 'XPC_SERVICE_NAME': '0', 05:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:56 INFO - Cleaning up... 05:15:56 INFO - Return code: 0 05:15:56 INFO - Running post-action listener: _resource_record_post_action 05:15:56 INFO - Running post-action listener: _start_resource_monitoring 05:15:56 INFO - Starting resource monitoring. 05:15:56 INFO - [mozharness: 2016-08-16 12:15:56.757578Z] Finished create-virtualenv step (success) 05:15:56 INFO - [mozharness: 2016-08-16 12:15:56.758630Z] Running install step. 05:15:56 INFO - Running pre-action listener: _resource_record_pre_action 05:15:56 INFO - Running main action method: install 05:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:57 INFO - Reading from file tmpfile_stdout 05:15:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:57 INFO - Reading from file tmpfile_stdout 05:15:57 INFO - Output received: 05:15:57 INFO - Usage: mozinstall [options] installer 05:15:57 INFO - Options: 05:15:57 INFO - -h, --help show this help message and exit 05:15:57 INFO - -d DEST, --destination=DEST 05:15:57 INFO - Directory to install application into. [default: 05:15:57 INFO - "/builds/slave/test"] 05:15:57 INFO - --app=APP Application being installed. [default: firefox] 05:15:57 INFO - mkdir: /builds/slave/test/build/application 05:15:57 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:15:57 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:16:31 INFO - Reading from file tmpfile_stdout 05:16:31 INFO - Output received: 05:16:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:16:31 INFO - Running post-action listener: _resource_record_post_action 05:16:31 INFO - [mozharness: 2016-08-16 12:16:31.333128Z] Finished install step (success) 05:16:31 INFO - [mozharness: 2016-08-16 12:16:31.333286Z] Running run-tests step. 05:16:31 INFO - Running pre-action listener: _resource_record_pre_action 05:16:31 INFO - Running main action method: run_tests 05:16:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:31 INFO - 2016-08-16 05:16:31.347 screenresolution[1634:7408] starting screenresolution argv=screenresolution get 05:16:31 INFO - 2016-08-16 05:16:31.350 screenresolution[1634:7408] Display 0: 1600x1200x32@60 05:16:31 INFO - 2016-08-16 05:16:31.356 screenresolution[1635:7410] starting screenresolution argv=screenresolution list 05:16:31 INFO - Available Modes on Display 0 05:16:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:31 INFO - Intel Iris: 05:16:31 INFO - Chipset Model: Intel Iris 05:16:31 INFO - Type: GPU 05:16:31 INFO - Bus: Built-In 05:16:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:31 INFO - Vendor: Intel (0x8086) 05:16:31 INFO - Device ID: 0x0a2e 05:16:31 INFO - Revision ID: 0x0009 05:16:31 INFO - Displays: 05:16:31 INFO - Display: 05:16:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:31 INFO - Display Serial Number: 1600x1200 60 05:16:31 INFO - Main Display: Yes 05:16:31 INFO - Mirror: Off 05:16:31 INFO - Online: Yes 05:16:31 INFO - Rotation: Supported 05:16:31 INFO - Return code: 0 05:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:31 INFO - Python 2.7.3 05:16:31 INFO - Return code: 0 05:16:31 INFO - grabbing minidump binary from tooltool 05:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:31 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 0x1057b5d30>, '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 0x10551adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057adb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:31 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:16:31 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:16:31 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:16:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:31 INFO - Return code: 0 05:16:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:16:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:16:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:31 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/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--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:16:31 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/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0215 --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:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OWj3pUk2yf/Render', 05:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:31 INFO - 'HOME': '/Users/cltbld', 05:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:31 INFO - 'LOGNAME': 'cltbld', 05:16:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:31 INFO - 'MOZ_NO_REMOTE': '1', 05:16:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:31 INFO - 'NO_EM_RESTART': '1', 05:16:31 INFO - 'PAGER': '/bin/cat', 05:16:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:31 INFO - 'PWD': '/builds/slave/test', 05:16:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:31 INFO - 'SHELL': '/bin/bash', 05:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqCiGamkOk/Listeners', 05:16:31 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 05:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:31 INFO - 'USER': 'cltbld', 05:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:31 INFO - 'XPC_FLAGS': '0x0', 05:16:31 INFO - 'XPC_SERVICE_NAME': '0', 05:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:31 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/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--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:16:31 INFO - mozversion application_buildid: 20160816031824 05:16:31 INFO - mozversion application_changeset: bc160abe215baed95384cb10e17118b168caa05a 05:16:31 INFO - mozversion application_display_name: Nightly 05:16:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:31 INFO - mozversion application_name: Firefox 05:16:31 INFO - mozversion application_remotingname: firefox 05:16:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:16:31 INFO - mozversion application_vendor: Mozilla 05:16:31 INFO - mozversion application_version: 51.0a1 05:16:31 INFO - mozversion platform_buildid: 20160816031824 05:16:31 INFO - mozversion platform_changeset: bc160abe215baed95384cb10e17118b168caa05a 05:16:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:16:31 INFO - mozversion platform_version: 51.0a1 05:16:31 INFO - using testdate: 1471349791 05:16:31 INFO - actual date: 1471349791 05:16:31 INFO - starting webserver on 'localhost:49267' 05:16:31 INFO - SUITE-START | Running 2 tests 05:16:31 INFO - TEST-START | dromaeo_css 05:16:31 INFO - operating with platform_type : mac_ 05:16:31 INFO - Initialising browser for dromaeo_css test... 05:16:31 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpIGh49k/profile http://localhost:49267/getInfo.html) 05:16:34 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 05:16:34 INFO - PROCESS | 1645 | colorDepth:24 05:16:34 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 05:16:34 INFO - PROCESS | 1645 | __metrics 05:16:34 INFO - PROCESS | 1645 | 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:16:34 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:16:35 INFO - TEST-INFO | 1645: exit 0 05:16:35 INFO - Browser initialized. 05:16:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:35 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpIGh49k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:47 INFO - PROCESS | 1647 | RSS: Main: 228569088 05:16:47 INFO - PROCESS | 1647 | 05:17:38 INFO - PROCESS | 1647 | 1471349858990 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:19:49 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 05:19:51 INFO - PROCESS | 1647 | RSS: Main: 355155968 05:19:51 INFO - PROCESS | 1647 | 05:22:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 05:22:54 INFO - PROCESS | 1647 | RSS: Main: 368771072 05:22:54 INFO - PROCESS | 1647 | 05:25:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 05:25:57 INFO - PROCESS | 1647 | RSS: Main: 333119488 05:25:57 INFO - PROCESS | 1647 | 05:29:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 05:29:01 INFO - PROCESS | 1647 | RSS: Main: 343552000 05:29:01 INFO - PROCESS | 1647 | 05:32:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 05:32:05 INFO - PROCESS | 1647 | RSS: Main: 330665984 05:32:05 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 05:35:08 INFO - PROCESS | 1647 | RSS: Main: 498995200 05:35:08 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | __start_tp_report 05:35:08 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 05:35:08 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 05:35:08 INFO - PROCESS | 1647 | |i|pagename|runs| 05:35:08 INFO - PROCESS | 1647 | |0;dojo.html;3397.694207521321;3398.2184097657537;3419.4016047191744;3442.363162814878;3475.7393195510326;5608.6073974821775;5708.514776244019;5768.163616275638;5816.825495235139;5844.79543215987;5777;5787.50806181475;5809.651420914748;5810.738516766745;5818.359980402152;5236.031334203175;5264.2893209416625;5282.577393808505;5291.206319052135;5361.839144825662;5206.219067139921;5290.947090529103;5312.893742125175;5326;5359.196120581905;5294.7617357219015;5303.337082864642;5314.521693047625;5324.973375133119;5377.059014672436;543.4924421747157;5283.996040752283;5369.62412631116;5374.946250537484;5379.300690910176;5303.840884773463;5317.494837990384;5324;5329.653572517774;5331.440198779111;5702.600817942745;5819.621724587888;5856.267966504187;5886.587938844283;5891;6052.636841789463;6106.938930610681;6203.937960620427;6207.379262073801;6212.502999760009;6096.987993961982;6169.475594574422;6178.104174894615;6189.81430557084;6193.5045196384635;5748.885022299531;5751.511121554715;5756.683382413966;5763.942360576382;5768.7692492300675;5387.326584176978;6335.556511044275;6384.3934826191435;6388.872222555523;6397.072424498421;6153.4154255345675;6199.380061993765;6211.378862113753;6220.906686399708;6220.968895155495;6140;6178.443940045418;6303.779367722108;6333.334999825044;6374.107624932513;6167.105769663373;6202.317745048041;6246.843828904223;6316.873662526816;6316.9368306317265;6285.214348206474;6287.245530536365;6295.433410992941;6299;6319.020551814476;4874.8537543873745;4971.825986090469;4986.276989836526;4991.800327986913;5013.39839219296;4422.469303683579;4431.8448854289945;4482.484514280834;4489.281714925596;4540.931886021713;5805.419458054161;5809.215755872903;5818.796342128006;5828.067509198508;5872.442117998783;6323;6335.968320158369;6342.778002769881;6343.524235682342;6381.585196962275;5631.802886898939;5741.220221731277;5774.566907481955;5803.680797556175;5881.764729410861;5467.261919640798;5498.80754173602;5500.037493438632;5502.642328248651;5504.4770746778995;6412.102305677302;6465.450436712932;6483.902741458882;6484.481241500763;6493.188351456068;6164.660943647963;6261.5616906816085;6306.810795676137;6339.429451349216;6344.175257216532;6450.7097180627925;6466.482681385572;6478.773242936474;6479.546431749733;6482.546221764431;6276.466500347339;6290.150829637941;6291.150694656163;6298.0552917062805;6308.463780578702;6194.349593292639;6243;6282.340354262737;6288.213973253343;6356.364363563606;6164.815055548341;6180.598261113013;6191.473724733448;6199.16311297969;6230.096635987847;5277.261183434399;6118.816435506942;6147.569670123048;6174.598651087665;6175.505959523138;5843.240378750906;5923.289205295392;5984.58107932458;5997.190379298739;6093.817185484442;6165.72254248551;6173.41352571505;6177.166082578794;6199.721012554356;6212.347703491249;6015.699215039318;6033.728482218398;6046.97201475759;6048.759081865031;6093.329733729375 05:35:08 INFO - PROCESS | 1647 | |1;ext.html;469.68061718031726;503.3180041044385;514.6757542748069;533.2774091106551;533.8158335374294;29839.850800745993;32188.195295117635;32321.67678323216;39437.60562394375;41007.97480063;41774.7911260444;42276.57723422765;42427.57572424275;42507.57492425075;42521.149577008444;9502.00457903841;9654.75863103421;9661.130498255156;9664.130228279453;9665.323427360088;8401.159884011611;8755.693550725726;8949.418287811304;9701.563429645683;11732.120090993167;11728.12039097067;12011.399430028463;12022;12053.939730301336;12062.69843253917;11825.994790442779;11928.224665396721;11940.940295298555;11950.163488555805;11952.52189912411;8698.695545655872;11434.256773309708;11506.424678766029;11709.180357374988;11726.589569365031;39243.41134882979;39671;39715.40426893599;39819.40270895939;39913.201735965406;3050.9542356864663;3456.861725530976;3483.3207524532727;3637.94543081854;3768.566614839301;31190.844045779624;32285.708571657105;32570.185745356317;32967.83516082428;33556.49665255023;3224.91937701557;3286.9342613147605;3324.8503817328037;3401.3197360527747;3405.080628230364;445426;459174.9999999967;459279;459628.4037159619;460986;63481;65362;65424.672876636265;65492.67253663796;65650.67174664192;68215;68608;68620.6568967152;68698;68720.28199295058;15953.521394357957;16158.949668271525;16160.27278772458;16169.676606467805;16199.67600648004;12255.203411778206;12342.691432714253;12369.196002259825;12378.566750163702;12399;17098.502145716746;17415.3033878646;17852.19665115047;20391.286304979254;20726.274580389614;8340.499570025819;8370.204830541088;8370.581470926429;8410.392778238765;8451.83096338082;899.4783025844994;914.492456686532;970.2286682087757;1033.6330602636106;1095.7479779650566;26054.73945260523;26377.736222637912;27631;30630.846845766075;30673.386532269677;939.7923668086613;991.3704797453524;1024.6977141743055;1075.887031861659;1086.223350304536;14603.123812571279;15323.923380383027;15350.771938244914;15428.537143885702;15722.764158537631;638881;644851;645519;648033;650050;48261.5173848257;53622.73188634032;54947.175792363145;55506.16740748892;55821.441785582436;1217.5555922088374;1329.2888304757103;1344.8386193656825;1360.8298962629672;1378.4417310989065;30197.396052079275;30877;30941.226469338446;31559.526607101372;31725.841370792998;47152.7642361786;55620.721896390256;57214;57233;59544;540777;543011;543416;546728;548512;26772.330691732863;27178;27555.586666199622;27860.860695696392;35091.47362789611;46088.14112125488;46432.30351544797;46708.299375510076;46974;47056.76471617757;37738.622613773514;38168.2366352677;38581.4212786814;39203.803980979916;39598.60401395949;37069.62930370662;37653.246935061696;38046.23907521779;38333.616663834124;38984.415233770946;37375.43936840895;37743.81128094342;38130.61869381271;38183.618163818006;38200.808995954845;31616.209594760316;33233;33720.32559348848;33868.49197262093;34186.48720269248;24870.50258994846;25078.498430030933;25167;25558.110139042805;25728.842202100575 05:35:08 INFO - PROCESS | 1647 | |2;jquery.html;332.83690991414204;357.5048557747519;376.1499012232356;381.2869933224869;406.93895915612654;14858.851411485895;15575.376984920604;20225.190992360323;20822.89588552057;21147.47131321718;19719.211231550722;19942.60114797703;20029.1988320467;20271.189152433923;20494.897525512388;5879.294484661847;6211.192544969148;6222.657753823538;6231.096491008823;6244.594101383395;4152.231837110129;4254.7021708480415;6104.206453161105;6201.379862013785;6886.380225779679;6891.862162756742;6905.792826215222;6916.65416729164;6926.826829329257;6933.549319294255;6691.933080669229;6755.729770809162;6802.251752307242;6869.381755642016;6869.725210991604;5660.971695141539;5870.178175055496;5913.704314784287;5926.585139040269;5933.614315069507;26798.33004174892;26803;26824.865875670694;26828.73171268282;27091.187264381904;2235.2835517058993;2374.4894847607675;2383.130157492503;2451.82837201396;2513.6857892763405;15538.456154034668;15686.68626627461;15819;15970.76043859343;16125.596860078474;1881.858860585448;1885.3212843376512;1904.2287873411153;1910.426871938413;1929.7684277886744;109685.87430986048;109735;112997;113006.30490542648;113799;10435.530401131968;10466.267361284637;10492.21308401873;10678.199135064746;10816.08063314627;11929.880701192877;12285;12572.685682858002;12984.870151298555;13009.739805203842;8136.959315203504;8260.678291473336;8286.295664868554;8366.53984030872;8479.236868681848;6793.11517924502;8319;8341.541215233221;8508;8579.957100214458;6419.422251997343;6533.640649764214;6551.901721474182;6557.9344206557325;6587.73649054042;1504.5787179589731;1761.1898526677614;1837.0998210876573;1838.172822229975;1839.2275244397117;847.876563553282;872.4198408058696;878.7232021913077;927.6474939523073;981.7692842182081;19535.0232488375;22821.20125795589;22844.771552284263;22938.885305573367;23035;932.8693982842408;949.6059135458845;953.752024473628;960.8126415348939;966.5360626898987;11206.831897521544;11238.719032024264;11613.709657258636;12019.459124339426;12032.578859739868;598430;605576;607557;614747;619118;74299;74466.62766686131;121841.39079304547;132809;142668.28665856604;940.7507010642186;973.1582181413027;1004.9999999999853;1021.4177918586483;1022.6574097677212;14382.712345752818;18880.62238755245;19328.4201473956;19454.513637159183;19580.902095489433;56603;56675;57104.1434378493;57611;60427.79144417175;80785.19214807777;81441.37117257503;83610.16389836023;84252.9448233108;86328.56835715781;7149.106361704787;7311.634418278958;7366.852662946604;7544.283293087367;7971.760847174594;11309.264897781617;12915.870841291842;13069.346532673519;13384;13589.45642174302;9048.547572621474;10457.058864702214;10592;10643.574257029943;10740;11074.833877492005;11236.269642473213;11474.541018359172;11611.776496621374;11684.532618695497;10695.358278503314;10940.015398614163;11034.944825275823;11095.334279943228;11120.555177793121;6999.370056694922;7299.708011679473;7326.267373262631;7362;7530.418612091522;8988.82014869842;10643.042126208678;10794.352338859693;10848.945755271174;10864.982582738197 05:35:08 INFO - PROCESS | 1647 | |3;mootools.html;1220.8950899436013;1504.8871334649905;1540.6687562174134;1692.7291633338668;1852.4813052345348;7611.8097047573765;8164.63259153338;8179.836403271938;8473.322134229262;8742.694005709802;8597.710343448485;8635.654573817039;8691.217790398863;8701.303895688345;8726.738197854058;2051.7230173926555;2368.348704106367;2403.0387844862107;2405.0379848060743;2405.542946840095;2343.906243750248;2377.988110059447;2388.283514945518;2390.2351247600773;2401.3516350585332;2353.2704861492907;2373.8694371809543;2381.428457170275;2390.7011623547055;2405.6632071510003;2329.301209637119;2364.5152743687504;2365.929022129339;2368.029108065702;2374.1334412939327;2323.5004474038165;2349;2352.8588284702973;2355.281639100074;2363.9172628957904;8670.826583468295;8698.999615044288;8759.605817738217;8777.42946708462;8785.604647790864;5183.585313174937;5230.843074707726;5340.732963351817;5351.411344752074;5440.863978400532;3521.2781379817075;3648.5804132524836;3729.5524537055726;3732.197577520846;3752.699784017272;914.4239129348468;1102.0247081332998;1109.351029647657;1135.727425417902;1136.0457215938652;11535.826962595567;11618.709532261677;11720.179587428884;11727.882721172764;11744.354060526668;4366.934495982563;4502.144592527409;4556.4939283394;4615.123126605934;4626.352310676508;9050.909490905138;9051.321150913707;9053.77365565853;9055.411398259092;9078.636854525745;5218.243354713545;5222.321098257202;5227.477252274742;5231.084560202025;5236.554892834151;4003.7197396181987;4453.621442177451;4546.954530454719;4883.438404583448;4887.731174785421;3631.4008188648577;3684.797336146484;3762;3782.3380908340932;3794.5067141271456;1151.6545036489188;1157.3923690062784;1176.1237877780936;1187.0681515010674;1188.257339163023;815.6003558256411;882.1927935938544;893.4371346051946;933.8513628237171;941.143559360992;5610.354809196913;5703.914441283384;6012.368701286389;6029.758809647653;6083.7870674526175;448.2558952139433;463.7426228443246;464.5772347164132;982.6560703753772;1001.1790331927749;3839.232153569297;3907.4529565860803;3958.4656071430563;4049.6760259179196;4061.045654271244;9106.86339704905;10591.417472039111;10911.727206819734;10924.96212859777;10932.453377331101;9283.210927071139;9957.253206009578;10264.64073757415;10272.383656980604;10679.145668346513;6641.435477984329;7949.960250198712;8160.83678326442;8190.344772418312;8197.016358037074;4825.372701548917;5793.913091303718;5919.526437884872;6038.396160384103;6250.812475625738;8668.479891206547;9771.609135634495;10107.090361867467;10151.934046925262;10232.539535720762;10205.183585313305;10260.589576417158;10357.533910973874;10396.48017599132;10406.063454289151;6120.418560236771;7251.383632391306;7596.658150383136;7731;7808;8134.308583770209;8340.87488687658;8427.873581896154;8441.83116337682;8465.407421480437;6232.719527621359;7368.300011498899;7468.439867009887;7550.433717471102;7578.507397019397;6351.9047214290895;6988.126484189476;7292.270772922665;7332.41340692754;7365.153007404003;6691.1636045494315;6857.451403887577;6960.129983752031;6981.441484681111;6984.371406573433;4747.098051370229;4819.060283244874;4838.322634831196;4858.684185527929;4966.428860681068;4736.621070314298;4760.690555113906;4823.03539292136;4928.137575924271;5086.61850361217 05:35:08 INFO - PROCESS | 1647 | |4;prototype.html;297.4734719546403;300.7218323051177;307.873771753581;314.4136186013083;316.6184747379408;4389.978050109749;4399.406080179175;5099.745012749357;5356.607282106651;5374.339701847586;4916.582090522301;4981.875453113674;5050.520200580948;5223.242629818674;5321.547668448186;3427.5775553145477;3876.3604005339084;4065.7357271777387;4082.836686532535;4093.7339072960312;3435.7251419886475;3590.676839084482;3964.2071585682834;4025.1949610077954;4028.3756017817286;3923.8822835314986;4056.269871423143;4061.6141466560775;4065.5324637666604;4065.9631793892518;3529.894103176883;3742.4573436851774;4105.630493255621;4122.340425531916;4127.649149822269;3043.5434684797237;3457.896263112111;3525.9294814103832;3580.820958952042;3602.279544091166;4939.185034469308;5099.566536844372;5166.457521960216;5182.948170518284;5202.609804264695;4302.924268932767;4419.867403977886;4503.774811259424;4663.090697314025;4704.670673052888;4227.8097485613225;4586.151561961048;5556.333100069963;5571.331440227199;5653.236813030229;3583.050491619723;3853.364194907837;3906.609339066099;3919.392494163409;3924.1170736584327;5550.72246387683;5585.2459917910965;5676.375598684224;5687.317521897357;5832.270966129234;3439.6216416194197;3503.9663299326758;3522.137076416243;3875.2249550090096;3910.335243008695;3475.3223121491064;3964.742291751027;3971.126352202511;4012.4583181270737;4049.7772622506045;3562.3943929532043;3675.1807855111892;4471.575200355961;4533.863984080483;4614.684814827758;4454.7549884756645;5442.91835622466;5473.7263136843;5495.313085864267;5495.340559132929;1153.5962413155328;1198.3469009389903;1321.9339033048502;1346.7441186174594;1378.6622277542067;836.6696951846593;837.5267973594899;925.319889880937;941.2328951904176;949.7530642033121;4303.827846886152;5137.460566640524;5192.299039629677;5206.687598744087;5212.9739351303;5320.536852365631;5596.048671725816;5694.722111155488;5729.799457018984;5761.5102716269585;4825.927611085836;5074.82238121664;5126.410462796752;5143.871403214949;5180.8963820723375;2361.7874391304863;2933.18414322253;2946.071987323986;2974.5686875402944;2980.8658610362586;5103.610894630615;5609.354924183689;5655.604107712503;5856.238688970407;5876.941230587639;4520.412346394947;5388.595855310789;5702.54379649627;5732.627379220421;5785.768569257267;4740.834070807505;5723.771049157987;5733.770649173986;5894.934633990301;5948.315943666447;5157.045946499909;5257.974694934451;5356.3572371315695;5425.674459532441;5635.351934527418;5084.381758157183;5171.069207542528;5174.404943431554;5446.428125046813;5455.472467709048;4853.927191092066;5049.863780649324;5379.462053794589;5586.16207568868;5876.676782776988;3616.4575313703153;3656.8720094796554;3870.4000879863665;3914.4324073009825;3949.30887094763;4766.833160839354;5444.1017232156255;5789.336905023736;5795.681237531976;5802.071668533014;4237.427947227085;4920.827771027997;5536.169574563686;5697.23087383198;5708.828735137952;4624.838130665411;4748.905021899612;5330.413654497925;5585.609007369445;5676.7161641918565;5260.605454590845;5272.340957380327;5505.091659876076;5515;5539.224508568723;4328.502222244482;5056.7471626419265;5538.224648549126;5748.48263656273;5766.711664416846;5598.076317407745;5623.2408624835125;5625.774969001194;5631.380548139619;5648.5481161507805 05:35:08 INFO - PROCESS | 1647 | |5;yui.html;710.808081817909;727.0715612281185;752.5108679358416;810.6068556749979;826.3554427546514;14980.775288370669;16141.11223882686;16199.514014579552;16200.432984845518;16224.513264602067;14675.119492830438;14846.960712750111;14854.108753474799;14854.925725371386;14855.851441485582;659.9604023758566;679.7043286170507;815.922487363701;820.2658620534618;843.9198276163785;826.1779529368287;844.9746507604782;845.7885528617845;846.3779122345071;846.9745907622781;903.9096090390974;904.0597778310549;905.0903841639143;905.384338649718;905.8686490458913;705.9964700176466;731.1591669580025;735.9300866417682;900.4732231644496;901.914318139779;538.2545174932707;538.9056915039891;648.8345471904681;672.2302963107214;678.1387637700143;14988.950773445864;15007.924960375238;15024.248787560688;15030.098194108388;15031.248437578186;13610.319484025758;13841.169529828141;13982.860171398257;14032.228227447486;14146.221957792317;12453.626391208278;12476.875231247663;12501.687457813536;12954.352282385937;13054.608361749162;4524.705894116904;4575.908481830378;4583.03756211196;4774.379330687023;4784.043191361707;93138.06861931362;93767.59348609776;93998;100376;103811;10879.075278601249;10892.237543372046;10898.730380885703;10955.287906286067;11306.321620702784;21385.465363366042;21386.78613213879;21413;21434.89282553577;21454.892725536272;7524.962375188089;7790.727324543614;7807.804804879924;7857.764267071997;7976.361891048702;4466.955330446719;4504.504504504502;4586.4266966629175;4709.317149013443;4733.9053218936115;3200.567923330367;3579.6420357964516;3740.9812950935616;3742.288965096623;3759.4924685167152;660.1780782925289;662.0532638327238;680.7106979533678;681.4139839737821;687.7352219395568;476.68300580114527;560.6271829233596;590.8995470769979;645.9935400646027;683.1187767779509;9244.068620883;9555.140037396528;9740.805183896282;9771.853422198672;9852.50737463124;591.810620601412;632.253940350391;645.6803882078401;680.608650026227;687.151368060445;4459.977700111479;4553.526254699877;4669.486356500782;4683.718976861399;4699.645412996862;153657.46342536432;159835;163332;164214;164640;137526.31236843753;138473;140635.29682351524;141981;145857.54142458652;117698;120279.75494180797;122683;123410.19077710732;124312;8807.984743789882;9027.548622568976;9043.32175086858;9049.54752262371;9195.77010574741;64854.67572662106;64967;64983.675081624286;65123.67438162779;67188;98128.50935745276;102269;102408;102621;108539;9967.50162491858;12012.75974480523;12056.156069075081;12347.444365003417;12390;13147.671308217372;13172.40724167434;13448.991325650812;13450.327483625584;13716.245606491739;12115.091368147248;12524.812127818272;12910.483580656668;12943.482260709843;13064.281464519543;12111.878881211427;12446.751064978469;12518.937405312916;12647.810282845581;12742.869930626499;12207.3678547946;12453.501859925502;12471.875281247072;12509.74980500403;12733.108682392514;8459.534725590152;10214.387136771817;10585.682429527127;10606.787864242518;10688.572457101629;9784.755381115245;10487.842682359618;10487.951204879451;10500.579976801147;10516.106130978953 05:35:08 INFO - PROCESS | 1647 | __end_tp_report 05:35:08 INFO - PROCESS | 1647 | __start_cc_report 05:35:08 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1280 05:35:08 INFO - PROCESS | 1647 | __end_cc_report 05:35:08 INFO - PROCESS | 1647 | __startTimestamp1471350908811__endTimestamp 05:35:08 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | ------- Summary: start ------- 05:35:08 INFO - PROCESS | 1647 | Number of tests: 6 05:35:08 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5779.96 Median:6033.73 stddev:755.64 (12.5%) stddev-sans-first:734.48 05:35:08 INFO - PROCESS | 1647 | Values: 3397.7 3398.2 3419.4 3442.4 3475.7 5608.6 5708.5 5768.2 5816.8 5844.8 5777.0 5787.5 5809.7 5810.7 5818.4 5236.0 5264.3 5282.6 5291.2 5361.8 5206.2 5290.9 5312.9 5326.0 5359.2 5294.8 5303.3 5314.5 5325.0 5377.1 543.5 5284.0 5369.6 5374.9 5379.3 5303.8 5317.5 5324.0 5329.7 5331.4 5702.6 5819.6 5856.3 5886.6 5891.0 6052.6 6106.9 6203.9 6207.4 6212.5 6097.0 6169.5 6178.1 6189.8 6193.5 5748.9 5751.5 5756.7 5763.9 5768.8 5387.3 6335.6 6384.4 6388.9 6397.1 6153.4 6199.4 6211.4 6220.9 6221.0 6140.0 6178.4 6303.8 6333.3 6374.1 6167.1 6202.3 6246.8 6316.9 6316.9 6285.2 6287.2 6295.4 6299.0 6319.0 4874.9 4971.8 4986.3 4991.8 5013.4 4422.5 4431.8 4482.5 4489.3 4540.9 5805.4 5809.2 5818.8 5828.1 5872.4 6323.0 6336.0 6342.8 6343.5 6381.6 5631.8 5741.2 5774.6 5803.7 5881.8 5467.3 5498.8 5500.0 5502.6 5504.5 6412.1 6465.5 6483.9 6484.5 6493.2 6164.7 6261.6 6306.8 6339.4 6344.2 6450.7 6466.5 6478.8 6479.5 6482.5 6276.5 6290.2 6291.2 6298.1 6308.5 6194.3 6243.0 6282.3 6288.2 6356.4 6164.8 6180.6 6191.5 6199.2 6230.1 5277.3 6118.8 6147.6 6174.6 6175.5 5843.2 5923.3 5984.6 5997.2 6093.8 6165.7 6173.4 6177.2 6199.7 6212.3 6015.7 6033.7 6047.0 6048.8 6093.3 05:35:08 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:68960.39 Median:20753.59 stddev:147973.64 (713.0%) stddev-sans-first:148299.39 05:35:08 INFO - PROCESS | 1647 | Values: 469.7 503.3 514.7 533.3 533.8 29839.9 32188.2 32321.7 39437.6 41008.0 41774.8 42276.6 42427.6 42507.6 42521.1 9502.0 9654.8 9661.1 9664.1 9665.3 8401.2 8755.7 8949.4 9701.6 11732.1 11728.1 12011.4 12022.0 12053.9 12062.7 11826.0 11928.2 11940.9 11950.2 11952.5 8698.7 11434.3 11506.4 11709.2 11726.6 39243.4 39671.0 39715.4 39819.4 39913.2 3051.0 3456.9 3483.3 3637.9 3768.6 31190.8 32285.7 32570.2 32967.8 33556.5 3224.9 3286.9 3324.9 3401.3 3405.1 445426.0 459175.0 459279.0 459628.4 460986.0 63481.0 65362.0 65424.7 65492.7 65650.7 68215.0 68608.0 68620.7 68698.0 68720.3 15953.5 16158.9 16160.3 16169.7 16199.7 12255.2 12342.7 12369.2 12378.6 12399.0 17098.5 17415.3 17852.2 20391.3 20726.3 8340.5 8370.2 8370.6 8410.4 8451.8 899.5 914.5 970.2 1033.6 1095.7 26054.7 26377.7 27631.0 30630.8 30673.4 939.8 991.4 1024.7 1075.9 1086.2 14603.1 15323.9 15350.8 15428.5 15722.8 638881.0 644851.0 645519.0 648033.0 650050.0 48261.5 53622.7 54947.2 55506.2 55821.4 1217.6 1329.3 1344.8 1360.8 1378.4 30197.4 30877.0 30941.2 31559.5 31725.8 47152.8 55620.7 57214.0 57233.0 59544.0 540777.0 543011.0 543416.0 546728.0 548512.0 26772.3 27178.0 27555.6 27860.9 35091.5 46088.1 46432.3 46708.3 46974.0 47056.8 37738.6 38168.2 38581.4 39203.8 39598.6 37069.6 37653.2 38046.2 38333.6 38984.4 37375.4 37743.8 38130.6 38183.6 38200.8 31616.2 33233.0 33720.3 33868.5 34186.5 24870.5 25078.5 25167.0 25558.1 25728.8 05:35:08 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:35054.27 Median:26813.93 stddev:101175.21 (377.3%) stddev-sans-first:101425.44 05:35:08 INFO - PROCESS | 1647 | Values: 332.8 357.5 376.1 381.3 406.9 14858.9 15575.4 20225.2 20822.9 21147.5 19719.2 19942.6 20029.2 20271.2 20494.9 5879.3 6211.2 6222.7 6231.1 6244.6 4152.2 4254.7 6104.2 6201.4 6886.4 6891.9 6905.8 6916.7 6926.8 6933.5 6691.9 6755.7 6802.3 6869.4 6869.7 5661.0 5870.2 5913.7 5926.6 5933.6 26798.3 26803.0 26824.9 26828.7 27091.2 2235.3 2374.5 2383.1 2451.8 2513.7 15538.5 15686.7 15819.0 15970.8 16125.6 1881.9 1885.3 1904.2 1910.4 1929.8 109685.9 109735.0 112997.0 113006.3 113799.0 10435.5 10466.3 10492.2 10678.2 10816.1 11929.9 12285.0 12572.7 12984.9 13009.7 8137.0 8260.7 8286.3 8366.5 8479.2 6793.1 8319.0 8341.5 8508.0 8580.0 6419.4 6533.6 6551.9 6557.9 6587.7 1504.6 1761.2 1837.1 1838.2 1839.2 847.9 872.4 878.7 927.6 981.8 19535.0 22821.2 22844.8 22938.9 23035.0 932.9 949.6 953.8 960.8 966.5 11206.8 11238.7 11613.7 12019.5 12032.6 598430.0 605576.0 607557.0 614747.0 619118.0 74299.0 74466.6 121841.4 132809.0 142668.3 940.8 973.2 1005.0 1021.4 1022.7 14382.7 18880.6 19328.4 19454.5 19580.9 56603.0 56675.0 57104.1 57611.0 60427.8 80785.2 81441.4 83610.2 84252.9 86328.6 7149.1 7311.6 7366.9 7544.3 7971.8 11309.3 12915.9 13069.3 13384.0 13589.5 9048.5 10457.1 10592.0 10643.6 10740.0 11074.8 11236.3 11474.5 11611.8 11684.5 10695.4 10940.0 11034.9 11095.3 11120.6 6999.4 7299.7 7326.3 7362.0 7530.4 8988.8 10643.0 10794.4 10848.9 10865.0 05:35:08 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5591.63 Median:4824.20 stddev:3139.17 (65.1%) stddev-sans-first:3130.78 05:35:08 INFO - PROCESS | 1647 | Values: 1220.9 1504.9 1540.7 1692.7 1852.5 7611.8 8164.6 8179.8 8473.3 8742.7 8597.7 8635.7 8691.2 8701.3 8726.7 2051.7 2368.3 2403.0 2405.0 2405.5 2343.9 2378.0 2388.3 2390.2 2401.4 2353.3 2373.9 2381.4 2390.7 2405.7 2329.3 2364.5 2365.9 2368.0 2374.1 2323.5 2349.0 2352.9 2355.3 2363.9 8670.8 8699.0 8759.6 8777.4 8785.6 5183.6 5230.8 5340.7 5351.4 5440.9 3521.3 3648.6 3729.6 3732.2 3752.7 914.4 1102.0 1109.4 1135.7 1136.0 11535.8 11618.7 11720.2 11727.9 11744.4 4366.9 4502.1 4556.5 4615.1 4626.4 9050.9 9051.3 9053.8 9055.4 9078.6 5218.2 5222.3 5227.5 5231.1 5236.6 4003.7 4453.6 4547.0 4883.4 4887.7 3631.4 3684.8 3762.0 3782.3 3794.5 1151.7 1157.4 1176.1 1187.1 1188.3 815.6 882.2 893.4 933.9 941.1 5610.4 5703.9 6012.4 6029.8 6083.8 448.3 463.7 464.6 982.7 1001.2 3839.2 3907.5 3958.5 4049.7 4061.0 9106.9 10591.4 10911.7 10925.0 10932.5 9283.2 9957.3 10264.6 10272.4 10679.1 6641.4 7950.0 8160.8 8190.3 8197.0 4825.4 5793.9 5919.5 6038.4 6250.8 8668.5 9771.6 10107.1 10151.9 10232.5 10205.2 10260.6 10357.5 10396.5 10406.1 6120.4 7251.4 7596.7 7731.0 7808.0 8134.3 8340.9 8427.9 8441.8 8465.4 6232.7 7368.3 7468.4 7550.4 7578.5 6351.9 6988.1 7292.3 7332.4 7365.2 6691.2 6857.5 6960.1 6981.4 6984.4 4747.1 4819.1 4838.3 4858.7 4966.4 4736.6 4760.7 4823.0 4928.1 5086.6 05:35:08 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4447.80 Median:5053.63 stddev:1365.02 (27.0%) stddev-sans-first:1332.83 05:35:08 INFO - PROCESS | 1647 | Values: 297.5 300.7 307.9 314.4 316.6 4390.0 4399.4 5099.7 5356.6 5374.3 4916.6 4981.9 5050.5 5223.2 5321.5 3427.6 3876.4 4065.7 4082.8 4093.7 3435.7 3590.7 3964.2 4025.2 4028.4 3923.9 4056.3 4061.6 4065.5 4066.0 3529.9 3742.5 4105.6 4122.3 4127.6 3043.5 3457.9 3525.9 3580.8 3602.3 4939.2 5099.6 5166.5 5182.9 5202.6 4302.9 4419.9 4503.8 4663.1 4704.7 4227.8 4586.2 5556.3 5571.3 5653.2 3583.1 3853.4 3906.6 3919.4 3924.1 5550.7 5585.2 5676.4 5687.3 5832.3 3439.6 3504.0 3522.1 3875.2 3910.3 3475.3 3964.7 3971.1 4012.5 4049.8 3562.4 3675.2 4471.6 4533.9 4614.7 4454.8 5442.9 5473.7 5495.3 5495.3 1153.6 1198.3 1321.9 1346.7 1378.7 836.7 837.5 925.3 941.2 949.8 4303.8 5137.5 5192.3 5206.7 5213.0 5320.5 5596.0 5694.7 5729.8 5761.5 4825.9 5074.8 5126.4 5143.9 5180.9 2361.8 2933.2 2946.1 2974.6 2980.9 5103.6 5609.4 5655.6 5856.2 5876.9 4520.4 5388.6 5702.5 5732.6 5785.8 4740.8 5723.8 5733.8 5894.9 5948.3 5157.0 5258.0 5356.4 5425.7 5635.4 5084.4 5171.1 5174.4 5446.4 5455.5 4853.9 5049.9 5379.5 5586.2 5876.7 3616.5 3656.9 3870.4 3914.4 3949.3 4766.8 5444.1 5789.3 5795.7 5802.1 4237.4 4920.8 5536.2 5697.2 5708.8 4624.8 4748.9 5330.4 5585.6 5676.7 5260.6 5272.3 5505.1 5515.0 5539.2 4328.5 5056.7 5538.2 5748.5 5766.7 5598.1 5623.2 5625.8 5631.4 5648.5 05:35:08 INFO - PROCESS | 1647 | 05:35:08 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:25765.04 Median:3741.64 stddev:42280.24 (1130.0%) stddev-sans-first:42357.00 05:35:08 INFO - PROCESS | 1647 | Values: 710.8 727.1 752.5 810.6 826.4 14980.8 16141.1 16199.5 16200.4 16224.5 14675.1 14847.0 14854.1 14854.9 14855.9 660.0 679.7 815.9 820.3 843.9 826.2 845.0 845.8 846.4 847.0 903.9 904.1 905.1 905.4 905.9 706.0 731.2 735.9 900.5 901.9 538.3 538.9 648.8 672.2 678.1 14989.0 15007.9 15024.2 15030.1 15031.2 13610.3 13841.2 13982.9 14032.2 14146.2 12453.6 12476.9 12501.7 12954.4 13054.6 4524.7 4575.9 4583.0 4774.4 4784.0 93138.1 93767.6 93998.0 100376.0 103811.0 10879.1 10892.2 10898.7 10955.3 11306.3 21385.5 21386.8 21413.0 21434.9 21454.9 7525.0 7790.7 7807.8 7857.8 7976.4 4467.0 4504.5 4586.4 4709.3 4733.9 3200.6 3579.6 3741.0 3742.3 3759.5 660.2 662.1 680.7 681.4 687.7 476.7 560.6 590.9 646.0 683.1 9244.1 9555.1 9740.8 9771.9 9852.5 591.8 632.3 645.7 680.6 687.2 4460.0 4553.5 4669.5 4683.7 4699.6 153657.5 159835.0 163332.0 164214.0 164640.0 137526.3 138473.0 140635.3 141981.0 145857.5 117698.0 120279.8 122683.0 123410.2 124312.0 8808.0 9027.5 9043.3 9049.5 9195.8 64854.7 64967.0 64983.7 65123.7 67188.0 98128.5 102269.0 102408.0 102621.0 108539.0 9967.5 12012.8 12056.2 12347.4 12390.0 13147.7 13172.4 13449.0 13450.3 13716.2 12115.1 12524.8 12910.5 12943.5 13064.3 12111.9 12446.8 12518.9 12647.8 12742.9 12207.4 12453.5 12471.9 12509.7 12733.1 8459.5 10214.4 10585.7 10606.8 10688.6 9784.8 10487.8 10488.0 10500.6 10516.1 05:35:08 INFO - PROCESS | 1647 | -------- Summary: end -------- 05:35:08 INFO - PROCESS | 1647 | 05:35:09 INFO - TEST-INFO | 1647: exit 0 05:35:09 INFO - TEST-OK | dromaeo_css | took 1117552ms 05:35:09 INFO - TEST-START | kraken 05:35:09 INFO - operating with platform_type : mac_ 05:35:09 INFO - Initialising browser for kraken test... 05:35:09 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmps_rmhr/profile http://localhost:49267/getInfo.html) 05:35:11 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:35:11 INFO - PROCESS | 1657 | colorDepth:24 05:35:11 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:35:11 INFO - PROCESS | 1657 | __metrics 05:35:11 INFO - PROCESS | 1657 | 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:35:11 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:35:12 INFO - TEST-INFO | 1657: exit 0 05:35:12 INFO - Browser initialized. 05:35:12 INFO - Running cycle 1/1 for kraken test... 05:35:12 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmps_rmhr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:24 INFO - PROCESS | 1658 | RSS: Main: 228421632 05:35:24 INFO - PROCESS | 1658 | 05:35:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:27 INFO - PROCESS | 1658 | RSS: Main: 285007872 05:35:27 INFO - PROCESS | 1658 | 05:35:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 05:35:31 INFO - PROCESS | 1658 | RSS: Main: 293101568 05:35:31 INFO - PROCESS | 1658 | 05:35:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 05:35:35 INFO - PROCESS | 1658 | RSS: Main: 388616192 05:35:35 INFO - PROCESS | 1658 | 05:35:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 05:35:38 INFO - PROCESS | 1658 | RSS: Main: 291762176 05:35:38 INFO - PROCESS | 1658 | 05:35:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:40 INFO - PROCESS | 1658 | RSS: Main: 294719488 05:35:40 INFO - PROCESS | 1658 | 05:35:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:44 INFO - PROCESS | 1658 | RSS: Main: 331096064 05:35:44 INFO - PROCESS | 1658 | 05:35:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:47 INFO - PROCESS | 1658 | RSS: Main: 333328384 05:35:47 INFO - PROCESS | 1658 | 05:35:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 05:35:51 INFO - PROCESS | 1658 | RSS: Main: 332808192 05:35:51 INFO - PROCESS | 1658 | 05:35:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:53 INFO - PROCESS | 1658 | RSS: Main: 302235648 05:35:53 INFO - PROCESS | 1658 | 05:35:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:56 INFO - PROCESS | 1658 | RSS: Main: 309153792 05:35:56 INFO - PROCESS | 1658 | 05:35:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:59 INFO - PROCESS | 1658 | RSS: Main: 304361472 05:35:59 INFO - PROCESS | 1658 | 05:36:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:02 INFO - PROCESS | 1658 | RSS: Main: 314081280 05:36:02 INFO - PROCESS | 1658 | 05:36:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:06 INFO - PROCESS | 1658 | RSS: Main: 315383808 05:36:06 INFO - PROCESS | 1658 | 05:36:07 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 05:36:08 INFO - PROCESS | 1658 | RSS: Main: 359120896 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | __start_tp_report 05:36:08 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 05:36:08 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 05:36:08 INFO - PROCESS | 1658 | |i|pagename|runs| 05:36:08 INFO - PROCESS | 1658 | |0;ai-astar;102;111;112;113;107;112;111;113;113;112 05:36:08 INFO - PROCESS | 1658 | |1;audio-beat-detection;142;111;106;166;107;108;127;101;132;116 05:36:08 INFO - PROCESS | 1658 | |2;audio-dft;183;197;266;192;184;184;181;185;183;183 05:36:08 INFO - PROCESS | 1658 | |3;audio-fft;79;57;63;88;60;69;55;51;146;81 05:36:08 INFO - PROCESS | 1658 | |4;audio-oscillator;81;87;98;72;70;69;95;70;68;102 05:36:08 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;87;85;87;84;87;84;87;84;88;84 05:36:08 INFO - PROCESS | 1658 | |6;imaging-darkroom;135;150;94;94;94;94;95;94;93;93 05:36:08 INFO - PROCESS | 1658 | |7;imaging-desaturate;85;85;84;91;132;85;96;133;132;85 05:36:08 INFO - PROCESS | 1658 | |8;json-parse-financial;51;51;53;53;53;56;53;52;53;52 05:36:08 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;65;70;68;75;79;72;70;69;68;69 05:36:08 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;85;95;105;107;106;86;83;83;89;81 05:36:08 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;152;133;149;156;127;152;153;144;164;152 05:36:08 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;167;168;166;168;168;166;166;167;167;168 05:36:08 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;65;68;69;67;66;68;65;67;65;65 05:36:08 INFO - PROCESS | 1658 | __end_tp_report 05:36:08 INFO - PROCESS | 1658 | __start_cc_report 05:36:08 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2084 05:36:08 INFO - PROCESS | 1658 | __end_cc_report 05:36:08 INFO - PROCESS | 1658 | __startTimestamp1471350968249__endTimestamp 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | ------- Summary: start ------- 05:36:08 INFO - PROCESS | 1658 | Number of tests: 14 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:1.88 05:36:08 INFO - PROCESS | 1658 | Values: 102.0 111.0 112.0 113.0 107.0 112.0 111.0 113.0 113.0 112.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:121.50 stddev:20.37 (16.8%) stddev-sans-first:20.22 05:36:08 INFO - PROCESS | 1658 | Values: 142.0 111.0 106.0 166.0 107.0 108.0 127.0 101.0 132.0 116.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:193.80 Median:184.50 stddev:25.84 (14.0%) stddev-sans-first:27.11 05:36:08 INFO - PROCESS | 1658 | Values: 183.0 197.0 266.0 192.0 184.0 184.0 181.0 185.0 183.0 183.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:74.90 Median:66.00 stddev:27.82 (42.2%) stddev-sans-first:29.47 05:36:08 INFO - PROCESS | 1658 | Values: 79.0 57.0 63.0 88.0 60.0 69.0 55.0 51.0 146.0 81.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:76.50 stddev:13.32 (17.4%) stddev-sans-first:14.13 05:36:08 INFO - PROCESS | 1658 | Values: 81.0 87.0 98.0 72.0 70.0 69.0 95.0 70.0 68.0 102.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:1.64 (1.9%) stddev-sans-first:1.67 05:36:08 INFO - PROCESS | 1658 | Values: 87.0 85.0 87.0 84.0 87.0 84.0 87.0 84.0 88.0 84.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:103.60 Median:94.00 stddev:20.81 (22.1%) stddev-sans-first:18.72 05:36:08 INFO - PROCESS | 1658 | Values: 135.0 150.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 93.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:100.80 Median:85.00 stddev:22.07 (26.0%) stddev-sans-first:22.66 05:36:08 INFO - PROCESS | 1658 | Values: 85.0 85.0 84.0 91.0 132.0 85.0 96.0 133.0 132.0 85.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.42 (2.7%) stddev-sans-first:1.36 05:36:08 INFO - PROCESS | 1658 | Values: 51.0 51.0 53.0 53.0 53.0 56.0 53.0 52.0 53.0 52.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.00 stddev:3.98 (5.7%) stddev-sans-first:3.69 05:36:08 INFO - PROCESS | 1658 | Values: 65.0 70.0 68.0 75.0 79.0 72.0 70.0 69.0 68.0 69.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:84.00 stddev:10.41 (12.4%) stddev-sans-first:10.73 05:36:08 INFO - PROCESS | 1658 | Values: 85.0 95.0 105.0 107.0 106.0 86.0 83.0 83.0 89.0 81.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:152.00 stddev:10.93 (7.2%) stddev-sans-first:11.51 05:36:08 INFO - PROCESS | 1658 | Values: 152.0 133.0 149.0 156.0 127.0 152.0 153.0 144.0 164.0 152.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 05:36:08 INFO - PROCESS | 1658 | Values: 167.0 168.0 166.0 168.0 168.0 166.0 166.0 167.0 167.0 168.0 05:36:08 INFO - PROCESS | 1658 | 05:36:08 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.51 (2.3%) stddev-sans-first:1.50 05:36:08 INFO - PROCESS | 1658 | Values: 65.0 68.0 69.0 67.0 66.0 68.0 65.0 67.0 65.0 65.0 05:36:08 INFO - PROCESS | 1658 | -------- Summary: end -------- 05:36:08 INFO - PROCESS | 1658 | 05:36:09 INFO - TEST-INFO | 1658: exit 0 05:36:09 INFO - TEST-OK | kraken | took 59623ms 05:36:09 INFO - SUITE-END | took 1177s 05:36:09 INFO - Completed test suite (00:19:37) 05:36:09 INFO - javascript benchmark 05:36:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3397.694207521321, 3398.2184097657537, 3419.4016047191744, 3442.363162814878, 3475.7393195510326, 5608.6073974821775, 5708.514776244019, 5768.163616275638, 5816.825495235139, 5844.79543215987, 5777.0, 5787.50806181475, 5809.651420914748, 5810.738516766745, 5818.359980402152, 5236.031334203175, 5264.2893209416625, 5282.577393808505, 5291.206319052135, 5361.839144825662, 5206.219067139921, 5290.947090529103, 5312.893742125175, 5326.0, 5359.196120581905, 5294.7617357219015, 5303.337082864642, 5314.521693047625, 5324.973375133119, 5377.059014672436, 543.4924421747157, 5283.996040752283, 5369.62412631116, 5374.946250537484, 5379.300690910176, 5303.840884773463, 5317.494837990384, 5324.0, 5329.653572517774, 5331.440198779111, 5702.600817942745, 5819.621724587888, 5856.267966504187, 5886.587938844283, 5891.0, 6052.636841789463, 6106.938930610681, 6203.937960620427, 6207.379262073801, 6212.502999760009, 6096.987993961982, 6169.475594574422, 6178.104174894615, 6189.81430557084, 6193.5045196384635, 5748.885022299531, 5751.511121554715, 5756.683382413966, 5763.942360576382, 5768.7692492300675, 5387.326584176978, 6335.556511044275, 6384.3934826191435, 6388.872222555523, 6397.072424498421, 6153.4154255345675, 6199.380061993765, 6211.378862113753, 6220.906686399708, 6220.968895155495, 6140.0, 6178.443940045418, 6303.779367722108, 6333.334999825044, 6374.107624932513, 6167.105769663373, 6202.317745048041, 6246.843828904223, 6316.873662526816, 6316.9368306317265, 6285.214348206474, 6287.245530536365, 6295.433410992941, 6299.0, 6319.020551814476, 4874.8537543873745, 4971.825986090469, 4986.276989836526, 4991.800327986913, 5013.39839219296, 4422.469303683579, 4431.8448854289945, 4482.484514280834, 4489.281714925596, 4540.931886021713, 5805.419458054161, 5809.215755872903, 5818.796342128006, 5828.067509198508, 5872.442117998783, 6323.0, 6335.968320158369, 6342.778002769881, 6343.524235682342, 6381.585196962275, 5631.802886898939, 5741.220221731277, 5774.566907481955, 5803.680797556175, 5881.764729410861, 5467.261919640798, 5498.80754173602, 5500.037493438632, 5502.642328248651, 5504.4770746778995, 6412.102305677302, 6465.450436712932, 6483.902741458882, 6484.481241500763, 6493.188351456068, 6164.660943647963, 6261.5616906816085, 6306.810795676137, 6339.429451349216, 6344.175257216532, 6450.7097180627925, 6466.482681385572, 6478.773242936474, 6479.546431749733, 6482.546221764431, 6276.466500347339, 6290.150829637941, 6291.150694656163, 6298.0552917062805, 6308.463780578702, 6194.349593292639, 6243.0, 6282.340354262737, 6288.213973253343, 6356.364363563606, 6164.815055548341, 6180.598261113013, 6191.473724733448, 6199.16311297969, 6230.096635987847, 5277.261183434399, 6118.816435506942, 6147.569670123048, 6174.598651087665, 6175.505959523138, 5843.240378750906, 5923.289205295392, 5984.58107932458, 5997.190379298739, 6093.817185484442, 6165.72254248551, 6173.41352571505, 6177.166082578794, 6199.721012554356, 6212.347703491249, 6015.699215039318, 6033.728482218398, 6046.97201475759, 6048.759081865031, 6093.329733729375], "value": 5734.350501408194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.68061718031726, 503.3180041044385, 514.6757542748069, 533.2774091106551, 533.8158335374294, 29839.850800745993, 32188.195295117635, 32321.67678323216, 39437.60562394375, 41007.97480063, 41774.7911260444, 42276.57723422765, 42427.57572424275, 42507.57492425075, 42521.149577008444, 9502.00457903841, 9654.75863103421, 9661.130498255156, 9664.130228279453, 9665.323427360088, 8401.159884011611, 8755.693550725726, 8949.418287811304, 9701.563429645683, 11732.120090993167, 11728.12039097067, 12011.399430028463, 12022.0, 12053.939730301336, 12062.69843253917, 11825.994790442779, 11928.224665396721, 11940.940295298555, 11950.163488555805, 11952.52189912411, 8698.695545655872, 11434.256773309708, 11506.424678766029, 11709.180357374988, 11726.589569365031, 39243.41134882979, 39671.0, 39715.40426893599, 39819.40270895939, 39913.201735965406, 3050.9542356864663, 3456.861725530976, 3483.3207524532727, 3637.94543081854, 3768.566614839301, 31190.844045779624, 32285.708571657105, 32570.185745356317, 32967.83516082428, 33556.49665255023, 3224.91937701557, 3286.9342613147605, 3324.8503817328037, 3401.3197360527747, 3405.080628230364, 445426.0, 459174.9999999967, 459279.0, 459628.4037159619, 460986.0, 63481.0, 65362.0, 65424.672876636265, 65492.67253663796, 65650.67174664192, 68215.0, 68608.0, 68620.6568967152, 68698.0, 68720.28199295058, 15953.521394357957, 16158.949668271525, 16160.27278772458, 16169.676606467805, 16199.67600648004, 12255.203411778206, 12342.691432714253, 12369.196002259825, 12378.566750163702, 12399.0, 17098.502145716746, 17415.3033878646, 17852.19665115047, 20391.286304979254, 20726.274580389614, 8340.499570025819, 8370.204830541088, 8370.581470926429, 8410.392778238765, 8451.83096338082, 899.4783025844994, 914.492456686532, 970.2286682087757, 1033.6330602636106, 1095.7479779650566, 26054.73945260523, 26377.736222637912, 27631.0, 30630.846845766075, 30673.386532269677, 939.7923668086613, 991.3704797453524, 1024.6977141743055, 1075.887031861659, 1086.223350304536, 14603.123812571279, 15323.923380383027, 15350.771938244914, 15428.537143885702, 15722.764158537631, 638881.0, 644851.0, 645519.0, 648033.0, 650050.0, 48261.5173848257, 53622.73188634032, 54947.175792363145, 55506.16740748892, 55821.441785582436, 1217.5555922088374, 1329.2888304757103, 1344.8386193656825, 1360.8298962629672, 1378.4417310989065, 30197.396052079275, 30877.0, 30941.226469338446, 31559.526607101372, 31725.841370792998, 47152.7642361786, 55620.721896390256, 57214.0, 57233.0, 59544.0, 540777.0, 543011.0, 543416.0, 546728.0, 548512.0, 26772.330691732863, 27178.0, 27555.586666199622, 27860.860695696392, 35091.47362789611, 46088.14112125488, 46432.30351544797, 46708.299375510076, 46974.0, 47056.76471617757, 37738.622613773514, 38168.2366352677, 38581.4212786814, 39203.803980979916, 39598.60401395949, 37069.62930370662, 37653.246935061696, 38046.23907521779, 38333.616663834124, 38984.415233770946, 37375.43936840895, 37743.81128094342, 38130.61869381271, 38183.618163818006, 38200.808995954845, 31616.209594760316, 33233.0, 33720.32559348848, 33868.49197262093, 34186.48720269248, 24870.50258994846, 25078.498430030933, 25167.0, 25558.110139042805, 25728.842202100575], "value": 20326.060562879386, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.83690991414204, 357.5048557747519, 376.1499012232356, 381.2869933224869, 406.93895915612654, 14858.851411485895, 15575.376984920604, 20225.190992360323, 20822.89588552057, 21147.47131321718, 19719.211231550722, 19942.60114797703, 20029.1988320467, 20271.189152433923, 20494.897525512388, 5879.294484661847, 6211.192544969148, 6222.657753823538, 6231.096491008823, 6244.594101383395, 4152.231837110129, 4254.7021708480415, 6104.206453161105, 6201.379862013785, 6886.380225779679, 6891.862162756742, 6905.792826215222, 6916.65416729164, 6926.826829329257, 6933.549319294255, 6691.933080669229, 6755.729770809162, 6802.251752307242, 6869.381755642016, 6869.725210991604, 5660.971695141539, 5870.178175055496, 5913.704314784287, 5926.585139040269, 5933.614315069507, 26798.33004174892, 26803.0, 26824.865875670694, 26828.73171268282, 27091.187264381904, 2235.2835517058993, 2374.4894847607675, 2383.130157492503, 2451.82837201396, 2513.6857892763405, 15538.456154034668, 15686.68626627461, 15819.0, 15970.76043859343, 16125.596860078474, 1881.858860585448, 1885.3212843376512, 1904.2287873411153, 1910.426871938413, 1929.7684277886744, 109685.87430986048, 109735.0, 112997.0, 113006.30490542648, 113799.0, 10435.530401131968, 10466.267361284637, 10492.21308401873, 10678.199135064746, 10816.08063314627, 11929.880701192877, 12285.0, 12572.685682858002, 12984.870151298555, 13009.739805203842, 8136.959315203504, 8260.678291473336, 8286.295664868554, 8366.53984030872, 8479.236868681848, 6793.11517924502, 8319.0, 8341.541215233221, 8508.0, 8579.957100214458, 6419.422251997343, 6533.640649764214, 6551.901721474182, 6557.9344206557325, 6587.73649054042, 1504.5787179589731, 1761.1898526677614, 1837.0998210876573, 1838.172822229975, 1839.2275244397117, 847.876563553282, 872.4198408058696, 878.7232021913077, 927.6474939523073, 981.7692842182081, 19535.0232488375, 22821.20125795589, 22844.771552284263, 22938.885305573367, 23035.0, 932.8693982842408, 949.6059135458845, 953.752024473628, 960.8126415348939, 966.5360626898987, 11206.831897521544, 11238.719032024264, 11613.709657258636, 12019.459124339426, 12032.578859739868, 598430.0, 605576.0, 607557.0, 614747.0, 619118.0, 74299.0, 74466.62766686131, 121841.39079304547, 132809.0, 142668.28665856604, 940.7507010642186, 973.1582181413027, 1004.9999999999853, 1021.4177918586483, 1022.6574097677212, 14382.712345752818, 18880.62238755245, 19328.4201473956, 19454.513637159183, 19580.902095489433, 56603.0, 56675.0, 57104.1434378493, 57611.0, 60427.79144417175, 80785.19214807777, 81441.37117257503, 83610.16389836023, 84252.9448233108, 86328.56835715781, 7149.106361704787, 7311.634418278958, 7366.852662946604, 7544.283293087367, 7971.760847174594, 11309.264897781617, 12915.870841291842, 13069.346532673519, 13384.0, 13589.45642174302, 9048.547572621474, 10457.058864702214, 10592.0, 10643.574257029943, 10740.0, 11074.833877492005, 11236.269642473213, 11474.541018359172, 11611.776496621374, 11684.532618695497, 10695.358278503314, 10940.015398614163, 11034.944825275823, 11095.334279943228, 11120.555177793121, 6999.370056694922, 7299.708011679473, 7326.267373262631, 7362.0, 7530.418612091522, 8988.82014869842, 10643.042126208678, 10794.352338859693, 10848.945755271174, 10864.982582738197], "value": 9713.827301937445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1220.8950899436013, 1504.8871334649905, 1540.6687562174134, 1692.7291633338668, 1852.4813052345348, 7611.8097047573765, 8164.63259153338, 8179.836403271938, 8473.322134229262, 8742.694005709802, 8597.710343448485, 8635.654573817039, 8691.217790398863, 8701.303895688345, 8726.738197854058, 2051.7230173926555, 2368.348704106367, 2403.0387844862107, 2405.0379848060743, 2405.542946840095, 2343.906243750248, 2377.988110059447, 2388.283514945518, 2390.2351247600773, 2401.3516350585332, 2353.2704861492907, 2373.8694371809543, 2381.428457170275, 2390.7011623547055, 2405.6632071510003, 2329.301209637119, 2364.5152743687504, 2365.929022129339, 2368.029108065702, 2374.1334412939327, 2323.5004474038165, 2349.0, 2352.8588284702973, 2355.281639100074, 2363.9172628957904, 8670.826583468295, 8698.999615044288, 8759.605817738217, 8777.42946708462, 8785.604647790864, 5183.585313174937, 5230.843074707726, 5340.732963351817, 5351.411344752074, 5440.863978400532, 3521.2781379817075, 3648.5804132524836, 3729.5524537055726, 3732.197577520846, 3752.699784017272, 914.4239129348468, 1102.0247081332998, 1109.351029647657, 1135.727425417902, 1136.0457215938652, 11535.826962595567, 11618.709532261677, 11720.179587428884, 11727.882721172764, 11744.354060526668, 4366.934495982563, 4502.144592527409, 4556.4939283394, 4615.123126605934, 4626.352310676508, 9050.909490905138, 9051.321150913707, 9053.77365565853, 9055.411398259092, 9078.636854525745, 5218.243354713545, 5222.321098257202, 5227.477252274742, 5231.084560202025, 5236.554892834151, 4003.7197396181987, 4453.621442177451, 4546.954530454719, 4883.438404583448, 4887.731174785421, 3631.4008188648577, 3684.797336146484, 3762.0, 3782.3380908340932, 3794.5067141271456, 1151.6545036489188, 1157.3923690062784, 1176.1237877780936, 1187.0681515010674, 1188.257339163023, 815.6003558256411, 882.1927935938544, 893.4371346051946, 933.8513628237171, 941.143559360992, 5610.354809196913, 5703.914441283384, 6012.368701286389, 6029.758809647653, 6083.7870674526175, 448.2558952139433, 463.7426228443246, 464.5772347164132, 982.6560703753772, 1001.1790331927749, 3839.232153569297, 3907.4529565860803, 3958.4656071430563, 4049.6760259179196, 4061.045654271244, 9106.86339704905, 10591.417472039111, 10911.727206819734, 10924.96212859777, 10932.453377331101, 9283.210927071139, 9957.253206009578, 10264.64073757415, 10272.383656980604, 10679.145668346513, 6641.435477984329, 7949.960250198712, 8160.83678326442, 8190.344772418312, 8197.016358037074, 4825.372701548917, 5793.913091303718, 5919.526437884872, 6038.396160384103, 6250.812475625738, 8668.479891206547, 9771.609135634495, 10107.090361867467, 10151.934046925262, 10232.539535720762, 10205.183585313305, 10260.589576417158, 10357.533910973874, 10396.48017599132, 10406.063454289151, 6120.418560236771, 7251.383632391306, 7596.658150383136, 7731.0, 7808.0, 8134.308583770209, 8340.87488687658, 8427.873581896154, 8441.83116337682, 8465.407421480437, 6232.719527621359, 7368.300011498899, 7468.439867009887, 7550.433717471102, 7578.507397019397, 6351.9047214290895, 6988.126484189476, 7292.270772922665, 7332.41340692754, 7365.153007404003, 6691.1636045494315, 6857.451403887577, 6960.129983752031, 6981.441484681111, 6984.371406573433, 4747.098051370229, 4819.060283244874, 4838.322634831196, 4858.684185527929, 4966.428860681068, 4736.621070314298, 4760.690555113906, 4823.03539292136, 4928.137575924271, 5086.61850361217], "value": 4470.311799561181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.4734719546403, 300.7218323051177, 307.873771753581, 314.4136186013083, 316.6184747379408, 4389.978050109749, 4399.406080179175, 5099.745012749357, 5356.607282106651, 5374.339701847586, 4916.582090522301, 4981.875453113674, 5050.520200580948, 5223.242629818674, 5321.547668448186, 3427.5775553145477, 3876.3604005339084, 4065.7357271777387, 4082.836686532535, 4093.7339072960312, 3435.7251419886475, 3590.676839084482, 3964.2071585682834, 4025.1949610077954, 4028.3756017817286, 3923.8822835314986, 4056.269871423143, 4061.6141466560775, 4065.5324637666604, 4065.9631793892518, 3529.894103176883, 3742.4573436851774, 4105.630493255621, 4122.340425531916, 4127.649149822269, 3043.5434684797237, 3457.896263112111, 3525.9294814103832, 3580.820958952042, 3602.279544091166, 4939.185034469308, 5099.566536844372, 5166.457521960216, 5182.948170518284, 5202.609804264695, 4302.924268932767, 4419.867403977886, 4503.774811259424, 4663.090697314025, 4704.670673052888, 4227.8097485613225, 4586.151561961048, 5556.333100069963, 5571.331440227199, 5653.236813030229, 3583.050491619723, 3853.364194907837, 3906.609339066099, 3919.392494163409, 3924.1170736584327, 5550.72246387683, 5585.2459917910965, 5676.375598684224, 5687.317521897357, 5832.270966129234, 3439.6216416194197, 3503.9663299326758, 3522.137076416243, 3875.2249550090096, 3910.335243008695, 3475.3223121491064, 3964.742291751027, 3971.126352202511, 4012.4583181270737, 4049.7772622506045, 3562.3943929532043, 3675.1807855111892, 4471.575200355961, 4533.863984080483, 4614.684814827758, 4454.7549884756645, 5442.91835622466, 5473.7263136843, 5495.313085864267, 5495.340559132929, 1153.5962413155328, 1198.3469009389903, 1321.9339033048502, 1346.7441186174594, 1378.6622277542067, 836.6696951846593, 837.5267973594899, 925.319889880937, 941.2328951904176, 949.7530642033121, 4303.827846886152, 5137.460566640524, 5192.299039629677, 5206.687598744087, 5212.9739351303, 5320.536852365631, 5596.048671725816, 5694.722111155488, 5729.799457018984, 5761.5102716269585, 4825.927611085836, 5074.82238121664, 5126.410462796752, 5143.871403214949, 5180.8963820723375, 2361.7874391304863, 2933.18414322253, 2946.071987323986, 2974.5686875402944, 2980.8658610362586, 5103.610894630615, 5609.354924183689, 5655.604107712503, 5856.238688970407, 5876.941230587639, 4520.412346394947, 5388.595855310789, 5702.54379649627, 5732.627379220421, 5785.768569257267, 4740.834070807505, 5723.771049157987, 5733.770649173986, 5894.934633990301, 5948.315943666447, 5157.045946499909, 5257.974694934451, 5356.3572371315695, 5425.674459532441, 5635.351934527418, 5084.381758157183, 5171.069207542528, 5174.404943431554, 5446.428125046813, 5455.472467709048, 4853.927191092066, 5049.863780649324, 5379.462053794589, 5586.16207568868, 5876.676782776988, 3616.4575313703153, 3656.8720094796554, 3870.4000879863665, 3914.4324073009825, 3949.30887094763, 4766.833160839354, 5444.1017232156255, 5789.336905023736, 5795.681237531976, 5802.071668533014, 4237.427947227085, 4920.827771027997, 5536.169574563686, 5697.23087383198, 5708.828735137952, 4624.838130665411, 4748.905021899612, 5330.413654497925, 5585.609007369445, 5676.7161641918565, 5260.605454590845, 5272.340957380327, 5505.091659876076, 5515.0, 5539.224508568723, 4328.502222244482, 5056.7471626419265, 5538.224648549126, 5748.48263656273, 5766.711664416846, 5598.076317407745, 5623.2408624835125, 5625.774969001194, 5631.380548139619, 5648.5481161507805], "value": 4018.7797007443432, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.808081817909, 727.0715612281185, 752.5108679358416, 810.6068556749979, 826.3554427546514, 14980.775288370669, 16141.11223882686, 16199.514014579552, 16200.432984845518, 16224.513264602067, 14675.119492830438, 14846.960712750111, 14854.108753474799, 14854.925725371386, 14855.851441485582, 659.9604023758566, 679.7043286170507, 815.922487363701, 820.2658620534618, 843.9198276163785, 826.1779529368287, 844.9746507604782, 845.7885528617845, 846.3779122345071, 846.9745907622781, 903.9096090390974, 904.0597778310549, 905.0903841639143, 905.384338649718, 905.8686490458913, 705.9964700176466, 731.1591669580025, 735.9300866417682, 900.4732231644496, 901.914318139779, 538.2545174932707, 538.9056915039891, 648.8345471904681, 672.2302963107214, 678.1387637700143, 14988.950773445864, 15007.924960375238, 15024.248787560688, 15030.098194108388, 15031.248437578186, 13610.319484025758, 13841.169529828141, 13982.860171398257, 14032.228227447486, 14146.221957792317, 12453.626391208278, 12476.875231247663, 12501.687457813536, 12954.352282385937, 13054.608361749162, 4524.705894116904, 4575.908481830378, 4583.03756211196, 4774.379330687023, 4784.043191361707, 93138.06861931362, 93767.59348609776, 93998.0, 100376.0, 103811.0, 10879.075278601249, 10892.237543372046, 10898.730380885703, 10955.287906286067, 11306.321620702784, 21385.465363366042, 21386.78613213879, 21413.0, 21434.89282553577, 21454.892725536272, 7524.962375188089, 7790.727324543614, 7807.804804879924, 7857.764267071997, 7976.361891048702, 4466.955330446719, 4504.504504504502, 4586.4266966629175, 4709.317149013443, 4733.9053218936115, 3200.567923330367, 3579.6420357964516, 3740.9812950935616, 3742.288965096623, 3759.4924685167152, 660.1780782925289, 662.0532638327238, 680.7106979533678, 681.4139839737821, 687.7352219395568, 476.68300580114527, 560.6271829233596, 590.8995470769979, 645.9935400646027, 683.1187767779509, 9244.068620883, 9555.140037396528, 9740.805183896282, 9771.853422198672, 9852.50737463124, 591.810620601412, 632.253940350391, 645.6803882078401, 680.608650026227, 687.151368060445, 4459.977700111479, 4553.526254699877, 4669.486356500782, 4683.718976861399, 4699.645412996862, 153657.46342536432, 159835.0, 163332.0, 164214.0, 164640.0, 137526.31236843753, 138473.0, 140635.29682351524, 141981.0, 145857.54142458652, 117698.0, 120279.75494180797, 122683.0, 123410.19077710732, 124312.0, 8807.984743789882, 9027.548622568976, 9043.32175086858, 9049.54752262371, 9195.77010574741, 64854.67572662106, 64967.0, 64983.675081624286, 65123.67438162779, 67188.0, 98128.50935745276, 102269.0, 102408.0, 102621.0, 108539.0, 9967.50162491858, 12012.75974480523, 12056.156069075081, 12347.444365003417, 12390.0, 13147.671308217372, 13172.40724167434, 13448.991325650812, 13450.327483625584, 13716.245606491739, 12115.091368147248, 12524.812127818272, 12910.483580656668, 12943.482260709843, 13064.281464519543, 12111.878881211427, 12446.751064978469, 12518.937405312916, 12647.810282845581, 12742.869930626499, 12207.3678547946, 12453.501859925502, 12471.875281247072, 12509.74980500403, 12733.108682392514, 8459.534725590152, 10214.387136771817, 10585.682429527127, 10606.787864242518, 10688.572457101629, 9784.755381115245, 10487.842682359618, 10487.951204879451, 10500.579976801147, 10516.106130978953], "value": 7779.943327458763, "unit": "score"}], "name": "dromaeo_css", "value": 7354.685998938178, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 113.0, 107.0, 112.0, 111.0, 113.0, 113.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 106.0, 166.0, 107.0, 108.0, 127.0, 101.0, 132.0, 116.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 197.0, 266.0, 192.0, 184.0, 184.0, 181.0, 185.0, 183.0, 183.0], "value": 193.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 57.0, 63.0, 88.0, 60.0, 69.0, 55.0, 51.0, 146.0, 81.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 98.0, 72.0, 70.0, 69.0, 95.0, 70.0, 68.0, 102.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 87.0, 84.0, 87.0, 84.0, 88.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 150.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 93.0], "value": 103.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 91.0, 132.0, 85.0, 96.0, 133.0, 132.0, 85.0], "value": 100.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 53.0, 53.0, 56.0, 53.0, 52.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 68.0, 75.0, 79.0, 72.0, 70.0, 69.0, 68.0, 69.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 95.0, 105.0, 107.0, 106.0, 86.0, 83.0, 83.0, 89.0, 81.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 149.0, 156.0, 127.0, 152.0, 153.0, 144.0, 164.0, 152.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 166.0, 168.0, 168.0, 166.0, 166.0, 167.0, 167.0, 168.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 69.0, 67.0, 66.0, 68.0, 65.0, 67.0, 65.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1469.2, "alertThreshold": 2.0}]} 05:36:09 INFO - Return code: 0 05:36:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:36:09 INFO - # TBPL SUCCESS # 05:36:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:09 INFO - 2016-08-16 05:36:09.576 screenresolution[1662:9685] starting screenresolution argv=screenresolution get 05:36:09 INFO - 2016-08-16 05:36:09.579 screenresolution[1662:9685] Display 0: 1600x1200x32@60 05:36:09 INFO - 2016-08-16 05:36:09.585 screenresolution[1663:9688] starting screenresolution argv=screenresolution list 05:36:09 INFO - Available Modes on Display 0 05:36:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:09 INFO - Intel Iris: 05:36:09 INFO - Chipset Model: Intel Iris 05:36:09 INFO - Type: GPU 05:36:09 INFO - Bus: Built-In 05:36:09 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:09 INFO - Vendor: Intel (0x8086) 05:36:09 INFO - Device ID: 0x0a2e 05:36:09 INFO - Revision ID: 0x0009 05:36:09 INFO - Displays: 05:36:09 INFO - Display: 05:36:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:09 INFO - Display Serial Number: 1600x1200 60 05:36:09 INFO - Main Display: Yes 05:36:09 INFO - Mirror: Off 05:36:09 INFO - Online: Yes 05:36:09 INFO - Rotation: Supported 05:36:09 INFO - Return code: 0 05:36:09 INFO - Running post-action listener: _resource_record_post_action 05:36:09 INFO - [mozharness: 2016-08-16 12:36:09.821634Z] Finished run-tests step (success) 05:36:09 INFO - Running post-run listener: _resource_record_post_run 05:36:09 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 37082112; Write bytes: 704544256; Read time: 256; Write time: 1966 05:36:09 INFO - TinderboxPrint: CPU usage
53.4% 05:36:09 INFO - TinderboxPrint: I/O read bytes / time
37,082,112 / 256 05:36:09 INFO - TinderboxPrint: I/O write bytes / time
704,544,256 / 1,966 05:36:09 INFO - TinderboxPrint: CPU idle
2,262.1 (46.6%) 05:36:09 INFO - TinderboxPrint: CPU system
965.7 (19.9%) 05:36:09 INFO - TinderboxPrint: CPU user
1,621.9 (33.4%) 05:36:09 INFO - TinderboxPrint: Swap in / out
441,942,016 / 0 05:36:09 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394289664; Write bytes: 389621248; Read time: 29484; Write time: 802 05:36:09 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 35173376; Write bytes: 294918144; Read time: 240; Write time: 1111 05:36:10 INFO - Running post-run listener: _upload_blobber_files 05:36:10 INFO - Blob upload gear active. 05:36:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:10 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:36:10 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:36:10 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:36:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:11 INFO - (blobuploader) - INFO - Done attempting. 05:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:36:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:12 INFO - (blobuploader) - INFO - Done attempting. 05:36:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:36:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:15 INFO - (blobuploader) - INFO - Done attempting. 05:36:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:15 INFO - Return code: 0 05:36:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05cb0183b0ec04d641dc9db5252013d0e9761da1bcc1d57860c5a767e2176d83cfe2af590d0c10687718ca11f63420f185e2027d51815146a9c2909912dbd95a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf9f782c6d4d2ab02bb7a9e627e9a4b45e1713a8bc97d3d645da78e2a6b25a760cc8de374370df172d9269d6ac35f347a83dcc9fcf478250a1c56122e6e00ab7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1705ccac63bae787c8b4e359cf2a8859e2128fc052171c57060492145c70e512cf741a1ba5c1d6833a5d80d8d49343443b1a1dfde940b3c10558c3122d7d7e33"} 05:36:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:15 INFO - Contents: 05:36:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05cb0183b0ec04d641dc9db5252013d0e9761da1bcc1d57860c5a767e2176d83cfe2af590d0c10687718ca11f63420f185e2027d51815146a9c2909912dbd95a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf9f782c6d4d2ab02bb7a9e627e9a4b45e1713a8bc97d3d645da78e2a6b25a760cc8de374370df172d9269d6ac35f347a83dcc9fcf478250a1c56122e6e00ab7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1705ccac63bae787c8b4e359cf2a8859e2128fc052171c57060492145c70e512cf741a1ba5c1d6833a5d80d8d49343443b1a1dfde940b3c10558c3122d7d7e33"} 05:36:15 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:15 INFO - Copying logs to upload dir... 05:36:15 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.386582 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-16 05:36:15.797105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:36:15.800936) ========= 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.OWj3pUk2yf/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.sqCiGamkOk/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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/05cb0183b0ec04d641dc9db5252013d0e9761da1bcc1d57860c5a767e2176d83cfe2af590d0c10687718ca11f63420f185e2027d51815146a9c2909912dbd95a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf9f782c6d4d2ab02bb7a9e627e9a4b45e1713a8bc97d3d645da78e2a6b25a760cc8de374370df172d9269d6ac35f347a83dcc9fcf478250a1c56122e6e00ab7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1705ccac63bae787c8b4e359cf2a8859e2128fc052171c57060492145c70e512cf741a1ba5c1d6833a5d80d8d49343443b1a1dfde940b3c10558c3122d7d7e33"} build_url:https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010425 build_url: 'https://queue.taskcluster.net/v1/task/L8dLEzzVQWONJd2oHhGHQQ/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/05cb0183b0ec04d641dc9db5252013d0e9761da1bcc1d57860c5a767e2176d83cfe2af590d0c10687718ca11f63420f185e2027d51815146a9c2909912dbd95a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cf9f782c6d4d2ab02bb7a9e627e9a4b45e1713a8bc97d3d645da78e2a6b25a760cc8de374370df172d9269d6ac35f347a83dcc9fcf478250a1c56122e6e00ab7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1705ccac63bae787c8b4e359cf2a8859e2128fc052171c57060492145c70e512cf741a1ba5c1d6833a5d80d8d49343443b1a1dfde940b3c10558c3122d7d7e33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:36:15.831464) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:36:15.831760) ========= 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.OWj3pUk2yf/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.sqCiGamkOk/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.004833 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:36:15.881036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:36:15.881401) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:36:15.882035) ========= ========= Total master_lag: 0.18 =========