builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0317 starttime: 1471395432.61 results: success (0) buildid: 20160816143514 builduid: fcc46ec626d84b06aa8424f0bd50b3b5 revision: 32ff5490a900e617eceb7b2458f1a20470dbb81f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:12.608541) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:12.609016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:12.609293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:12.781678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 17:57:12.781977) ========= 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.EkleUCRBlA/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.MfZCoUbYmq/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 17:57:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 209K=0.06s 2016-08-16 17:57:13 (209 KB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.923997 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 17:57:13.918616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:13.918963) ========= 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.EkleUCRBlA/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.MfZCoUbYmq/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.039628 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:14.149872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 17:57:14.150221) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 32ff5490a900e617eceb7b2458f1a20470dbb81f --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 32ff5490a900e617eceb7b2458f1a20470dbb81f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EkleUCRBlA/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.MfZCoUbYmq/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 17:57:14,241 truncating revision to first 12 chars 2016-08-16 17:57:14,242 Setting DEBUG logging. 2016-08-16 17:57:14,242 attempt 1/10 2016-08-16 17:57:14,242 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/32ff5490a900?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 17:57:15,536 unpacking tar archive at: fx-team-32ff5490a900/testing/mozharness/ program finished with exit code 0 elapsedTime=1.583478 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 17:57:15.756298) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:15.756640) ========= script_repo_revision: 32ff5490a900e617eceb7b2458f1a20470dbb81f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:15.757063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:15.757369) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:15.775571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-08-16 17:57:15.775949) ========= /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.EkleUCRBlA/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.MfZCoUbYmq/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:57:15 INFO - MultiFileLogger online at 20160816 17:57:15 in /builds/slave/test 17:57:15 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 17:57:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:57:15 INFO - {'append_to_log': False, 17:57:15 INFO - 'base_work_dir': '/builds/slave/test', 17:57:15 INFO - 'blob_upload_branch': 'Fx-Team', 17:57:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:57:15 INFO - 'branch': 'Fx-Team', 17:57:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:57:15 INFO - 'config_files': ('talos/mac_config.py',), 17:57:15 INFO - 'default_actions': ('clobber', 17:57:15 INFO - 'read-buildbot-config', 17:57:15 INFO - 'download-and-extract', 17:57:15 INFO - 'populate-webroot', 17:57:15 INFO - 'create-virtualenv', 17:57:15 INFO - 'install', 17:57:15 INFO - 'run-tests'), 17:57:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:57:15 INFO - 'download_minidump_stackwalk': True, 17:57:15 INFO - 'download_symbols': 'ondemand', 17:57:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:57:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:57:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:57:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:57:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:57:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:57:15 INFO - 'installer_path': 'installer.exe', 17:57:15 INFO - 'log_level': 'info', 17:57:15 INFO - 'log_name': 'talos', 17:57:15 INFO - 'log_to_console': True, 17:57:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:57:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:57:15 INFO - 'opt_config_files': (), 17:57:15 INFO - 'pip_index': False, 17:57:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:57:15 INFO - 'cmd': ('bash', 17:57:15 INFO - '-c', 17:57:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:57:15 INFO - 'enabled': True, 17:57:15 INFO - 'halt_on_failure': False, 17:57:15 INFO - 'name': 'check_screen_resolution'},), 17:57:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:57:15 INFO - 'cmd': ('bash', 17:57:15 INFO - '-c', 17:57:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:57:15 INFO - 'enabled': True, 17:57:15 INFO - 'halt_on_failure': False, 17:57:15 INFO - 'name': 'check_screen_resolution'},), 17:57:15 INFO - 'run_cmd_checks_enabled': True, 17:57:15 INFO - 'sps_profile': False, 17:57:15 INFO - 'sps_profile_interval': 0, 17:57:15 INFO - 'suite': 'dromaeojs', 17:57:15 INFO - 'system_bits': '32', 17:57:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:57:15 INFO - 'title': 't-yosemite-r7-0317', 17:57:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:57:15 INFO - 'use_talos_json': True, 17:57:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:57:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:57:15 INFO - 'work_dir': 'build'} 17:57:15 INFO - [mozharness: 2016-08-17 00:57:15.980461Z] Running clobber step. 17:57:15 INFO - Running pre-action listener: _resource_record_pre_action 17:57:15 INFO - Running main action method: clobber 17:57:15 INFO - rmtree: /builds/slave/test/build 17:57:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:57:18 INFO - Running post-action listener: _resource_record_post_action 17:57:18 INFO - [mozharness: 2016-08-17 00:57:18.029301Z] Finished clobber step (success) 17:57:18 INFO - [mozharness: 2016-08-17 00:57:18.029581Z] Running read-buildbot-config step. 17:57:18 INFO - Running pre-action listener: _resource_record_pre_action 17:57:18 INFO - Running main action method: read_buildbot_config 17:57:18 INFO - Using buildbot properties: 17:57:18 INFO - { 17:57:18 INFO - "project": "", 17:57:18 INFO - "product": "firefox", 17:57:18 INFO - "script_repo_revision": "production", 17:57:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:57:18 INFO - "repository": "", 17:57:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:57:18 INFO - "buildid": "20160816143514", 17:57:18 INFO - "pgo_build": "False", 17:57:18 INFO - "basedir": "/builds/slave/test", 17:57:18 INFO - "buildnumber": 913, 17:57:18 INFO - "slavename": "t-yosemite-r7-0317", 17:57:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:57:18 INFO - "platform": "yosemite_r7", 17:57:18 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:57:18 INFO - "branch": "fx-team", 17:57:18 INFO - "repo_path": "integration/fx-team", 17:57:18 INFO - "revision": "32ff5490a900e617eceb7b2458f1a20470dbb81f", 17:57:18 INFO - "stage_platform": "macosx64", 17:57:18 INFO - "builduid": "fcc46ec626d84b06aa8424f0bd50b3b5", 17:57:18 INFO - "slavebuilddir": "test" 17:57:18 INFO - } 17:57:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:57:18 INFO - Running post-action listener: _resource_record_post_action 17:57:18 INFO - [mozharness: 2016-08-17 00:57:18.035359Z] Finished read-buildbot-config step (success) 17:57:18 INFO - [mozharness: 2016-08-17 00:57:18.035519Z] Running download-and-extract step. 17:57:18 INFO - Running pre-action listener: _resource_record_pre_action 17:57:18 INFO - Running main action method: download_and_extract 17:57:18 INFO - mkdir: /builds/slave/test/build/tests 17:57: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')]} 17:57:18 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:57:18 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 17:57:19 INFO - Downloaded 1199 bytes. 17:57:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:57:19 INFO - Using the following test package requirements: 17:57:19 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:57:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:19 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:57:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:19 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:57:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:19 INFO - u'jsshell-mac.zip'], 17:57:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:19 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:57:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:57:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:19 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:57:19 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:19 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:57:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:19 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:57:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:19 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:57:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:19 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:57:19 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:57:20 INFO - Downloaded 16332150 bytes. 17:57:20 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:57:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:27 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:57:27 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:57:28 INFO - Downloaded 16332150 bytes. 17:57:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:34 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:57:34 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:57:41 INFO - Downloaded 14413719 bytes. 17:57:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 17:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:41 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:57:41 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 17:57:53 INFO - Downloaded 111084819 bytes. 17:57:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:57:53 INFO - mkdir: /builds/slave/test/properties 17:57:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:57:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:57:53 INFO - Contents: 17:57:53 INFO - build_url:https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:57:54 INFO - Running post-action listener: _resource_record_post_action 17:57:54 INFO - Running post-action listener: set_extra_try_arguments 17:57:54 INFO - [mozharness: 2016-08-17 00:57:54.576501Z] Finished download-and-extract step (success) 17:57:54 INFO - [mozharness: 2016-08-17 00:57:54.576654Z] Running populate-webroot step. 17:57:54 INFO - Running pre-action listener: _resource_record_pre_action 17:57:54 INFO - Running main action method: populate_webroot 17:57:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:57:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:57:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:57:54 INFO - '--tppagecycles', 17:57:54 INFO - '7'], 17:57:54 INFO - 'tests': ['tsvgm']}}, 17:57:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:57:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:57:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:57:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:57:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:54 INFO - 'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:54 INFO - 'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['damp', 'tps']}, 17:57:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:54 INFO - 'tests': ['damp', 'tps']}, 17:57:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['dromaeo_dom']}, 17:57:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:57:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['basic_compositor_video']}, 17:57:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:57:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['a11yr', 17:57:54 INFO - 'ts_paint', 17:57:54 INFO - 'tpaint', 17:57:54 INFO - 'sessionrestore', 17:57:54 INFO - 'sessionrestore_no_auto_restore', 17:57:54 INFO - 'tabpaint']}, 17:57:54 INFO - 'other-e10s': {'tests': ['a11yr', 17:57:54 INFO - 'ts_paint', 17:57:54 INFO - 'tpaint', 17:57:54 INFO - 'sessionrestore', 17:57:54 INFO - 'sessionrestore_no_auto_restore', 17:57:54 INFO - 'tabpaint']}, 17:57:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:57:54 INFO - 'ts_paint', 17:57:54 INFO - 'tpaint', 17:57:54 INFO - 'sessionrestore', 17:57:54 INFO - 'sessionrestore_no_auto_restore', 17:57:54 INFO - 'tabpaint']}, 17:57:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:57:54 INFO - 'ts_paint', 17:57:54 INFO - 'tpaint', 17:57:54 INFO - 'sessionrestore', 17:57:54 INFO - 'sessionrestore_no_auto_restore', 17:57:54 INFO - 'tabpaint']}, 17:57:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['a11yr', 17:57:54 INFO - 'ts_paint', 17:57:54 INFO - 'tpaint', 17:57:54 INFO - 'sessionrestore', 17:57:54 INFO - 'sessionrestore_no_auto_restore', 17:57:54 INFO - 'tabpaint']}, 17:57:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['a11yr', 17:57:54 INFO - 'ts_paint', 17:57:54 INFO - 'tpaint', 17:57:54 INFO - 'sessionrestore', 17:57:54 INFO - 'sessionrestore_no_auto_restore', 17:57:54 INFO - 'tabpaint']}, 17:57:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['tsvgx', 17:57:54 INFO - 'tsvgr_opacity', 17:57:54 INFO - 'tart', 17:57:54 INFO - 'tscrollx', 17:57:54 INFO - 'cart']}, 17:57:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:57:54 INFO - 'tsvgr_opacity', 17:57:54 INFO - 'tart', 17:57:54 INFO - 'tscrollx', 17:57:54 INFO - 'cart']}, 17:57:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:54 INFO - 'talos_options': ['--disable-e10s'], 17:57:54 INFO - 'tests': ['tp5o']}, 17:57:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:54 INFO - 'tests': ['tp5o']}, 17:57:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:54 INFO - 'talos_options': ['--disable-e10s', 17:57:54 INFO - '--xperf_path', 17:57:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:54 INFO - 'tests': ['tp5n']}, 17:57:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:54 INFO - 'talos_options': ['--xperf_path', 17:57:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:54 INFO - 'tests': ['tp5n']}}, 17:57:54 INFO - 'talos.zip': {'path': '', 17:57:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:57:54 INFO - Running post-action listener: _resource_record_post_action 17:57:54 INFO - [mozharness: 2016-08-17 00:57:54.595537Z] Finished populate-webroot step (success) 17:57:54 INFO - [mozharness: 2016-08-17 00:57:54.595668Z] Running create-virtualenv step. 17:57:54 INFO - Running pre-action listener: _resource_record_pre_action 17:57:54 INFO - Running main action method: create_virtualenv 17:57:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:57:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:57:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:57:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:57:54 INFO - Using real prefix '/tools/python27' 17:57:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:57:55 INFO - Installing distribute.............................................................................................................................................................................................done. 17:57:58 INFO - Installing pip.................done. 17:57:58 INFO - Return code: 0 17:57:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:58 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:58 INFO - 'HOME': '/Users/cltbld', 17:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:58 INFO - 'LOGNAME': 'cltbld', 17:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:58 INFO - 'MOZ_NO_REMOTE': '1', 17:57:58 INFO - 'NO_EM_RESTART': '1', 17:57:58 INFO - 'PAGER': '/bin/cat', 17:57:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:58 INFO - 'PWD': '/builds/slave/test', 17:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:58 INFO - 'SHELL': '/bin/bash', 17:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:57:58 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:58 INFO - 'USER': 'cltbld', 17:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:58 INFO - 'XPC_FLAGS': '0x0', 17:57:58 INFO - 'XPC_SERVICE_NAME': '0', 17:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:57:58 INFO - Cleaning up... 17:57:58 INFO - Return code: 0 17:57:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:57:58 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:57:58 INFO - 'HOME': '/Users/cltbld', 17:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:57:58 INFO - 'LOGNAME': 'cltbld', 17:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:58 INFO - 'MOZ_NO_REMOTE': '1', 17:57:58 INFO - 'NO_EM_RESTART': '1', 17:57:58 INFO - 'PAGER': '/bin/cat', 17:57:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:58 INFO - 'PWD': '/builds/slave/test', 17:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:57:58 INFO - 'SHELL': '/bin/bash', 17:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:57:58 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:57:58 INFO - 'USER': 'cltbld', 17:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:58 INFO - 'XPC_FLAGS': '0x0', 17:57:58 INFO - 'XPC_SERVICE_NAME': '0', 17:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:57:58 INFO - Downloading/unpacking psutil>=3.1.1 17:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:58:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:01 INFO - Installing collected packages: psutil 17:58:01 INFO - Running setup.py install for psutil 17:58:01 INFO - building 'psutil._psutil_osx' extension 17:58:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:58:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:58:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:58:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:58:02 INFO - building 'psutil._psutil_posix' extension 17:58:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:58:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:58:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:58:02 INFO - ^ 17:58:02 INFO - 1 warning generated. 17:58:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:58:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:02 INFO - Successfully installed psutil 17:58:02 INFO - Cleaning up... 17:58:02 INFO - Return code: 0 17:58:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:02 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:58:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:58:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:02 INFO - 'HOME': '/Users/cltbld', 17:58:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:02 INFO - 'LOGNAME': 'cltbld', 17:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:02 INFO - 'MOZ_NO_REMOTE': '1', 17:58:02 INFO - 'NO_EM_RESTART': '1', 17:58:02 INFO - 'PAGER': '/bin/cat', 17:58:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:02 INFO - 'PWD': '/builds/slave/test', 17:58:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:02 INFO - 'SHELL': '/bin/bash', 17:58:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:58:02 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:58:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:02 INFO - 'USER': 'cltbld', 17:58:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:02 INFO - 'XPC_FLAGS': '0x0', 17:58:02 INFO - 'XPC_SERVICE_NAME': '0', 17:58:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:58:05 INFO - Installing collected packages: mozsystemmonitor 17:58:05 INFO - Running setup.py install for mozsystemmonitor 17:58:06 INFO - Successfully installed mozsystemmonitor 17:58:06 INFO - Cleaning up... 17:58:06 INFO - Return code: 0 17:58:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:06 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:58:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:58:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:06 INFO - 'HOME': '/Users/cltbld', 17:58:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:06 INFO - 'LOGNAME': 'cltbld', 17:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:06 INFO - 'MOZ_NO_REMOTE': '1', 17:58:06 INFO - 'NO_EM_RESTART': '1', 17:58:06 INFO - 'PAGER': '/bin/cat', 17:58:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:06 INFO - 'PWD': '/builds/slave/test', 17:58:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:06 INFO - 'SHELL': '/bin/bash', 17:58:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:58:06 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:58:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:06 INFO - 'USER': 'cltbld', 17:58:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:06 INFO - 'XPC_FLAGS': '0x0', 17:58:06 INFO - 'XPC_SERVICE_NAME': '0', 17:58:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:06 INFO - Downloading/unpacking jsonschema==2.5.1 17:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:58:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:09 INFO - Downloading functools32-3.2.3-2.tar.gz 17:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:58:09 INFO - warning: no files found matching '*.txt' 17:58:09 INFO - no previously-included directories found matching 'build' 17:58:09 INFO - no previously-included directories found matching 'dist' 17:58:09 INFO - no previously-included directories found matching '.git*' 17:58:09 INFO - Installing collected packages: jsonschema, functools32 17:58:09 INFO - Running setup.py install for functools32 17:58:09 INFO - warning: no files found matching '*.txt' 17:58:09 INFO - no previously-included directories found matching 'build' 17:58:09 INFO - no previously-included directories found matching 'dist' 17:58:09 INFO - no previously-included directories found matching '.git*' 17:58:09 INFO - Successfully installed jsonschema functools32 17:58:09 INFO - Cleaning up... 17:58:09 INFO - Return code: 0 17:58:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:09 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:09 INFO - 'HOME': '/Users/cltbld', 17:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:09 INFO - 'LOGNAME': 'cltbld', 17:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:09 INFO - 'MOZ_NO_REMOTE': '1', 17:58:09 INFO - 'NO_EM_RESTART': '1', 17:58:09 INFO - 'PAGER': '/bin/cat', 17:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:09 INFO - 'PWD': '/builds/slave/test', 17:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:09 INFO - 'SHELL': '/bin/bash', 17:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:58:09 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:09 INFO - 'USER': 'cltbld', 17:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:09 INFO - 'XPC_FLAGS': '0x0', 17:58:09 INFO - 'XPC_SERVICE_NAME': '0', 17:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:58:09 INFO - Cleaning up... 17:58:09 INFO - Return code: 0 17:58:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:09 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:58:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:58:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:09 INFO - 'HOME': '/Users/cltbld', 17:58:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:09 INFO - 'LOGNAME': 'cltbld', 17:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:09 INFO - 'MOZ_NO_REMOTE': '1', 17:58:09 INFO - 'NO_EM_RESTART': '1', 17:58:09 INFO - 'PAGER': '/bin/cat', 17:58:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:09 INFO - 'PWD': '/builds/slave/test', 17:58:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:09 INFO - 'SHELL': '/bin/bash', 17:58:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:58:09 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:58:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:09 INFO - 'USER': 'cltbld', 17:58:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:09 INFO - 'XPC_FLAGS': '0x0', 17:58:09 INFO - 'XPC_SERVICE_NAME': '0', 17:58:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:12 INFO - Downloading blobuploader-1.2.4.tar.gz 17:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:58:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:58:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:13 INFO - Downloading docopt-0.6.1.tar.gz 17:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:58:13 INFO - Installing collected packages: blobuploader, requests, docopt 17:58:13 INFO - Running setup.py install for blobuploader 17:58:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:58:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:58:14 INFO - Running setup.py install for requests 17:58:14 INFO - Running setup.py install for docopt 17:58:14 INFO - Successfully installed blobuploader requests docopt 17:58:14 INFO - Cleaning up... 17:58:14 INFO - Return code: 0 17:58:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:14 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:58:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:58:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:58:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:14 INFO - 'HOME': '/Users/cltbld', 17:58:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:14 INFO - 'LOGNAME': 'cltbld', 17:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:14 INFO - 'MOZ_NO_REMOTE': '1', 17:58:14 INFO - 'NO_EM_RESTART': '1', 17:58:14 INFO - 'PAGER': '/bin/cat', 17:58:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:14 INFO - 'PWD': '/builds/slave/test', 17:58:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:14 INFO - 'SHELL': '/bin/bash', 17:58:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:58:14 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:58:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:14 INFO - 'USER': 'cltbld', 17:58:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:14 INFO - 'XPC_FLAGS': '0x0', 17:58:14 INFO - 'XPC_SERVICE_NAME': '0', 17:58:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-T9hBBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-gfbLGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-uyj3fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-4qVvyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-SzTpzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-UGxe0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-WGpugL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-SBrOzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:58:15 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-aLWVgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:58:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-buxILB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:58:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Ehnhwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:58:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-8VgRoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:58:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-uBgoaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:58:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Syxeim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Sax7ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:58:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-ZZth0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:58:16 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-ts4Uv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:58:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:58:16 INFO - Running setup.py install for manifestparser 17:58:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Running setup.py install for mozcrash 17:58:17 INFO - Running setup.py install for mozdebug 17:58:17 INFO - Running setup.py install for mozdevice 17:58:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Running setup.py install for mozfile 17:58:17 INFO - Running setup.py install for mozhttpd 17:58:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Running setup.py install for mozinfo 17:58:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Running setup.py install for mozInstall 17:58:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:58:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for mozleak 17:58:18 INFO - Running setup.py install for mozlog 17:58:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for moznetwork 17:58:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for mozprocess 17:58:18 INFO - Running setup.py install for mozprofile 17:58:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for mozrunner 17:58:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:58:18 INFO - Running setup.py install for mozscreenshot 17:58:19 INFO - Running setup.py install for moztest 17:58:19 INFO - Running setup.py install for mozversion 17:58:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:58:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:58:19 INFO - Cleaning up... 17:58:19 INFO - Return code: 0 17:58:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:19 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:58:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:58:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:19 INFO - 'HOME': '/Users/cltbld', 17:58:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:19 INFO - 'LOGNAME': 'cltbld', 17:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:19 INFO - 'MOZ_NO_REMOTE': '1', 17:58:19 INFO - 'NO_EM_RESTART': '1', 17:58:19 INFO - 'PAGER': '/bin/cat', 17:58:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:19 INFO - 'PWD': '/builds/slave/test', 17:58:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:19 INFO - 'SHELL': '/bin/bash', 17:58:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:58:19 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:58:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:19 INFO - 'USER': 'cltbld', 17:58:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:19 INFO - 'XPC_FLAGS': '0x0', 17:58:19 INFO - 'XPC_SERVICE_NAME': '0', 17:58:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:58:19 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-JxjUWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:58:19 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Y5cQKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:58:19 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-XrIz5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:58:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-GP8QV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-nwzUwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-fp34na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wPaOcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-6YRy4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-VcBpsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-mjmK2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-29DTOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-KLEKhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:58:20 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-_MhxA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:58:21 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-gNr8CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:21 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-FlqKry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:58:21 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-3bj3VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:58:21 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-fhlW4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:23 INFO - Downloading blessings-1.6.tar.gz 17:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:58:24 INFO - Installing collected packages: blessings 17:58:24 INFO - Running setup.py install for blessings 17:58:24 INFO - Successfully installed blessings 17:58:24 INFO - Cleaning up... 17:58:24 INFO - Return code: 0 17:58:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:58:24 INFO - Reading from file tmpfile_stdout 17:58:24 INFO - Current package versions: 17:58:24 INFO - blessings == 1.6 17:58:24 INFO - blobuploader == 1.2.4 17:58:24 INFO - docopt == 0.6.1 17:58:24 INFO - functools32 == 3.2.3-2 17:58:24 INFO - jsonschema == 2.5.1 17:58:24 INFO - manifestparser == 1.1 17:58:24 INFO - mozInstall == 1.12 17:58:24 INFO - mozcrash == 0.17 17:58:24 INFO - mozdebug == 0.1 17:58:24 INFO - mozdevice == 0.48 17:58:24 INFO - mozfile == 1.2 17:58:24 INFO - mozhttpd == 0.7 17:58:24 INFO - mozinfo == 0.9 17:58:24 INFO - mozleak == 0.1 17:58:24 INFO - mozlog == 3.3 17:58:24 INFO - moznetwork == 0.27 17:58:24 INFO - mozprocess == 0.23 17:58:24 INFO - mozprofile == 0.28 17:58:24 INFO - mozrunner == 6.12 17:58:24 INFO - mozscreenshot == 0.1 17:58:24 INFO - mozsystemmonitor == 0.3 17:58:24 INFO - moztest == 0.7 17:58:24 INFO - mozversion == 1.4 17:58:24 INFO - psutil == 3.1.1 17:58:24 INFO - requests == 1.2.3 17:58:24 INFO - wsgiref == 0.1.2 17:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:24 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:24 INFO - 'HOME': '/Users/cltbld', 17:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:24 INFO - 'LOGNAME': 'cltbld', 17:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:24 INFO - 'MOZ_NO_REMOTE': '1', 17:58:24 INFO - 'NO_EM_RESTART': '1', 17:58:24 INFO - 'PAGER': '/bin/cat', 17:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:24 INFO - 'PWD': '/builds/slave/test', 17:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:24 INFO - 'SHELL': '/bin/bash', 17:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:58:24 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:24 INFO - 'USER': 'cltbld', 17:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:24 INFO - 'XPC_FLAGS': '0x0', 17:58:24 INFO - 'XPC_SERVICE_NAME': '0', 17:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:58:24 INFO - Cleaning up... 17:58:24 INFO - Return code: 0 17:58:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:24 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 0x10c79ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c831618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66a494ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, '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.EkleUCRBlA/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.MfZCoUbYmq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:24 INFO - 'HOME': '/Users/cltbld', 17:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:24 INFO - 'LOGNAME': 'cltbld', 17:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:24 INFO - 'MOZ_NO_REMOTE': '1', 17:58:24 INFO - 'NO_EM_RESTART': '1', 17:58:24 INFO - 'PAGER': '/bin/cat', 17:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:24 INFO - 'PWD': '/builds/slave/test', 17:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:24 INFO - 'SHELL': '/bin/bash', 17:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:58:24 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:24 INFO - 'USER': 'cltbld', 17:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:24 INFO - 'XPC_FLAGS': '0x0', 17:58:24 INFO - 'XPC_SERVICE_NAME': '0', 17:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:58:25 INFO - Cleaning up... 17:58:25 INFO - Return code: 0 17:58:25 INFO - Running post-action listener: _resource_record_post_action 17:58:25 INFO - Running post-action listener: _start_resource_monitoring 17:58:25 INFO - Starting resource monitoring. 17:58:25 INFO - [mozharness: 2016-08-17 00:58:25.190331Z] Finished create-virtualenv step (success) 17:58:25 INFO - [mozharness: 2016-08-17 00:58:25.191403Z] Running install step. 17:58:25 INFO - Running pre-action listener: _resource_record_pre_action 17:58:25 INFO - Running main action method: install 17:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:58:25 INFO - Reading from file tmpfile_stdout 17:58:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:58:25 INFO - Reading from file tmpfile_stdout 17:58:25 INFO - Output received: 17:58:25 INFO - Usage: mozinstall [options] installer 17:58:25 INFO - Options: 17:58:25 INFO - -h, --help show this help message and exit 17:58:25 INFO - -d DEST, --destination=DEST 17:58:25 INFO - Directory to install application into. [default: 17:58:25 INFO - "/builds/slave/test"] 17:58:25 INFO - --app=APP Application being installed. [default: firefox] 17:58:25 INFO - mkdir: /builds/slave/test/build/application 17:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:59:00 INFO - Reading from file tmpfile_stdout 17:59:00 INFO - Output received: 17:59:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:59:00 INFO - Running post-action listener: _resource_record_post_action 17:59:00 INFO - [mozharness: 2016-08-17 00:59:00.472368Z] Finished install step (success) 17:59:00 INFO - [mozharness: 2016-08-17 00:59:00.472523Z] Running run-tests step. 17:59:00 INFO - Running pre-action listener: _resource_record_pre_action 17:59:00 INFO - Running main action method: run_tests 17:59:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:00 INFO - 2016-08-16 17:59:00.484 screenresolution[1638:8112] starting screenresolution argv=screenresolution get 17:59:00 INFO - 2016-08-16 17:59:00.487 screenresolution[1638:8112] Display 0: 1600x1200x32@60 17:59:00 INFO - 2016-08-16 17:59:00.492 screenresolution[1639:8115] starting screenresolution argv=screenresolution list 17:59:00 INFO - Available Modes on Display 0 17:59:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:00 INFO - Intel Iris: 17:59:00 INFO - Chipset Model: Intel Iris 17:59:00 INFO - Type: GPU 17:59:00 INFO - Bus: Built-In 17:59:00 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:00 INFO - Vendor: Intel (0x8086) 17:59:00 INFO - Device ID: 0x0a2e 17:59:00 INFO - Revision ID: 0x0009 17:59:00 INFO - Displays: 17:59:00 INFO - Display: 17:59:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:00 INFO - Display Serial Number: 1600x1200 60 17:59:00 INFO - Main Display: Yes 17:59:00 INFO - Mirror: Off 17:59:00 INFO - Online: Yes 17:59:00 INFO - Rotation: Supported 17:59:00 INFO - Return code: 0 17:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:59:00 INFO - Python 2.7.3 17:59:00 INFO - Return code: 0 17:59:00 INFO - grabbing minidump binary from tooltool 17:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:00 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 0x10c700d30>, '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 0x10c465db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:59:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:59:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:59:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:59:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:59:00 INFO - Return code: 0 17:59:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:59:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:59:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:59:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:59:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:59:00 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/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 17:59:00 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/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --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 17:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EkleUCRBlA/Render', 17:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:00 INFO - 'HOME': '/Users/cltbld', 17:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:00 INFO - 'LOGNAME': 'cltbld', 17:59:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:59:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:00 INFO - 'MOZ_NO_REMOTE': '1', 17:59:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:59:00 INFO - 'NO_EM_RESTART': '1', 17:59:00 INFO - 'PAGER': '/bin/cat', 17:59:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:00 INFO - 'PWD': '/builds/slave/test', 17:59:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:00 INFO - 'SHELL': '/bin/bash', 17:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MfZCoUbYmq/Listeners', 17:59:00 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 17:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:00 INFO - 'USER': 'cltbld', 17:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:00 INFO - 'XPC_FLAGS': '0x0', 17:59:00 INFO - 'XPC_SERVICE_NAME': '0', 17:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:00 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/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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 17:59:01 INFO - mozversion application_buildid: 20160816143514 17:59:01 INFO - mozversion application_changeset: 32ff5490a900e617eceb7b2458f1a20470dbb81f 17:59:01 INFO - mozversion application_display_name: Nightly 17:59:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:59:01 INFO - mozversion application_name: Firefox 17:59:01 INFO - mozversion application_remotingname: firefox 17:59:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:59:01 INFO - mozversion application_vendor: Mozilla 17:59:01 INFO - mozversion application_version: 51.0a1 17:59:01 INFO - mozversion platform_buildid: 20160816143514 17:59:01 INFO - mozversion platform_changeset: 32ff5490a900e617eceb7b2458f1a20470dbb81f 17:59:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:59:01 INFO - mozversion platform_version: 51.0a1 17:59:01 INFO - using testdate: 1471395541 17:59:01 INFO - actual date: 1471395541 17:59:01 INFO - starting webserver on 'localhost:49267' 17:59:01 INFO - SUITE-START | Running 2 tests 17:59:01 INFO - TEST-START | dromaeo_css 17:59:01 INFO - operating with platform_type : mac_ 17:59:01 INFO - Initialising browser for dromaeo_css test... 17:59:01 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpdIfVDD/profile http://localhost:49267/getInfo.html) 17:59:03 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 17:59:03 INFO - PROCESS | 1649 | colorDepth:24 17:59:03 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 17:59:03 INFO - PROCESS | 1649 | __metrics 17:59:03 INFO - PROCESS | 1649 | 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" 17:59:03 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:59:04 INFO - TEST-INFO | 1649: exit 0 17:59:04 INFO - Browser initialized. 17:59:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:59:04 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpdIfVDD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:59:16 INFO - PROCESS | 1652 | RSS: Main: 227262464 17:59:16 INFO - PROCESS | 1652 | 18:00:08 INFO - PROCESS | 1652 | 1471395608515 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] 18:02:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 18:02:22 INFO - PROCESS | 1652 | RSS: Main: 369946624 18:02:22 INFO - PROCESS | 1652 | 18:05:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 18:05:25 INFO - PROCESS | 1652 | RSS: Main: 368824320 18:05:25 INFO - PROCESS | 1652 | 18:08:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 18:08:28 INFO - PROCESS | 1652 | RSS: Main: 335491072 18:08:28 INFO - PROCESS | 1652 | 18:11:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 18:11:31 INFO - PROCESS | 1652 | RSS: Main: 362987520 18:11:31 INFO - PROCESS | 1652 | 18:14:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 18:14:35 INFO - PROCESS | 1652 | RSS: Main: 339763200 18:14:35 INFO - PROCESS | 1652 | 18:17:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 18:17:39 INFO - PROCESS | 1652 | RSS: Main: 436277248 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | __start_tp_report 18:17:39 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 18:17:39 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 18:17:39 INFO - PROCESS | 1652 | |i|pagename|runs| 18:17:39 INFO - PROCESS | 1652 | |0;dojo.html;3353.4299169141245;3405.67646073623;3433.2446861690437;3446.8621255149797;3488.91277718057;5691.772329106841;5785.305763308404;5838.532917366606;5896.498797602204;5927.466528012478;5888.41115888411;5898.734556944937;5903.380145084758;5931.911021334683;5933.732982015809;5256.684598924067;5285;5334.91997620036;5351.384590772052;5398.352197736277;5362.865928351803;5402.810901618444;5406.567474602022;5409;5409.891802163955;5288.180332048539;5325.7603407846545;5333.2000199970125;5340.813071542497;5397.595180361489;4476.55234476553;5404.378496472897;5424.891502169974;5432.565394768449;5461.2354270402175;5162.586993040548;5229.2417599448245;5291.497307755757;5323.494268044568;5328.440513746078;5836.124581312794;5863;5881.647101173943;5911.586188966774;5945.227120474354;5246.265522826808;6219.87560248797;6234.220722409699;6240.469560087398;6241.21984751906;6124.258880972529;6160.9383906161265;6263.34234905333;6280.497560195174;6313.431791138773;6035.155078289043;6042.879142417127;6052.455279024909;6052.939470605325;6054.455099041107;5410.3778065522965;6393.6483493408305;6417;6422.197225346832;6440.549161558646;6094.8943112006145;6131.774283661862;6162.383761623802;6191.659458729723;6260.154879091265;6251.187345645037;6273.811785646438;6280.623162610258;6280.937190628127;6292.370762923762;5185.896282074337;6218.061751027758;6235.095911092957;6239.344868788802;6267.310595834455;6181.505479561624;6188.845278868064;6233.407826256498;6249.031400132896;6258.249010118815;4969.105560998983;4982;4988.700677959261;4995.825146119869;5020.548150666457;3946.9013274668364;4338.305871060616;4435.667324950641;4450.332450132441;4490.079533695584;5716.942830571641;5794.855128621818;5809.331926828469;5818.44724751148;5889.793857214977;6162.445379915829;6216.036514340284;6229.968850155811;6275.529335299871;6282.151909492251;5893.410658934073;5895.115732640053;5898.528117750569;5898.793542226002;5959.165716799652;5409.107497262986;5433.185022246695;5512.448755124536;5519.448055194529;5537.750801213955;5172.922406163835;6372.330905254881;6398.8720225595225;6489.1888513935755;6502.707378167899;6204;6266.811995640138;6274.874502510015;6286.9371306288185;6289.779857704958;6499.740010399721;6502.544821862424;6508;6511.544191906521;6522.15212022434;6142.539309551712;6155.569110162425;6163.291221509584;6180.876382472416;6220.626762394271;6081.878362432815;6250.937490625218;6264.091706702594;6270.623762574261;6281;6237.1891654084675;6238.906416403848;6244.781432650017;6255.24937007562;6257.624542527463;6032.4570788629235;6124.319907527303;6169.56813023084;6171.47542458896;6253.280872699515;5069.923951140662;6066.240790170801;6115.266168059861;6118.908216376847;6120.693965301806;6084.8783024340155;6219.191505104489;6255.96872015637;6257.9687101564205;6258.155149054819;6029.035354343284;6036.33600303975;6091.208142941389;6103.176071230327;6105.328413874381 18:17:39 INFO - PROCESS | 1652 | |1;ext.html;463.83533845484845;479.25954400451275;481.4054642516494;510.720644784814;541.8242413961702;26552.336191595197;39649.60350396495;40382.394264086026;40417.393739093866;40438.19123617526;34098.48852267218;41425.96435089117;41830.163396732045;41839.58160418395;42034.57965420345;8875.378723489359;9690.806183876319;9870.901290987105;9876.802463950717;9895.356801807895;8826.249768769661;11757.647270581854;11973.341466219354;12008.339541325224;12285.262884226975;12042.939785301061;12105.818412723816;12116;12132.968697660664;12164.087693422984;12034.879651203508;12128.939355303255;12133.878661213363;12135.029197664166;12139.332336721476;11782.941085294518;11864.288142711379;11934.16460847741;11936.522539098425;11943.761124777457;39435.40846887299;39620.40569391462;39653.40519892204;39672.61145859881;39720.404193937116;3298.4062868683627;3348.916277093092;3362.2771104212466;3786.280606684721;4232.238197124517;31266.21834454134;32013.83993080043;32200.516992245135;32504;32547.51178732321;3139;3248.870045198189;3273.623533293678;3287.539744435781;3344.7324214062814;479258;479734;481763;483659.5817020928;487332;57455.425445745845;57853.71073144607;57857.8428431429;57932.8413431729;57978;62321.68839155775;62383;62438;62474.68762656249;62531;15153.393864245527;15351.692966140614;15377.692446151013;15384;15404.306806193748;10819.972102650236;10979.396133212591;11006;11096.5561377544;11766.176367654352;16191;18254.269829206947;18679;18722.438326850217;18989.33537326187;4910.8859469960125;6558.376954189344;6722.563033402813;7769.961150194213;7852.725154619675;844.4004756622744;879.2174964281794;906.4153620914605;950.9144177024101;1038.7558923652934;28762;29431.11706648804;29596.112116636534;29997.550036749468;30028.24929376783;946.7538440005649;1058.6559368205365;1103.4096758234307;1125.8142406503;1172.7419967607113;15015.849841501664;15254;15379;15410;15731;609919;619047;619437.9309138041;619604;620964;55740.442595574335;56108.438915611136;56115;56140;56221.71889140528;1181;1236.746466974286;1270.9237445753283;1307.4900788692419;1326.2042774335514;29126.854365728035;30661.386772264876;31188;31278.53082203723;31612.209694757814;39396.40905386479;47570.52429475661;48070.79823004313;48071;48140.518594813606;458731;463433;463687;464436;465521;22524.436889077904;25737.613935791353;26721;27152.321191970357;28145.43709125847;45631.54368456273;46386.53613463822;46861.06277874492;47124.76437617927;47235;32069;37310.880673579835;38544.22911541809;39637.801810991914;40135.79932100321;37629.81185094167;37812.81093594514;37855;39358.6545143666;39375;37213;37695.811520943316;38094;38225.808870955465;38272.42591361188;30960;33774.32451351008;33789.83105084459;33839.32321353608;33880.15299617529;24631.87684061568;25008.124715634865;25362.365940851625;25501.56926621915;25631.871840640677 18:17:39 INFO - PROCESS | 1652 | |2;jquery.html;352.0371783173023;369.67837980956557;373.48832100022975;379.70383101181073;402.27590337392706;12449;16533.338666453343;20046;20190.59618807623;20280.797192028076;16596.170191490437;20738.89630551849;21168.153273869066;21429.249976250834;21471.248506302283;5144.61415393847;5923.911141332873;5935.783164451299;6170.105334726462;6172.938270617304;6055.364186760393;6152.47703945163;6161.938380616204;6163.044728067157;6171.228596425447;3470.861165553375;3907.960920390802;4120.649744771683;5842.970785146068;6137.355577664325;5807.506361959238;6136.693165341715;6165.445109940082;6169.722362493699;6190.102435146923;5900.291964964232;6003.579749417542;6008.068749343815;6019.097135429721;6036.788712395089;13496.662583435394;13501.797473037912;13526.729465410735;13532.255725935069;13705.725885482334;1903.7636018768148;2127.489402543394;2151.279321427324;2239.1379318962154;2656.6546348974703;7710.768676939645;8352.331813454908;9896.208303335716;10136.087752102272;10497.055265026183;1863.0963982468493;1891.4136617648574;1906.7235250888682;1966.6558352288434;1987.6620974434381;104026.16308054372;108716.82566348708;127684.99999999907;127731;134517;11293.37886416255;11481.138914581274;11545.249558778652;11582.768344633228;11589.377487151805;12098.63704088861;14554.981151319518;14568.198749068692;14571.635709107357;14580.979331446697;8103.0681471631515;8330.791730206793;8354.456960297683;8461.646136618234;8500.957495212484;6788.76239331621;8158.224968627971;8170.509769413854;8172.387070969701;8374.665013399517;4427.822887084545;4490.550944905483;4517.774111294422;4574.268117101248;4597.011642496879;1673.6150685342195;1816.8364847163555;1909.675355189621;1920.5486710622993;1927.5373910261437;810.8743144812563;869.4480352570757;898.481566153199;906.496894223699;968.9273304502191;20417.387478375673;21178.576428471653;21258;21319.573608527742;21360.145594176058;708.4721882197692;804.9557274349967;833.4957350802798;890.6214858685033;903.0969030969031;10551.103156231806;11070.889291107147;11078.778424431466;11260.38067906273;11267.887321126684;549875;572492;614740;618032;622799;70510;77664;109087;123028;141067;944.6504793226413;979.588572799426;992.007992007992;1012.1599072769584;1012.1801340913736;19356.612867742286;19535.413937581896;19563.51091222731;19780.50548736293;19789.90105049523;56487.71756141193;57245.14132288102;57332;58383;58402.83194336174;54214.728926355114;75963.62018189873;77853.61073194598;78451.60774196092;78603;6857.828554286183;7556.584387858501;8084.959575202086;8198.795030124294;8468;11969.760604788029;12483.375831208585;13189.604311870658;13556.525521606696;13778.448862045807;11124.332540047622;11415.429228538706;11781.646550603497;11831.526738930346;11948.76102477963;10889.455527223765;11251.831222531504;11496.425178740863;11897.821532676844;11930.522779088738;10790.651168603925;11470.483828227583;11865.822012669989;11877.406129693654;12092;6984.965075174795;7128.928710713034;8121.593920303843;8435.072142064246;8472.406931514735;9371;11641.59254426091;11766.470508826953;11780.52877884875;11821.172517924007 18:17:39 INFO - PROCESS | 1652 | |3;mootools.html;1513.061901620995;1549.5428848489696;1715.1681434504262;1853.907304634768;1864.776226852777;8337.916620833797;8914.153155450222;8918.42030268033;8920.107989201077;8920.732378028653;7778.727744528943;7991.520508769478;8486.321094312456;8683.869741953877;8707.303415726743;2339.134520227514;2381.833271670975;2382.892769825362;2384.8926798294033;2385.105585405473;2360.3862995621175;2377.0135393811547;2402.267308470916;2403.3390817525146;2406.1217655555683;1985.0670185013093;2157.2018353209255;2186.7813218678166;2341.882905854709;2396.400899775056;2347.5539647466926;2365.467769751809;2373.311739595515;2373.7032870891226;2380.8214383921277;2361.728401233846;2368.27767530903;2371.8814059296965;2380.0479808076734;2389.8685572293516;8709.390342676015;8879.245264152554;8884.955575222148;8887.35583916971;8888.688895888612;5212.765425555859;5243.082460569385;5347.518723314882;5365.919511207335;5389.353277606712;2947.3957838643028;3578.7494875358734;3712.962870371289;3713.9814300928592;3725.8695945642044;1049.5906596427399;1090.820014697574;1103.2442776697987;1124.5333186727498;1130.4517309105076;11607.955284024394;11721.589744358907;11731.120165987584;11735.4132293385;11754.706132346675;4528.117017181618;4591.724496530219;4778.617710583215;4778.832740854054;4809.062232864558;8291.83416331682;9885.851712224323;9897.554610042565;9916.801663966824;9921.255905807093;5348.358197016383;5354.143337066051;5354.41101478837;5357.785688572491;5361.946380536145;4400.867973960786;4559.749213793207;4573.748443835554;4827.324174615556;4919.2867034279825;3862.787546684903;3886.902827429337;3973.2450834341385;4021.597840215955;4025.75845449274;1283.3573026526062;1289.3166621690518;1290.6837824733;1303.3939218263363;1306.2227974355244;833.2375876073326;857.2713193785232;903.9954800225956;908.8046070094962;934.1359242700611;5777.19119323295;5806.622569532967;6068.575199735976;6076.513878889678;6126.509879209652;801.9558924259105;954.2461455450256;954.8424509955919;962.2302158273353;1011.0092109732503;3908.179282350738;3978.403239514096;4030.5892937472236;4121.690873184523;4125.690573207022;8830.690925817566;10511.737206569896;10925;10942.945285273523;10989;10163.034511721375;10634.042936135631;10651.467426628638;10839.783204335869;10858.022777949864;8016.879746803803;8196.754097377088;8241.79395515105;8248.83502329962;8266.256036956582;5210.53105220532;5909.172715819703;5972.70136493165;6125.663088529996;6171.950768369298;9012.909870901207;9798.216142708709;9973.750656233362;10036.799264014824;10168.186545076229;10012.04885535873;10078.546465409221;10232.948835255776;10437.060664540228;10439.634612788515;7016.824579385556;7233.421326293989;7430.888536671846;7533.547987120571;7691.50005249657;8306.584670766559;8544.444611100258;8544.487330760174;8547.188017138362;8553;7366.7053317866685;7457.47797654159;7459.664315105942;7520.962395188208;7629.389648828192;6325.905111423241;7233;7287.979682844512;7292.380147687506;7497.662605182671;6939.236683964861;7089.695848849248;7091.43268538526;7092.361687448154;7097.609631470112;4940.505949405031;4994.450610432777;5020.146575082172;5021.472745361684;5107.182850744011;4876.905274918152;4934.568974997211;5033.823816166417;5156.484351564814;5210.869728256824 18:17:39 INFO - PROCESS | 1652 | |4;prototype.html;228.62733743997282;301.92753739102614;309.19917413897997;313.92151962009495;315.24656071987937;4877.926831097532;5511.807086751965;5538.196961440589;5572.606848287928;5573.972130139344;4114;4532.650956121559;4892.535209155125;5450.127979523277;5451.454854514546;3949.3878448840474;3988.262171498282;4095.4471146395304;4146.253674338618;4167.291560434734;3820.522434695663;3855.961440385602;4172.100390228792;4185.309423945046;4201.264778663737;4010.939835902464;4082.4284600156;4111.321631930728;4159.854405095823;4194.203101410738;3584.6415358463946;4147.668186545069;4155.501339839208;4170.833166673329;4180.874573762792;3573.1781690211396;3594.5866225383893;3602.1808986461933;3623.365910965597;3640.3265395901576;4631.444226692818;4972.900541989176;4993.601791498386;5391.541718953894;5400.108982017962;4038.9394159087637;4498.280275155992;4504.144212599595;4512.420652771537;4665.576999015299;5155.948440515622;5722.54219662426;5728.882867840773;5744.339400968858;5772.8845423091725;3974.463447434588;3987.8803635890968;4003.799810009488;4004.759714417115;4019.33680942647;5134.843365786379;5352.143657014898;5467.507924286833;5615.298087739033;5975.372585878507;3800.7719536827326;3929.8821035368983;3936.626020528045;3945.8754255037175;3952.1700442906736;3967.444557761916;4008.196311659765;4008.899777505586;4036.1927614476635;4036.455078564415;4311.655067594647;4522.977385113119;4541.409616749801;4611.700239484489;4642.651801114863;5041.504455294653;5078.619103567247;5238.3190185276435;5700.600957932905;5800.8259752207505;1232.0451649971164;1352.9255890925897;1364.324659293656;1366.6856622976572;1369.7876829091506;770.98230335956;815.0260438775724;817.5952903312898;835.7659855240543;836.5148214035845;3726.950177402472;4021.552241193168;4395.055063161436;4403.933940990888;4424.889377765581;3872.760716570727;4281.550437204111;4474.664400170001;4815.422149342101;4840.830570930071;4358.411614432011;4421.7346959181905;4452.821887124479;4458.9554104459185;4541.84103556374;2128.978710212909;2183.7707040760492;2396.0232807933526;2420.4070002849417;2616.921492355232;4171.687123465692;4436.6672499562665;4510.684252102387;4912.017596480719;5024.57291130258;4234.640055595309;4557;4829.6291855870495;4948.950510494921;5003.549680528697;4551.418891130212;4982.75086245679;5010.774515146754;5017.54842064216;5018.594793457838;4160.791960402028;4654.299831633927;4820;4927.8605970984545;4940.7035577865445;4353.151135528541;4587.954120458886;4649.930251046305;4765.76171191446;4922.4339200992345;4601.8955450692265;4635.284944570396;4981.750912454435;5021.543752311934;5085.8728531787;2930.8534573271677;3075.8923437679573;3200.535922291208;3270.9836450817593;3382.678645528671;4248.511421186603;4345.565443455629;4553.453585569753;4576.9861261045035;4887.780049897834;3916.395596928011;4284.935725964176;4727.881802954954;4731.881702957454;4747.620190384692;4614.584687378152;4652.744099074584;4701.576858082789;4702.717836929795;4741.5495527924795;3874.9418758719207;4584.312353147055;4593.678442508993;4602.677812553089;4607.447106347126;3905;4158;4679.602233810164;4685.601723853374;4697.6711630185555;4307.741535507879;4558.994042621236;4559.452865656142;4614.10025045113;4629.490756016903 18:17:39 INFO - PROCESS | 1652 | |5;yui.html;711.6015031582315;732.6226993098555;742.2169611060333;783.6865253898442;819.2381085590398;15170.469033583826;15939.601509962256;15966;15985.120818355;15991.040537567755;15065.472708455207;15218.315175817088;15246.085234885915;15249.695006099872;15264.16047117408;667.8430568816324;685.7497013590054;823.5593957232882;828.883956246126;838.2330167896367;826.2481142160635;843.9535825529593;844.4131328726537;846.5344060766585;848.3001523742937;901.0808974845653;902.5351943748974;903.0382642485764;903.5527413930114;903.8282726282018;707.7699747582005;866.1295398124907;894.9149830766066;896.5651658945407;900.4732231644463;665.1087542692767;666.4468491152332;666.4535081233342;666.7333066773281;666.8266250774833;15101.018433801768;15116.470923517734;15177.16525591092;15177.317020734094;15205.923970380078;12853.742925141538;13900.374483148182;14064.367103480368;14360.712785744226;14406.78389824143;12991.415386307639;13123.278219697913;13276.137051091744;13434.395452204673;13849.307534623329;3819.5034645496185;4672.299155126724;4713.905721885578;4799.544043315879;4877.585405240558;110526;112592;119290.40354798171;120142;122264;11241.759934029802;11384.316940983568;11512.021478174449;11567.76864462723;11614.825777613343;22444.775552244268;22480.662790058162;22505.662415063787;22508;22588.548229035656;7735.690572377154;7993.200679931961;8018.4787988780545;8095.595220238964;8096.635651395702;4290.356446533045;4403.581659742319;4415.116976604628;4469.396631454712;4599;3368.6294507604143;3428.4171690812623;3484.738644601665;3488.755787094879;3491.982540087334;631.8199313195718;641.7561326695919;641.9967900160469;657.2310396835713;659.947204223661;564.0861803877744;591.5770224289654;602.2471910112359;607.4350853706007;620.7392894984117;8337.583120844054;9099.954500227457;9113.088691130833;9150.40522366044;9211.170994610517;574.2506029631288;587.4477990688739;601.6239850093691;634.4835842336819;641.4323323858418;4281.678874084456;4424.98476961255;4449.755263460476;4457.353683715843;4503.166914120898;86482;87514;90346.64480032805;147154;158466;127663.36168319099;136504;138021.7186968785;138773;144494;90867.18265634782;109953.35069973797;110369;111800.44099779449;115921.61175823693;7247.231960015414;7470.775876723707;8607.95696021541;8745.956270218609;8882.60028298741;51352;63078;63734.043989341124;65070;65977.67011164913;94618.95738862274;100610;101091;103416;103511.48244258731;11596.652100437;11644.6506604802;11666.358350290815;11701.648950531498;11719.648410547697;12529.060320476183;12876.163049401759;13031.543895963596;13321;13410.798838017632;12275.508979640714;12320.876791232331;13295.232812670423;14088.929555352568;14339.067960582528;11436.94281528587;13280.269585172908;14399.280035997948;14590.270486475845;14603.43352762133;12507.624771256877;14022.8781697466;14081.577552673027;14177.716445670823;14557.490487833298;11563.768724625628;11622.535098595961;11640.94179529097;11764.823527647264;12029.398530073637;9497.905020949702;10536.79015034861;10555.886013625844;10577;11237.04485118774 18:17:39 INFO - PROCESS | 1652 | __end_tp_report 18:17:39 INFO - PROCESS | 1652 | __start_cc_report 18:17:39 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1468 18:17:39 INFO - PROCESS | 1652 | __end_cc_report 18:17:39 INFO - PROCESS | 1652 | __startTimestamp1471396659054__endTimestamp 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | ------- Summary: start ------- 18:17:39 INFO - PROCESS | 1652 | Number of tests: 6 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5804.38 Median:6054.46 stddev:652.68 (10.8%) stddev-sans-first:625.72 18:17:39 INFO - PROCESS | 1652 | Values: 3353.4 3405.7 3433.2 3446.9 3488.9 5691.8 5785.3 5838.5 5896.5 5927.5 5888.4 5898.7 5903.4 5931.9 5933.7 5256.7 5285.0 5334.9 5351.4 5398.4 5362.9 5402.8 5406.6 5409.0 5409.9 5288.2 5325.8 5333.2 5340.8 5397.6 4476.6 5404.4 5424.9 5432.6 5461.2 5162.6 5229.2 5291.5 5323.5 5328.4 5836.1 5863.0 5881.6 5911.6 5945.2 5246.3 6219.9 6234.2 6240.5 6241.2 6124.3 6160.9 6263.3 6280.5 6313.4 6035.2 6042.9 6052.5 6052.9 6054.5 5410.4 6393.6 6417.0 6422.2 6440.5 6094.9 6131.8 6162.4 6191.7 6260.2 6251.2 6273.8 6280.6 6280.9 6292.4 5185.9 6218.1 6235.1 6239.3 6267.3 6181.5 6188.8 6233.4 6249.0 6258.2 4969.1 4982.0 4988.7 4995.8 5020.5 3946.9 4338.3 4435.7 4450.3 4490.1 5716.9 5794.9 5809.3 5818.4 5889.8 6162.4 6216.0 6230.0 6275.5 6282.2 5893.4 5895.1 5898.5 5898.8 5959.2 5409.1 5433.2 5512.4 5519.4 5537.8 5172.9 6372.3 6398.9 6489.2 6502.7 6204.0 6266.8 6274.9 6286.9 6289.8 6499.7 6502.5 6508.0 6511.5 6522.2 6142.5 6155.6 6163.3 6180.9 6220.6 6081.9 6250.9 6264.1 6270.6 6281.0 6237.2 6238.9 6244.8 6255.2 6257.6 6032.5 6124.3 6169.6 6171.5 6253.3 5069.9 6066.2 6115.3 6118.9 6120.7 6084.9 6219.2 6256.0 6258.0 6258.2 6029.0 6036.3 6091.2 6103.2 6105.3 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:65977.92 Median:37261.94 stddev:140109.88 (376.0%) stddev-sans-first:140416.58 18:17:39 INFO - PROCESS | 1652 | Values: 463.8 479.3 481.4 510.7 541.8 26552.3 39649.6 40382.4 40417.4 40438.2 34098.5 41426.0 41830.2 41839.6 42034.6 8875.4 9690.8 9870.9 9876.8 9895.4 8826.2 11757.6 11973.3 12008.3 12285.3 12042.9 12105.8 12116.0 12133.0 12164.1 12034.9 12128.9 12133.9 12135.0 12139.3 11782.9 11864.3 11934.2 11936.5 11943.8 39435.4 39620.4 39653.4 39672.6 39720.4 3298.4 3348.9 3362.3 3786.3 4232.2 31266.2 32013.8 32200.5 32504.0 32547.5 3139.0 3248.9 3273.6 3287.5 3344.7 479258.0 479734.0 481763.0 483659.6 487332.0 57455.4 57853.7 57857.8 57932.8 57978.0 62321.7 62383.0 62438.0 62474.7 62531.0 15153.4 15351.7 15377.7 15384.0 15404.3 10820.0 10979.4 11006.0 11096.6 11766.2 16191.0 18254.3 18679.0 18722.4 18989.3 4910.9 6558.4 6722.6 7770.0 7852.7 844.4 879.2 906.4 950.9 1038.8 28762.0 29431.1 29596.1 29997.6 30028.2 946.8 1058.7 1103.4 1125.8 1172.7 15015.8 15254.0 15379.0 15410.0 15731.0 609919.0 619047.0 619437.9 619604.0 620964.0 55740.4 56108.4 56115.0 56140.0 56221.7 1181.0 1236.7 1270.9 1307.5 1326.2 29126.9 30661.4 31188.0 31278.5 31612.2 39396.4 47570.5 48070.8 48071.0 48140.5 458731.0 463433.0 463687.0 464436.0 465521.0 22524.4 25737.6 26721.0 27152.3 28145.4 45631.5 46386.5 46861.1 47124.8 47235.0 32069.0 37310.9 38544.2 39637.8 40135.8 37629.8 37812.8 37855.0 39358.7 39375.0 37213.0 37695.8 38094.0 38225.8 38272.4 30960.0 33774.3 33789.8 33839.3 33880.2 24631.9 25008.1 25362.4 25501.6 25631.9 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33963.88 Median:3063.76 stddev:99228.58 (3238.8%) stddev-sans-first:99474.85 18:17:39 INFO - PROCESS | 1652 | Values: 352.0 369.7 373.5 379.7 402.3 12449.0 16533.3 20046.0 20190.6 20280.8 16596.2 20738.9 21168.2 21429.2 21471.2 5144.6 5923.9 5935.8 6170.1 6172.9 6055.4 6152.5 6161.9 6163.0 6171.2 3470.9 3908.0 4120.6 5843.0 6137.4 5807.5 6136.7 6165.4 6169.7 6190.1 5900.3 6003.6 6008.1 6019.1 6036.8 13496.7 13501.8 13526.7 13532.3 13705.7 1903.8 2127.5 2151.3 2239.1 2656.7 7710.8 8352.3 9896.2 10136.1 10497.1 1863.1 1891.4 1906.7 1966.7 1987.7 104026.2 108716.8 127685.0 127731.0 134517.0 11293.4 11481.1 11545.2 11582.8 11589.4 12098.6 14555.0 14568.2 14571.6 14581.0 8103.1 8330.8 8354.5 8461.6 8501.0 6788.8 8158.2 8170.5 8172.4 8374.7 4427.8 4490.6 4517.8 4574.3 4597.0 1673.6 1816.8 1909.7 1920.5 1927.5 810.9 869.4 898.5 906.5 968.9 20417.4 21178.6 21258.0 21319.6 21360.1 708.5 805.0 833.5 890.6 903.1 10551.1 11070.9 11078.8 11260.4 11267.9 549875.0 572492.0 614740.0 618032.0 622799.0 70510.0 77664.0 109087.0 123028.0 141067.0 944.7 979.6 992.0 1012.2 1012.2 19356.6 19535.4 19563.5 19780.5 19789.9 56487.7 57245.1 57332.0 58383.0 58402.8 54214.7 75963.6 77853.6 78451.6 78603.0 6857.8 7556.6 8085.0 8198.8 8468.0 11969.8 12483.4 13189.6 13556.5 13778.4 11124.3 11415.4 11781.6 11831.5 11948.8 10889.5 11251.8 11496.4 11897.8 11930.5 10790.7 11470.5 11865.8 11877.4 12092.0 6985.0 7128.9 8121.6 8435.1 8472.4 9371.0 11641.6 11766.5 11780.5 11821.2 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5700.63 Median:5007.30 stddev:3173.79 (63.4%) stddev-sans-first:3167.09 18:17:39 INFO - PROCESS | 1652 | Values: 1513.1 1549.5 1715.2 1853.9 1864.8 8337.9 8914.2 8918.4 8920.1 8920.7 7778.7 7991.5 8486.3 8683.9 8707.3 2339.1 2381.8 2382.9 2384.9 2385.1 2360.4 2377.0 2402.3 2403.3 2406.1 1985.1 2157.2 2186.8 2341.9 2396.4 2347.6 2365.5 2373.3 2373.7 2380.8 2361.7 2368.3 2371.9 2380.0 2389.9 8709.4 8879.2 8885.0 8887.4 8888.7 5212.8 5243.1 5347.5 5365.9 5389.4 2947.4 3578.7 3713.0 3714.0 3725.9 1049.6 1090.8 1103.2 1124.5 1130.5 11608.0 11721.6 11731.1 11735.4 11754.7 4528.1 4591.7 4778.6 4778.8 4809.1 8291.8 9885.9 9897.6 9916.8 9921.3 5348.4 5354.1 5354.4 5357.8 5361.9 4400.9 4559.7 4573.7 4827.3 4919.3 3862.8 3886.9 3973.2 4021.6 4025.8 1283.4 1289.3 1290.7 1303.4 1306.2 833.2 857.3 904.0 908.8 934.1 5777.2 5806.6 6068.6 6076.5 6126.5 802.0 954.2 954.8 962.2 1011.0 3908.2 3978.4 4030.6 4121.7 4125.7 8830.7 10511.7 10925.0 10942.9 10989.0 10163.0 10634.0 10651.5 10839.8 10858.0 8016.9 8196.8 8241.8 8248.8 8266.3 5210.5 5909.2 5972.7 6125.7 6172.0 9012.9 9798.2 9973.8 10036.8 10168.2 10012.0 10078.5 10232.9 10437.1 10439.6 7016.8 7233.4 7430.9 7533.5 7691.5 8306.6 8544.4 8544.5 8547.2 8553.0 7366.7 7457.5 7459.7 7521.0 7629.4 6325.9 7233.0 7288.0 7292.4 7497.7 6939.2 7089.7 7091.4 7092.4 7097.6 4940.5 4994.5 5020.1 5021.5 5107.2 4876.9 4934.6 5033.8 5156.5 5210.9 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4146.96 Median:4511.55 stddev:1209.01 (26.8%) stddev-sans-first:1176.09 18:17:39 INFO - PROCESS | 1652 | Values: 228.6 301.9 309.2 313.9 315.2 4877.9 5511.8 5538.2 5572.6 5574.0 4114.0 4532.7 4892.5 5450.1 5451.5 3949.4 3988.3 4095.4 4146.3 4167.3 3820.5 3856.0 4172.1 4185.3 4201.3 4010.9 4082.4 4111.3 4159.9 4194.2 3584.6 4147.7 4155.5 4170.8 4180.9 3573.2 3594.6 3602.2 3623.4 3640.3 4631.4 4972.9 4993.6 5391.5 5400.1 4038.9 4498.3 4504.1 4512.4 4665.6 5155.9 5722.5 5728.9 5744.3 5772.9 3974.5 3987.9 4003.8 4004.8 4019.3 5134.8 5352.1 5467.5 5615.3 5975.4 3800.8 3929.9 3936.6 3945.9 3952.2 3967.4 4008.2 4008.9 4036.2 4036.5 4311.7 4523.0 4541.4 4611.7 4642.7 5041.5 5078.6 5238.3 5700.6 5800.8 1232.0 1352.9 1364.3 1366.7 1369.8 771.0 815.0 817.6 835.8 836.5 3727.0 4021.6 4395.1 4403.9 4424.9 3872.8 4281.6 4474.7 4815.4 4840.8 4358.4 4421.7 4452.8 4459.0 4541.8 2129.0 2183.8 2396.0 2420.4 2616.9 4171.7 4436.7 4510.7 4912.0 5024.6 4234.6 4557.0 4829.6 4949.0 5003.5 4551.4 4982.8 5010.8 5017.5 5018.6 4160.8 4654.3 4820.0 4927.9 4940.7 4353.2 4588.0 4649.9 4765.8 4922.4 4601.9 4635.3 4981.8 5021.5 5085.9 2930.9 3075.9 3200.5 3271.0 3382.7 4248.5 4345.6 4553.5 4577.0 4887.8 3916.4 4284.9 4727.9 4731.9 4747.6 4614.6 4652.7 4701.6 4702.7 4741.5 3874.9 4584.3 4593.7 4602.7 4607.4 3905.0 4158.0 4679.6 4685.6 4697.7 4307.7 4559.0 4559.5 4614.1 4629.5 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24503.03 Median:3456.58 stddev:38741.44 (1120.8%) stddev-sans-first:38808.93 18:17:39 INFO - PROCESS | 1652 | Values: 711.6 732.6 742.2 783.7 819.2 15170.5 15939.6 15966.0 15985.1 15991.0 15065.5 15218.3 15246.1 15249.7 15264.2 667.8 685.7 823.6 828.9 838.2 826.2 844.0 844.4 846.5 848.3 901.1 902.5 903.0 903.6 903.8 707.8 866.1 894.9 896.6 900.5 665.1 666.4 666.5 666.7 666.8 15101.0 15116.5 15177.2 15177.3 15205.9 12853.7 13900.4 14064.4 14360.7 14406.8 12991.4 13123.3 13276.1 13434.4 13849.3 3819.5 4672.3 4713.9 4799.5 4877.6 110526.0 112592.0 119290.4 120142.0 122264.0 11241.8 11384.3 11512.0 11567.8 11614.8 22444.8 22480.7 22505.7 22508.0 22588.5 7735.7 7993.2 8018.5 8095.6 8096.6 4290.4 4403.6 4415.1 4469.4 4599.0 3368.6 3428.4 3484.7 3488.8 3492.0 631.8 641.8 642.0 657.2 659.9 564.1 591.6 602.2 607.4 620.7 8337.6 9100.0 9113.1 9150.4 9211.2 574.3 587.4 601.6 634.5 641.4 4281.7 4425.0 4449.8 4457.4 4503.2 86482.0 87514.0 90346.6 147154.0 158466.0 127663.4 136504.0 138021.7 138773.0 144494.0 90867.2 109953.4 110369.0 111800.4 115921.6 7247.2 7470.8 8608.0 8746.0 8882.6 51352.0 63078.0 63734.0 65070.0 65977.7 94619.0 100610.0 101091.0 103416.0 103511.5 11596.7 11644.7 11666.4 11701.6 11719.6 12529.1 12876.2 13031.5 13321.0 13410.8 12275.5 12320.9 13295.2 14088.9 14339.1 11436.9 13280.3 14399.3 14590.3 14603.4 12507.6 14022.9 14081.6 14177.7 14557.5 11563.8 11622.5 11640.9 11764.8 12029.4 9497.9 10536.8 10555.9 10577.0 11237.0 18:17:39 INFO - PROCESS | 1652 | -------- Summary: end -------- 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - TEST-INFO | 1652: exit 0 18:17:39 INFO - TEST-OK | dromaeo_css | took 1118689ms 18:17:39 INFO - TEST-START | kraken 18:17:39 INFO - operating with platform_type : mac_ 18:17:39 INFO - Initialising browser for kraken test... 18:17:39 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpDvgu0c/profile http://localhost:49267/getInfo.html) 18:17:41 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 18:17:41 INFO - PROCESS | 1657 | colorDepth:24 18:17:41 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 18:17:41 INFO - PROCESS | 1657 | __metrics 18:17:42 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" 18:17:42 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] 18:17:42 INFO - TEST-INFO | 1657: exit 0 18:17:42 INFO - Browser initialized. 18:17:42 INFO - Running cycle 1/1 for kraken test... 18:17:42 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpDvgu0c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:54 INFO - PROCESS | 1658 | RSS: Main: 227360768 18:17:54 INFO - PROCESS | 1658 | 18:17:57 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) 18:17:58 INFO - PROCESS | 1658 | RSS: Main: 283807744 18:17:58 INFO - PROCESS | 1658 | 18:18:01 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) 18:18:01 INFO - PROCESS | 1658 | RSS: Main: 290435072 18:18:01 INFO - PROCESS | 1658 | 18:18:05 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) 18:18:05 INFO - PROCESS | 1658 | RSS: Main: 387588096 18:18:05 INFO - PROCESS | 1658 | 18:18:07 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) 18:18:08 INFO - PROCESS | 1658 | RSS: Main: 289292288 18:18:08 INFO - PROCESS | 1658 | 18:18:10 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) 18:18:11 INFO - PROCESS | 1658 | RSS: Main: 293621760 18:18:11 INFO - PROCESS | 1658 | 18:18:13 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) 18:18:14 INFO - PROCESS | 1658 | RSS: Main: 331210752 18:18:14 INFO - PROCESS | 1658 | 18:18:17 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) 18:18:18 INFO - PROCESS | 1658 | RSS: Main: 331350016 18:18:18 INFO - PROCESS | 1658 | 18:18:20 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) 18:18:21 INFO - PROCESS | 1658 | RSS: Main: 331517952 18:18:21 INFO - PROCESS | 1658 | 18:18:23 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) 18:18:23 INFO - PROCESS | 1658 | RSS: Main: 301875200 18:18:23 INFO - PROCESS | 1658 | 18:18:25 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) 18:18:26 INFO - PROCESS | 1658 | RSS: Main: 307154944 18:18:26 INFO - PROCESS | 1658 | 18:18:28 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) 18:18:29 INFO - PROCESS | 1658 | RSS: Main: 308060160 18:18:29 INFO - PROCESS | 1658 | 18:18:32 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) 18:18:32 INFO - PROCESS | 1658 | RSS: Main: 315129856 18:18:32 INFO - PROCESS | 1658 | 18:18:35 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) 18:18:36 INFO - PROCESS | 1658 | RSS: Main: 317513728 18:18:36 INFO - PROCESS | 1658 | 18:18:38 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) 18:18:38 INFO - PROCESS | 1658 | RSS: Main: 361205760 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | __start_tp_report 18:18:38 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 18:18:38 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 18:18:38 INFO - PROCESS | 1658 | |i|pagename|runs| 18:18:38 INFO - PROCESS | 1658 | |0;ai-astar;140;169;150;113;112;108;113;112;113;111 18:18:38 INFO - PROCESS | 1658 | |1;audio-beat-detection;144;108;107;165;108;107;128;106;141;108 18:18:38 INFO - PROCESS | 1658 | |2;audio-dft;182;183;184;185;183;183;237;246;184;182 18:18:38 INFO - PROCESS | 1658 | |3;audio-fft;80;58;64;88;60;58;63;69;85;58 18:18:38 INFO - PROCESS | 1658 | |4;audio-oscillator;86;70;103;69;77;68;96;69;68;99 18:18:38 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;91;88;92;89;90;87;91;88;90;87 18:18:38 INFO - PROCESS | 1658 | |6;imaging-darkroom;95;95;96;96;95;95;94;105;148;113 18:18:38 INFO - PROCESS | 1658 | |7;imaging-desaturate;85;86;84;83;83;83;86;85;86;86 18:18:38 INFO - PROCESS | 1658 | |8;json-parse-financial;54;53;55;54;54;54;55;54;55;53 18:18:38 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;68;74;67;73;74;71;71;71;72;72 18:18:38 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;89;89;87;87;84;88;87;84;83;89 18:18:38 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;152;151;151;136;138;141;138;153;228;143 18:18:38 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;174;177;175;173;172;173;173;175;174;173 18:18:38 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;68;68;70;66;67;69;68;68;67 18:18:38 INFO - PROCESS | 1658 | __end_tp_report 18:18:38 INFO - PROCESS | 1658 | __start_cc_report 18:18:38 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2006 18:18:38 INFO - PROCESS | 1658 | __end_cc_report 18:18:38 INFO - PROCESS | 1658 | __startTimestamp1471396718286__endTimestamp 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | ------- Summary: start ------- 18:18:38 INFO - PROCESS | 1658 | Number of tests: 14 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:124.10 Median:113.00 stddev:21.17 (18.7%) stddev-sans-first:21.66 18:18:38 INFO - PROCESS | 1658 | Values: 140.0 169.0 150.0 113.0 112.0 108.0 113.0 112.0 113.0 111.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:118.00 stddev:21.14 (17.9%) stddev-sans-first:20.90 18:18:38 INFO - PROCESS | 1658 | Values: 144.0 108.0 107.0 165.0 108.0 107.0 128.0 106.0 141.0 108.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:194.90 Median:184.00 stddev:24.67 (13.4%) stddev-sans-first:25.72 18:18:38 INFO - PROCESS | 1658 | Values: 182.0 183.0 184.0 185.0 183.0 183.0 237.0 246.0 184.0 182.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:68.30 Median:66.50 stddev:11.73 (17.6%) stddev-sans-first:11.65 18:18:38 INFO - PROCESS | 1658 | Values: 80.0 58.0 64.0 88.0 60.0 58.0 63.0 69.0 85.0 58.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:73.50 stddev:14.21 (19.3%) stddev-sans-first:14.94 18:18:38 INFO - PROCESS | 1658 | Values: 86.0 70.0 103.0 69.0 77.0 68.0 96.0 69.0 68.0 99.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:90.00 stddev:1.77 (2.0%) stddev-sans-first:1.76 18:18:38 INFO - PROCESS | 1658 | Values: 91.0 88.0 92.0 89.0 90.0 87.0 91.0 88.0 90.0 87.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:95.00 stddev:16.88 (17.8%) stddev-sans-first:17.64 18:18:38 INFO - PROCESS | 1658 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 94.0 105.0 148.0 113.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.34 (1.6%) stddev-sans-first:1.41 18:18:38 INFO - PROCESS | 1658 | Values: 85.0 86.0 84.0 83.0 83.0 83.0 86.0 85.0 86.0 86.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 18:18:38 INFO - PROCESS | 1658 | Values: 54.0 53.0 55.0 54.0 54.0 54.0 55.0 54.0 55.0 53.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:2.31 (3.2%) stddev-sans-first:2.12 18:18:38 INFO - PROCESS | 1658 | Values: 68.0 74.0 67.0 73.0 74.0 71.0 71.0 71.0 72.0 72.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:2.26 (2.6%) stddev-sans-first:2.24 18:18:38 INFO - PROCESS | 1658 | Values: 89.0 89.0 87.0 87.0 84.0 88.0 87.0 84.0 83.0 89.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:153.10 Median:151.00 stddev:27.11 (18.0%) stddev-sans-first:28.76 18:18:38 INFO - PROCESS | 1658 | Values: 152.0 151.0 151.0 136.0 138.0 141.0 138.0 153.0 228.0 143.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:1.45 (0.8%) stddev-sans-first:1.54 18:18:38 INFO - PROCESS | 1658 | Values: 174.0 177.0 175.0 173.0 172.0 173.0 173.0 175.0 174.0 173.0 18:18:38 INFO - PROCESS | 1658 | 18:18:38 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 18:18:38 INFO - PROCESS | 1658 | Values: 68.0 68.0 68.0 70.0 66.0 67.0 69.0 68.0 68.0 67.0 18:18:38 INFO - PROCESS | 1658 | -------- Summary: end -------- 18:18:38 INFO - PROCESS | 1658 | 18:18:39 INFO - TEST-INFO | 1658: exit 0 18:18:39 INFO - TEST-OK | kraken | took 59340ms 18:18:39 INFO - SUITE-END | took 1178s 18:18:39 INFO - Completed test suite (00:19:38) 18:18:39 INFO - javascript benchmark 18:18:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.4299169141245, 3405.67646073623, 3433.2446861690437, 3446.8621255149797, 3488.91277718057, 5691.772329106841, 5785.305763308404, 5838.532917366606, 5896.498797602204, 5927.466528012478, 5888.41115888411, 5898.734556944937, 5903.380145084758, 5931.911021334683, 5933.732982015809, 5256.684598924067, 5285.0, 5334.91997620036, 5351.384590772052, 5398.352197736277, 5362.865928351803, 5402.810901618444, 5406.567474602022, 5409.0, 5409.891802163955, 5288.180332048539, 5325.7603407846545, 5333.2000199970125, 5340.813071542497, 5397.595180361489, 4476.55234476553, 5404.378496472897, 5424.891502169974, 5432.565394768449, 5461.2354270402175, 5162.586993040548, 5229.2417599448245, 5291.497307755757, 5323.494268044568, 5328.440513746078, 5836.124581312794, 5863.0, 5881.647101173943, 5911.586188966774, 5945.227120474354, 5246.265522826808, 6219.87560248797, 6234.220722409699, 6240.469560087398, 6241.21984751906, 6124.258880972529, 6160.9383906161265, 6263.34234905333, 6280.497560195174, 6313.431791138773, 6035.155078289043, 6042.879142417127, 6052.455279024909, 6052.939470605325, 6054.455099041107, 5410.3778065522965, 6393.6483493408305, 6417.0, 6422.197225346832, 6440.549161558646, 6094.8943112006145, 6131.774283661862, 6162.383761623802, 6191.659458729723, 6260.154879091265, 6251.187345645037, 6273.811785646438, 6280.623162610258, 6280.937190628127, 6292.370762923762, 5185.896282074337, 6218.061751027758, 6235.095911092957, 6239.344868788802, 6267.310595834455, 6181.505479561624, 6188.845278868064, 6233.407826256498, 6249.031400132896, 6258.249010118815, 4969.105560998983, 4982.0, 4988.700677959261, 4995.825146119869, 5020.548150666457, 3946.9013274668364, 4338.305871060616, 4435.667324950641, 4450.332450132441, 4490.079533695584, 5716.942830571641, 5794.855128621818, 5809.331926828469, 5818.44724751148, 5889.793857214977, 6162.445379915829, 6216.036514340284, 6229.968850155811, 6275.529335299871, 6282.151909492251, 5893.410658934073, 5895.115732640053, 5898.528117750569, 5898.793542226002, 5959.165716799652, 5409.107497262986, 5433.185022246695, 5512.448755124536, 5519.448055194529, 5537.750801213955, 5172.922406163835, 6372.330905254881, 6398.8720225595225, 6489.1888513935755, 6502.707378167899, 6204.0, 6266.811995640138, 6274.874502510015, 6286.9371306288185, 6289.779857704958, 6499.740010399721, 6502.544821862424, 6508.0, 6511.544191906521, 6522.15212022434, 6142.539309551712, 6155.569110162425, 6163.291221509584, 6180.876382472416, 6220.626762394271, 6081.878362432815, 6250.937490625218, 6264.091706702594, 6270.623762574261, 6281.0, 6237.1891654084675, 6238.906416403848, 6244.781432650017, 6255.24937007562, 6257.624542527463, 6032.4570788629235, 6124.319907527303, 6169.56813023084, 6171.47542458896, 6253.280872699515, 5069.923951140662, 6066.240790170801, 6115.266168059861, 6118.908216376847, 6120.693965301806, 6084.8783024340155, 6219.191505104489, 6255.96872015637, 6257.9687101564205, 6258.155149054819, 6029.035354343284, 6036.33600303975, 6091.208142941389, 6103.176071230327, 6105.328413874381], "value": 5764.018069527768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.83533845484845, 479.25954400451275, 481.4054642516494, 510.720644784814, 541.8242413961702, 26552.336191595197, 39649.60350396495, 40382.394264086026, 40417.393739093866, 40438.19123617526, 34098.48852267218, 41425.96435089117, 41830.163396732045, 41839.58160418395, 42034.57965420345, 8875.378723489359, 9690.806183876319, 9870.901290987105, 9876.802463950717, 9895.356801807895, 8826.249768769661, 11757.647270581854, 11973.341466219354, 12008.339541325224, 12285.262884226975, 12042.939785301061, 12105.818412723816, 12116.0, 12132.968697660664, 12164.087693422984, 12034.879651203508, 12128.939355303255, 12133.878661213363, 12135.029197664166, 12139.332336721476, 11782.941085294518, 11864.288142711379, 11934.16460847741, 11936.522539098425, 11943.761124777457, 39435.40846887299, 39620.40569391462, 39653.40519892204, 39672.61145859881, 39720.404193937116, 3298.4062868683627, 3348.916277093092, 3362.2771104212466, 3786.280606684721, 4232.238197124517, 31266.21834454134, 32013.83993080043, 32200.516992245135, 32504.0, 32547.51178732321, 3139.0, 3248.870045198189, 3273.623533293678, 3287.539744435781, 3344.7324214062814, 479258.0, 479734.0, 481763.0, 483659.5817020928, 487332.0, 57455.425445745845, 57853.71073144607, 57857.8428431429, 57932.8413431729, 57978.0, 62321.68839155775, 62383.0, 62438.0, 62474.68762656249, 62531.0, 15153.393864245527, 15351.692966140614, 15377.692446151013, 15384.0, 15404.306806193748, 10819.972102650236, 10979.396133212591, 11006.0, 11096.5561377544, 11766.176367654352, 16191.0, 18254.269829206947, 18679.0, 18722.438326850217, 18989.33537326187, 4910.8859469960125, 6558.376954189344, 6722.563033402813, 7769.961150194213, 7852.725154619675, 844.4004756622744, 879.2174964281794, 906.4153620914605, 950.9144177024101, 1038.7558923652934, 28762.0, 29431.11706648804, 29596.112116636534, 29997.550036749468, 30028.24929376783, 946.7538440005649, 1058.6559368205365, 1103.4096758234307, 1125.8142406503, 1172.7419967607113, 15015.849841501664, 15254.0, 15379.0, 15410.0, 15731.0, 609919.0, 619047.0, 619437.9309138041, 619604.0, 620964.0, 55740.442595574335, 56108.438915611136, 56115.0, 56140.0, 56221.71889140528, 1181.0, 1236.746466974286, 1270.9237445753283, 1307.4900788692419, 1326.2042774335514, 29126.854365728035, 30661.386772264876, 31188.0, 31278.53082203723, 31612.209694757814, 39396.40905386479, 47570.52429475661, 48070.79823004313, 48071.0, 48140.518594813606, 458731.0, 463433.0, 463687.0, 464436.0, 465521.0, 22524.436889077904, 25737.613935791353, 26721.0, 27152.321191970357, 28145.43709125847, 45631.54368456273, 46386.53613463822, 46861.06277874492, 47124.76437617927, 47235.0, 32069.0, 37310.880673579835, 38544.22911541809, 39637.801810991914, 40135.79932100321, 37629.81185094167, 37812.81093594514, 37855.0, 39358.6545143666, 39375.0, 37213.0, 37695.811520943316, 38094.0, 38225.808870955465, 38272.42591361188, 30960.0, 33774.32451351008, 33789.83105084459, 33839.32321353608, 33880.15299617529, 24631.87684061568, 25008.124715634865, 25362.365940851625, 25501.56926621915, 25631.871840640677], "value": 19898.61226411584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.0371783173023, 369.67837980956557, 373.48832100022975, 379.70383101181073, 402.27590337392706, 12449.0, 16533.338666453343, 20046.0, 20190.59618807623, 20280.797192028076, 16596.170191490437, 20738.89630551849, 21168.153273869066, 21429.249976250834, 21471.248506302283, 5144.61415393847, 5923.911141332873, 5935.783164451299, 6170.105334726462, 6172.938270617304, 6055.364186760393, 6152.47703945163, 6161.938380616204, 6163.044728067157, 6171.228596425447, 3470.861165553375, 3907.960920390802, 4120.649744771683, 5842.970785146068, 6137.355577664325, 5807.506361959238, 6136.693165341715, 6165.445109940082, 6169.722362493699, 6190.102435146923, 5900.291964964232, 6003.579749417542, 6008.068749343815, 6019.097135429721, 6036.788712395089, 13496.662583435394, 13501.797473037912, 13526.729465410735, 13532.255725935069, 13705.725885482334, 1903.7636018768148, 2127.489402543394, 2151.279321427324, 2239.1379318962154, 2656.6546348974703, 7710.768676939645, 8352.331813454908, 9896.208303335716, 10136.087752102272, 10497.055265026183, 1863.0963982468493, 1891.4136617648574, 1906.7235250888682, 1966.6558352288434, 1987.6620974434381, 104026.16308054372, 108716.82566348708, 127684.99999999907, 127731.0, 134517.0, 11293.37886416255, 11481.138914581274, 11545.249558778652, 11582.768344633228, 11589.377487151805, 12098.63704088861, 14554.981151319518, 14568.198749068692, 14571.635709107357, 14580.979331446697, 8103.0681471631515, 8330.791730206793, 8354.456960297683, 8461.646136618234, 8500.957495212484, 6788.76239331621, 8158.224968627971, 8170.509769413854, 8172.387070969701, 8374.665013399517, 4427.822887084545, 4490.550944905483, 4517.774111294422, 4574.268117101248, 4597.011642496879, 1673.6150685342195, 1816.8364847163555, 1909.675355189621, 1920.5486710622993, 1927.5373910261437, 810.8743144812563, 869.4480352570757, 898.481566153199, 906.496894223699, 968.9273304502191, 20417.387478375673, 21178.576428471653, 21258.0, 21319.573608527742, 21360.145594176058, 708.4721882197692, 804.9557274349967, 833.4957350802798, 890.6214858685033, 903.0969030969031, 10551.103156231806, 11070.889291107147, 11078.778424431466, 11260.38067906273, 11267.887321126684, 549875.0, 572492.0, 614740.0, 618032.0, 622799.0, 70510.0, 77664.0, 109087.0, 123028.0, 141067.0, 944.6504793226413, 979.588572799426, 992.007992007992, 1012.1599072769584, 1012.1801340913736, 19356.612867742286, 19535.413937581896, 19563.51091222731, 19780.50548736293, 19789.90105049523, 56487.71756141193, 57245.14132288102, 57332.0, 58383.0, 58402.83194336174, 54214.728926355114, 75963.62018189873, 77853.61073194598, 78451.60774196092, 78603.0, 6857.828554286183, 7556.584387858501, 8084.959575202086, 8198.795030124294, 8468.0, 11969.760604788029, 12483.375831208585, 13189.604311870658, 13556.525521606696, 13778.448862045807, 11124.332540047622, 11415.429228538706, 11781.646550603497, 11831.526738930346, 11948.76102477963, 10889.455527223765, 11251.831222531504, 11496.425178740863, 11897.821532676844, 11930.522779088738, 10790.651168603925, 11470.483828227583, 11865.822012669989, 11877.406129693654, 12092.0, 6984.965075174795, 7128.928710713034, 8121.593920303843, 8435.072142064246, 8472.406931514735, 9371.0, 11641.59254426091, 11766.470508826953, 11780.52877884875, 11821.172517924007], "value": 9247.437538903638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.061901620995, 1549.5428848489696, 1715.1681434504262, 1853.907304634768, 1864.776226852777, 8337.916620833797, 8914.153155450222, 8918.42030268033, 8920.107989201077, 8920.732378028653, 7778.727744528943, 7991.520508769478, 8486.321094312456, 8683.869741953877, 8707.303415726743, 2339.134520227514, 2381.833271670975, 2382.892769825362, 2384.8926798294033, 2385.105585405473, 2360.3862995621175, 2377.0135393811547, 2402.267308470916, 2403.3390817525146, 2406.1217655555683, 1985.0670185013093, 2157.2018353209255, 2186.7813218678166, 2341.882905854709, 2396.400899775056, 2347.5539647466926, 2365.467769751809, 2373.311739595515, 2373.7032870891226, 2380.8214383921277, 2361.728401233846, 2368.27767530903, 2371.8814059296965, 2380.0479808076734, 2389.8685572293516, 8709.390342676015, 8879.245264152554, 8884.955575222148, 8887.35583916971, 8888.688895888612, 5212.765425555859, 5243.082460569385, 5347.518723314882, 5365.919511207335, 5389.353277606712, 2947.3957838643028, 3578.7494875358734, 3712.962870371289, 3713.9814300928592, 3725.8695945642044, 1049.5906596427399, 1090.820014697574, 1103.2442776697987, 1124.5333186727498, 1130.4517309105076, 11607.955284024394, 11721.589744358907, 11731.120165987584, 11735.4132293385, 11754.706132346675, 4528.117017181618, 4591.724496530219, 4778.617710583215, 4778.832740854054, 4809.062232864558, 8291.83416331682, 9885.851712224323, 9897.554610042565, 9916.801663966824, 9921.255905807093, 5348.358197016383, 5354.143337066051, 5354.41101478837, 5357.785688572491, 5361.946380536145, 4400.867973960786, 4559.749213793207, 4573.748443835554, 4827.324174615556, 4919.2867034279825, 3862.787546684903, 3886.902827429337, 3973.2450834341385, 4021.597840215955, 4025.75845449274, 1283.3573026526062, 1289.3166621690518, 1290.6837824733, 1303.3939218263363, 1306.2227974355244, 833.2375876073326, 857.2713193785232, 903.9954800225956, 908.8046070094962, 934.1359242700611, 5777.19119323295, 5806.622569532967, 6068.575199735976, 6076.513878889678, 6126.509879209652, 801.9558924259105, 954.2461455450256, 954.8424509955919, 962.2302158273353, 1011.0092109732503, 3908.179282350738, 3978.403239514096, 4030.5892937472236, 4121.690873184523, 4125.690573207022, 8830.690925817566, 10511.737206569896, 10925.0, 10942.945285273523, 10989.0, 10163.034511721375, 10634.042936135631, 10651.467426628638, 10839.783204335869, 10858.022777949864, 8016.879746803803, 8196.754097377088, 8241.79395515105, 8248.83502329962, 8266.256036956582, 5210.53105220532, 5909.172715819703, 5972.70136493165, 6125.663088529996, 6171.950768369298, 9012.909870901207, 9798.216142708709, 9973.750656233362, 10036.799264014824, 10168.186545076229, 10012.04885535873, 10078.546465409221, 10232.948835255776, 10437.060664540228, 10439.634612788515, 7016.824579385556, 7233.421326293989, 7430.888536671846, 7533.547987120571, 7691.50005249657, 8306.584670766559, 8544.444611100258, 8544.487330760174, 8547.188017138362, 8553.0, 7366.7053317866685, 7457.47797654159, 7459.664315105942, 7520.962395188208, 7629.389648828192, 6325.905111423241, 7233.0, 7287.979682844512, 7292.380147687506, 7497.662605182671, 6939.236683964861, 7089.695848849248, 7091.43268538526, 7092.361687448154, 7097.609631470112, 4940.505949405031, 4994.450610432777, 5020.146575082172, 5021.472745361684, 5107.182850744011, 4876.905274918152, 4934.568974997211, 5033.823816166417, 5156.484351564814, 5210.869728256824], "value": 4595.261860235782, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [228.62733743997282, 301.92753739102614, 309.19917413897997, 313.92151962009495, 315.24656071987937, 4877.926831097532, 5511.807086751965, 5538.196961440589, 5572.606848287928, 5573.972130139344, 4114.0, 4532.650956121559, 4892.535209155125, 5450.127979523277, 5451.454854514546, 3949.3878448840474, 3988.262171498282, 4095.4471146395304, 4146.253674338618, 4167.291560434734, 3820.522434695663, 3855.961440385602, 4172.100390228792, 4185.309423945046, 4201.264778663737, 4010.939835902464, 4082.4284600156, 4111.321631930728, 4159.854405095823, 4194.203101410738, 3584.6415358463946, 4147.668186545069, 4155.501339839208, 4170.833166673329, 4180.874573762792, 3573.1781690211396, 3594.5866225383893, 3602.1808986461933, 3623.365910965597, 3640.3265395901576, 4631.444226692818, 4972.900541989176, 4993.601791498386, 5391.541718953894, 5400.108982017962, 4038.9394159087637, 4498.280275155992, 4504.144212599595, 4512.420652771537, 4665.576999015299, 5155.948440515622, 5722.54219662426, 5728.882867840773, 5744.339400968858, 5772.8845423091725, 3974.463447434588, 3987.8803635890968, 4003.799810009488, 4004.759714417115, 4019.33680942647, 5134.843365786379, 5352.143657014898, 5467.507924286833, 5615.298087739033, 5975.372585878507, 3800.7719536827326, 3929.8821035368983, 3936.626020528045, 3945.8754255037175, 3952.1700442906736, 3967.444557761916, 4008.196311659765, 4008.899777505586, 4036.1927614476635, 4036.455078564415, 4311.655067594647, 4522.977385113119, 4541.409616749801, 4611.700239484489, 4642.651801114863, 5041.504455294653, 5078.619103567247, 5238.3190185276435, 5700.600957932905, 5800.8259752207505, 1232.0451649971164, 1352.9255890925897, 1364.324659293656, 1366.6856622976572, 1369.7876829091506, 770.98230335956, 815.0260438775724, 817.5952903312898, 835.7659855240543, 836.5148214035845, 3726.950177402472, 4021.552241193168, 4395.055063161436, 4403.933940990888, 4424.889377765581, 3872.760716570727, 4281.550437204111, 4474.664400170001, 4815.422149342101, 4840.830570930071, 4358.411614432011, 4421.7346959181905, 4452.821887124479, 4458.9554104459185, 4541.84103556374, 2128.978710212909, 2183.7707040760492, 2396.0232807933526, 2420.4070002849417, 2616.921492355232, 4171.687123465692, 4436.6672499562665, 4510.684252102387, 4912.017596480719, 5024.57291130258, 4234.640055595309, 4557.0, 4829.6291855870495, 4948.950510494921, 5003.549680528697, 4551.418891130212, 4982.75086245679, 5010.774515146754, 5017.54842064216, 5018.594793457838, 4160.791960402028, 4654.299831633927, 4820.0, 4927.8605970984545, 4940.7035577865445, 4353.151135528541, 4587.954120458886, 4649.930251046305, 4765.76171191446, 4922.4339200992345, 4601.8955450692265, 4635.284944570396, 4981.750912454435, 5021.543752311934, 5085.8728531787, 2930.8534573271677, 3075.8923437679573, 3200.535922291208, 3270.9836450817593, 3382.678645528671, 4248.511421186603, 4345.565443455629, 4553.453585569753, 4576.9861261045035, 4887.780049897834, 3916.395596928011, 4284.935725964176, 4727.881802954954, 4731.881702957454, 4747.620190384692, 4614.584687378152, 4652.744099074584, 4701.576858082789, 4702.717836929795, 4741.5495527924795, 3874.9418758719207, 4584.312353147055, 4593.678442508993, 4602.677812553089, 4607.447106347126, 3905.0, 4158.0, 4679.602233810164, 4685.601723853374, 4697.6711630185555, 4307.741535507879, 4558.994042621236, 4559.452865656142, 4614.10025045113, 4629.490756016903], "value": 3765.455007269251, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6015031582315, 732.6226993098555, 742.2169611060333, 783.6865253898442, 819.2381085590398, 15170.469033583826, 15939.601509962256, 15966.0, 15985.120818355, 15991.040537567755, 15065.472708455207, 15218.315175817088, 15246.085234885915, 15249.695006099872, 15264.16047117408, 667.8430568816324, 685.7497013590054, 823.5593957232882, 828.883956246126, 838.2330167896367, 826.2481142160635, 843.9535825529593, 844.4131328726537, 846.5344060766585, 848.3001523742937, 901.0808974845653, 902.5351943748974, 903.0382642485764, 903.5527413930114, 903.8282726282018, 707.7699747582005, 866.1295398124907, 894.9149830766066, 896.5651658945407, 900.4732231644463, 665.1087542692767, 666.4468491152332, 666.4535081233342, 666.7333066773281, 666.8266250774833, 15101.018433801768, 15116.470923517734, 15177.16525591092, 15177.317020734094, 15205.923970380078, 12853.742925141538, 13900.374483148182, 14064.367103480368, 14360.712785744226, 14406.78389824143, 12991.415386307639, 13123.278219697913, 13276.137051091744, 13434.395452204673, 13849.307534623329, 3819.5034645496185, 4672.299155126724, 4713.905721885578, 4799.544043315879, 4877.585405240558, 110526.0, 112592.0, 119290.40354798171, 120142.0, 122264.0, 11241.759934029802, 11384.316940983568, 11512.021478174449, 11567.76864462723, 11614.825777613343, 22444.775552244268, 22480.662790058162, 22505.662415063787, 22508.0, 22588.548229035656, 7735.690572377154, 7993.200679931961, 8018.4787988780545, 8095.595220238964, 8096.635651395702, 4290.356446533045, 4403.581659742319, 4415.116976604628, 4469.396631454712, 4599.0, 3368.6294507604143, 3428.4171690812623, 3484.738644601665, 3488.755787094879, 3491.982540087334, 631.8199313195718, 641.7561326695919, 641.9967900160469, 657.2310396835713, 659.947204223661, 564.0861803877744, 591.5770224289654, 602.2471910112359, 607.4350853706007, 620.7392894984117, 8337.583120844054, 9099.954500227457, 9113.088691130833, 9150.40522366044, 9211.170994610517, 574.2506029631288, 587.4477990688739, 601.6239850093691, 634.4835842336819, 641.4323323858418, 4281.678874084456, 4424.98476961255, 4449.755263460476, 4457.353683715843, 4503.166914120898, 86482.0, 87514.0, 90346.64480032805, 147154.0, 158466.0, 127663.36168319099, 136504.0, 138021.7186968785, 138773.0, 144494.0, 90867.18265634782, 109953.35069973797, 110369.0, 111800.44099779449, 115921.61175823693, 7247.231960015414, 7470.775876723707, 8607.95696021541, 8745.956270218609, 8882.60028298741, 51352.0, 63078.0, 63734.043989341124, 65070.0, 65977.67011164913, 94618.95738862274, 100610.0, 101091.0, 103416.0, 103511.48244258731, 11596.652100437, 11644.6506604802, 11666.358350290815, 11701.648950531498, 11719.648410547697, 12529.060320476183, 12876.163049401759, 13031.543895963596, 13321.0, 13410.798838017632, 12275.508979640714, 12320.876791232331, 13295.232812670423, 14088.929555352568, 14339.067960582528, 11436.94281528587, 13280.269585172908, 14399.280035997948, 14590.270486475845, 14603.43352762133, 12507.624771256877, 14022.8781697466, 14081.577552673027, 14177.716445670823, 14557.490487833298, 11563.768724625628, 11622.535098595961, 11640.94179529097, 11764.823527647264, 12029.398530073637, 9497.905020949702, 10536.79015034861, 10555.886013625844, 10577.0, 11237.04485118774], "value": 7761.7673626399455, "unit": "score"}], "name": "dromaeo_css", "value": 7226.886024771618, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 169.0, 150.0, 113.0, 112.0, 108.0, 113.0, 112.0, 113.0, 111.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 107.0, 165.0, 108.0, 107.0, 128.0, 106.0, 141.0, 108.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 184.0, 185.0, 183.0, 183.0, 237.0, 246.0, 184.0, 182.0], "value": 194.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 64.0, 88.0, 60.0, 58.0, 63.0, 69.0, 85.0, 58.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 103.0, 69.0, 77.0, 68.0, 96.0, 69.0, 68.0, 99.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 92.0, 89.0, 90.0, 87.0, 91.0, 88.0, 90.0, 87.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 94.0, 105.0, 148.0, 113.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 83.0, 83.0, 83.0, 86.0, 85.0, 86.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 67.0, 73.0, 74.0, 71.0, 71.0, 71.0, 72.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 87.0, 87.0, 84.0, 88.0, 87.0, 84.0, 83.0, 89.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 136.0, 138.0, 141.0, 138.0, 153.0, 228.0, 143.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 175.0, 173.0, 172.0, 173.0, 173.0, 175.0, 174.0, 173.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 70.0, 66.0, 67.0, 69.0, 68.0, 68.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1474.2, "alertThreshold": 2.0}]} 18:18:39 INFO - Return code: 0 18:18:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:18:39 INFO - # TBPL SUCCESS # 18:18:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:18:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:18:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:18:39 INFO - 2016-08-16 18:18:39.633 screenresolution[1662:10407] starting screenresolution argv=screenresolution get 18:18:39 INFO - 2016-08-16 18:18:39.636 screenresolution[1662:10407] Display 0: 1600x1200x32@60 18:18:39 INFO - 2016-08-16 18:18:39.642 screenresolution[1663:10410] starting screenresolution argv=screenresolution list 18:18:39 INFO - Available Modes on Display 0 18:18:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:18:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:18:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:18:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:18:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:18:39 INFO - Intel Iris: 18:18:39 INFO - Chipset Model: Intel Iris 18:18:39 INFO - Type: GPU 18:18:39 INFO - Bus: Built-In 18:18:39 INFO - VRAM (Dynamic, Max): 1536 MB 18:18:39 INFO - Vendor: Intel (0x8086) 18:18:39 INFO - Device ID: 0x0a2e 18:18:39 INFO - Revision ID: 0x0009 18:18:39 INFO - Displays: 18:18:39 INFO - Display: 18:18:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:18:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:18:39 INFO - Display Serial Number: 1600x1200 60 18:18:39 INFO - Main Display: Yes 18:18:39 INFO - Mirror: Off 18:18:39 INFO - Online: Yes 18:18:39 INFO - Rotation: Supported 18:18:39 INFO - Return code: 0 18:18:39 INFO - Running post-action listener: _resource_record_post_action 18:18:39 INFO - [mozharness: 2016-08-17 01:18:39.876032Z] Finished run-tests step (success) 18:18:39 INFO - Running post-run listener: _resource_record_post_run 18:18:39 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 31783936; Write bytes: 704580608; Read time: 193; Write time: 1986 18:18:39 INFO - TinderboxPrint: CPU usage
53.7% 18:18:39 INFO - TinderboxPrint: I/O read bytes / time
31,783,936 / 193 18:18:39 INFO - TinderboxPrint: I/O write bytes / time
704,580,608 / 1,986 18:18:39 INFO - TinderboxPrint: CPU idle
2,248.7 (46.3%) 18:18:39 INFO - TinderboxPrint: CPU system
973.1 (20.0%) 18:18:39 INFO - TinderboxPrint: CPU user
1,636.0 (33.7%) 18:18:39 INFO - TinderboxPrint: Swap in / out
432,394,240 / 0 18:18:39 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 402518528; Write bytes: 397506560; Read time: 30566; Write time: 838 18:18:39 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29694976; Write bytes: 295175168; Read time: 173; Write time: 1112 18:18:40 INFO - Running post-run listener: _upload_blobber_files 18:18:40 INFO - Blob upload gear active. 18:18:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:18:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:18:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:18:40 INFO - (blobuploader) - INFO - Open directory for files ... 18:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:41 INFO - (blobuploader) - INFO - Done attempting. 18:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:43 INFO - (blobuploader) - INFO - Done attempting. 18:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:46 INFO - (blobuploader) - INFO - Done attempting. 18:18:46 INFO - (blobuploader) - INFO - Iteration through files over. 18:18:46 INFO - Return code: 0 18:18:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:18:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:18:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18e4fb51e309b8664cf43840579e75bc7baf77912fafa01190dae74ce1e963893c4c21bf26747cf96defa864fed8516a679a257e6b3fec515a46960bde93bde5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9436c730c7dbdd41a9ff2d11ea8c234753ac6b1ed5802e406d15b8a6903ee550784436259a2eb43f150c9f97178e70ac41bc8ae4284231c85502401cd523d53c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33f61f8581259048ca8d98df160dae9f0846bfc3b0f0a0652ca0f6146835fb648bc89862445478c2d7b99b7c94280ce86d6a78dd3bf729b5f192581f6e4b9bbb"} 18:18:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:18:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:18:46 INFO - Contents: 18:18:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18e4fb51e309b8664cf43840579e75bc7baf77912fafa01190dae74ce1e963893c4c21bf26747cf96defa864fed8516a679a257e6b3fec515a46960bde93bde5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9436c730c7dbdd41a9ff2d11ea8c234753ac6b1ed5802e406d15b8a6903ee550784436259a2eb43f150c9f97178e70ac41bc8ae4284231c85502401cd523d53c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33f61f8581259048ca8d98df160dae9f0846bfc3b0f0a0652ca0f6146835fb648bc89862445478c2d7b99b7c94280ce86d6a78dd3bf729b5f192581f6e4b9bbb"} 18:18:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:18:46 INFO - Copying logs to upload dir... 18:18:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:18:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.575585 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-08-16 18:18:46.389876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 18:18:46.392983) ========= 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.EkleUCRBlA/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.MfZCoUbYmq/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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/18e4fb51e309b8664cf43840579e75bc7baf77912fafa01190dae74ce1e963893c4c21bf26747cf96defa864fed8516a679a257e6b3fec515a46960bde93bde5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9436c730c7dbdd41a9ff2d11ea8c234753ac6b1ed5802e406d15b8a6903ee550784436259a2eb43f150c9f97178e70ac41bc8ae4284231c85502401cd523d53c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33f61f8581259048ca8d98df160dae9f0846bfc3b0f0a0652ca0f6146835fb648bc89862445478c2d7b99b7c94280ce86d6a78dd3bf729b5f192581f6e4b9bbb"} build_url:https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/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/18e4fb51e309b8664cf43840579e75bc7baf77912fafa01190dae74ce1e963893c4c21bf26747cf96defa864fed8516a679a257e6b3fec515a46960bde93bde5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9436c730c7dbdd41a9ff2d11ea8c234753ac6b1ed5802e406d15b8a6903ee550784436259a2eb43f150c9f97178e70ac41bc8ae4284231c85502401cd523d53c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/33f61f8581259048ca8d98df160dae9f0846bfc3b0f0a0652ca0f6146835fb648bc89862445478c2d7b99b7c94280ce86d6a78dd3bf729b5f192581f6e4b9bbb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 18:18:46.425620) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 18:18:46.425922) ========= 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.EkleUCRBlA/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.MfZCoUbYmq/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.005289 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 18:18:46.474250) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 18:18:46.474566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 18:18:46.474893) ========= ========= Total master_lag: 0.53 =========