builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0235 starttime: 1472246257.71 results: success (0) buildid: 20160826130713 builduid: 7c87127ad6cb4ee98e8f56e3c44a311a revision: f1c8f78cd6f6e49a5f67b37567888473b898cb90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:37.706560) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:37.707041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:37.707332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:37.854056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:37.854424) ========= 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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-26 14:17:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2016-08-26 14:17:38 (19.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.559596 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:38.487922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:38.488263) ========= 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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.024416 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:38.579361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-26 14:17:38.579730) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1c8f78cd6f6e49a5f67b37567888473b898cb90 --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 f1c8f78cd6f6e49a5f67b37567888473b898cb90 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SjciwRs4Xk/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.TWHNE16Zc3/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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-26 14:17:38,672 truncating revision to first 12 chars 2016-08-26 14:17:38,673 Setting DEBUG logging. 2016-08-26 14:17:38,673 attempt 1/10 2016-08-26 14:17:38,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1c8f78cd6f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 14:17:40,378 unpacking tar archive at: fx-team-f1c8f78cd6f6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.961726 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-26 14:17:40.606467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:40.606755) ========= script_repo_revision: f1c8f78cd6f6e49a5f67b37567888473b898cb90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:40.607168) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:40.607951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 14:17:40.626917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-26 14:17:40.627206) ========= /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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:17:40 INFO - MultiFileLogger online at 20160826 14:17:40 in /builds/slave/test 14:17:40 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 14:17:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:40 INFO - {'append_to_log': False, 14:17:40 INFO - 'base_work_dir': '/builds/slave/test', 14:17:40 INFO - 'blob_upload_branch': 'Fx-Team', 14:17:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:40 INFO - 'branch': 'Fx-Team', 14:17:40 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:40 INFO - 'config_files': ('talos/mac_config.py',), 14:17:40 INFO - 'default_actions': ('clobber', 14:17:40 INFO - 'read-buildbot-config', 14:17:40 INFO - 'download-and-extract', 14:17:40 INFO - 'populate-webroot', 14:17:40 INFO - 'create-virtualenv', 14:17:40 INFO - 'install', 14:17:40 INFO - 'run-tests'), 14:17:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:40 INFO - 'download_minidump_stackwalk': True, 14:17:40 INFO - 'download_symbols': 'ondemand', 14:17:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:40 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:40 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:40 INFO - 'installer_path': 'installer.exe', 14:17:40 INFO - 'log_level': 'info', 14:17:40 INFO - 'log_name': 'talos', 14:17:40 INFO - 'log_to_console': True, 14:17:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:17:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:17:40 INFO - 'opt_config_files': (), 14:17:40 INFO - 'pip_index': False, 14:17:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:17:40 INFO - 'cmd': ('bash', 14:17:40 INFO - '-c', 14:17:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:17:40 INFO - 'enabled': True, 14:17:40 INFO - 'halt_on_failure': False, 14:17:40 INFO - 'name': 'check_screen_resolution'},), 14:17:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:17:40 INFO - 'cmd': ('bash', 14:17:40 INFO - '-c', 14:17:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:17:40 INFO - 'enabled': True, 14:17:40 INFO - 'halt_on_failure': False, 14:17:40 INFO - 'name': 'check_screen_resolution'},), 14:17:40 INFO - 'run_cmd_checks_enabled': True, 14:17:40 INFO - 'sps_profile': False, 14:17:40 INFO - 'sps_profile_interval': 0, 14:17:40 INFO - 'suite': 'dromaeojs', 14:17:40 INFO - 'system_bits': '32', 14:17:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:40 INFO - 'title': 't-yosemite-r7-0235', 14:17:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:40 INFO - 'use_talos_json': True, 14:17:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:40 INFO - 'work_dir': 'build'} 14:17:40 INFO - [mozharness: 2016-08-26 21:17:40.815500Z] Running clobber step. 14:17:40 INFO - Running pre-action listener: _resource_record_pre_action 14:17:40 INFO - Running main action method: clobber 14:17:40 INFO - rmtree: /builds/slave/test/build 14:17:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:42 INFO - Running post-action listener: _resource_record_post_action 14:17:42 INFO - [mozharness: 2016-08-26 21:17:42.876774Z] Finished clobber step (success) 14:17:42 INFO - [mozharness: 2016-08-26 21:17:42.876885Z] Running read-buildbot-config step. 14:17:42 INFO - Running pre-action listener: _resource_record_pre_action 14:17:42 INFO - Running main action method: read_buildbot_config 14:17:42 INFO - Using buildbot properties: 14:17:42 INFO - { 14:17:42 INFO - "project": "", 14:17:42 INFO - "product": "firefox", 14:17:42 INFO - "script_repo_revision": "production", 14:17:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:17:42 INFO - "repository": "", 14:17:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:17:42 INFO - "buildid": "20160826130713", 14:17:42 INFO - "pgo_build": "False", 14:17:42 INFO - "basedir": "/builds/slave/test", 14:17:42 INFO - "buildnumber": 125, 14:17:42 INFO - "slavename": "t-yosemite-r7-0235", 14:17:42 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:17:42 INFO - "platform": "yosemite_r7", 14:17:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:17:42 INFO - "branch": "fx-team", 14:17:42 INFO - "repo_path": "integration/fx-team", 14:17:42 INFO - "revision": "f1c8f78cd6f6e49a5f67b37567888473b898cb90", 14:17:42 INFO - "stage_platform": "macosx64", 14:17:42 INFO - "builduid": "7c87127ad6cb4ee98e8f56e3c44a311a", 14:17:42 INFO - "slavebuilddir": "test" 14:17:42 INFO - } 14:17:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:17:42 INFO - Running post-action listener: _resource_record_post_action 14:17:42 INFO - [mozharness: 2016-08-26 21:17:42.879665Z] Finished read-buildbot-config step (success) 14:17:42 INFO - [mozharness: 2016-08-26 21:17:42.879771Z] Running download-and-extract step. 14:17:42 INFO - Running pre-action listener: _resource_record_pre_action 14:17:42 INFO - Running main action method: download_and_extract 14:17:42 INFO - mkdir: /builds/slave/test/build/tests 14:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:42 INFO - trying https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:17:42 INFO - Downloading https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:17:44 INFO - Downloaded 1199 bytes. 14:17:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:17:44 INFO - Using the following test package requirements: 14:17:44 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:17:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:17:44 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:17:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:17:44 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:17:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:17:44 INFO - u'jsshell-mac.zip'], 14:17:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:17:44 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:17:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:17:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:17:44 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:17:44 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:17:44 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:17:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:17:44 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:17:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:17:44 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:17:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:44 INFO - trying https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:17:44 INFO - Downloading https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:17:45 INFO - Downloaded 16367952 bytes. 14:17:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:17:51 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 14:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:51 INFO - trying https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:17:51 INFO - Downloading https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:17:52 INFO - Downloaded 16367952 bytes. 14:17:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:59 INFO - trying https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:17:59 INFO - Downloading https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:17:59 INFO - Downloaded 14413998 bytes. 14:17:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 14:18: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')]} 14:18:00 INFO - trying https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:18:00 INFO - Downloading https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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 14:18:03 INFO - Downloaded 111601695 bytes. 14:18:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:18:03 INFO - mkdir: /builds/slave/test/properties 14:18:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:03 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:03 INFO - Contents: 14:18:03 INFO - build_url:https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:18:03 INFO - Running post-action listener: _resource_record_post_action 14:18:03 INFO - Running post-action listener: set_extra_try_arguments 14:18:03 INFO - [mozharness: 2016-08-26 21:18:03.835330Z] Finished download-and-extract step (success) 14:18:03 INFO - [mozharness: 2016-08-26 21:18:03.835459Z] Running populate-webroot step. 14:18:03 INFO - Running pre-action listener: _resource_record_pre_action 14:18:03 INFO - Running main action method: populate_webroot 14:18:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:03 INFO - '--tppagecycles', 14:18:03 INFO - '7'], 14:18:03 INFO - 'tests': ['tsvgm']}}, 14:18:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:18:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:18:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:03 INFO - 'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:03 INFO - 'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['damp', 'tps']}, 14:18:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:03 INFO - 'tests': ['damp', 'tps']}, 14:18:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['dromaeo_dom']}, 14:18:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['basic_compositor_video']}, 14:18:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:18:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['a11yr', 14:18:03 INFO - 'ts_paint', 14:18:03 INFO - 'tpaint', 14:18:03 INFO - 'sessionrestore', 14:18:03 INFO - 'sessionrestore_no_auto_restore', 14:18:03 INFO - 'tabpaint']}, 14:18:03 INFO - 'other-e10s': {'tests': ['a11yr', 14:18:03 INFO - 'ts_paint', 14:18:03 INFO - 'tpaint', 14:18:03 INFO - 'sessionrestore', 14:18:03 INFO - 'sessionrestore_no_auto_restore', 14:18:03 INFO - 'tabpaint']}, 14:18:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:18:03 INFO - 'ts_paint', 14:18:03 INFO - 'tpaint', 14:18:03 INFO - 'sessionrestore', 14:18:03 INFO - 'sessionrestore_no_auto_restore', 14:18:03 INFO - 'tabpaint']}, 14:18:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:18:03 INFO - 'ts_paint', 14:18:03 INFO - 'tpaint', 14:18:03 INFO - 'sessionrestore', 14:18:03 INFO - 'sessionrestore_no_auto_restore', 14:18:03 INFO - 'tabpaint']}, 14:18:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['a11yr', 14:18:03 INFO - 'ts_paint', 14:18:03 INFO - 'tpaint', 14:18:03 INFO - 'sessionrestore', 14:18:03 INFO - 'sessionrestore_no_auto_restore', 14:18:03 INFO - 'tabpaint']}, 14:18:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['a11yr', 14:18:03 INFO - 'ts_paint', 14:18:03 INFO - 'tpaint', 14:18:03 INFO - 'sessionrestore', 14:18:03 INFO - 'sessionrestore_no_auto_restore', 14:18:03 INFO - 'tabpaint']}, 14:18:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['tsvgx', 14:18:03 INFO - 'tsvgr_opacity', 14:18:03 INFO - 'tart', 14:18:03 INFO - 'tscrollx', 14:18:03 INFO - 'cart']}, 14:18:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:18:03 INFO - 'tsvgr_opacity', 14:18:03 INFO - 'tart', 14:18:03 INFO - 'tscrollx', 14:18:03 INFO - 'cart']}, 14:18:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:03 INFO - 'talos_options': ['--disable-e10s'], 14:18:03 INFO - 'tests': ['tp5o']}, 14:18:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:03 INFO - 'tests': ['tp5o']}, 14:18:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:03 INFO - 'talos_options': ['--disable-e10s', 14:18:03 INFO - '--xperf_path', 14:18:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:03 INFO - 'tests': ['tp5n']}, 14:18:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:03 INFO - 'talos_options': ['--xperf_path', 14:18:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:03 INFO - 'tests': ['tp5n']}}, 14:18:03 INFO - 'talos.zip': {'path': '', 14:18:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:03 INFO - Running post-action listener: _resource_record_post_action 14:18:03 INFO - [mozharness: 2016-08-26 21:18:03.853657Z] Finished populate-webroot step (success) 14:18:03 INFO - [mozharness: 2016-08-26 21:18:03.853766Z] Running create-virtualenv step. 14:18:03 INFO - Running pre-action listener: _resource_record_pre_action 14:18:03 INFO - Running main action method: create_virtualenv 14:18:03 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:03 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 14:18:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:03 INFO - Using real prefix '/tools/python27' 14:18:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:07 INFO - Installing pip.................done. 14:18:07 INFO - Return code: 0 14:18:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:07 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:07 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 14:18:07 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 14:18:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:07 INFO - 'HOME': '/Users/cltbld', 14:18:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:07 INFO - 'LOGNAME': 'cltbld', 14:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:07 INFO - 'MOZ_NO_REMOTE': '1', 14:18:07 INFO - 'NO_EM_RESTART': '1', 14:18:07 INFO - 'PAGER': '/bin/cat', 14:18:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:07 INFO - 'PWD': '/builds/slave/test', 14:18:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:07 INFO - 'SHELL': '/bin/bash', 14:18:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:07 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:07 INFO - 'USER': 'cltbld', 14:18:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:07 INFO - 'XPC_FLAGS': '0x0', 14:18:07 INFO - 'XPC_SERVICE_NAME': '0', 14:18:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:07 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 14:18:07 INFO - Cleaning up... 14:18:07 INFO - Return code: 0 14:18:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:07 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:07 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 14:18:07 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 14:18:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:07 INFO - 'HOME': '/Users/cltbld', 14:18:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:07 INFO - 'LOGNAME': 'cltbld', 14:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:07 INFO - 'MOZ_NO_REMOTE': '1', 14:18:07 INFO - 'NO_EM_RESTART': '1', 14:18:07 INFO - 'PAGER': '/bin/cat', 14:18:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:07 INFO - 'PWD': '/builds/slave/test', 14:18:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:07 INFO - 'SHELL': '/bin/bash', 14:18:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:07 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:07 INFO - 'USER': 'cltbld', 14:18:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:07 INFO - 'XPC_FLAGS': '0x0', 14:18:07 INFO - 'XPC_SERVICE_NAME': '0', 14:18:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:08 INFO - Downloading/unpacking psutil>=3.1.1 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:11 INFO - Installing collected packages: psutil 14:18:11 INFO - Running setup.py install for psutil 14:18:11 INFO - building 'psutil._psutil_osx' extension 14:18:11 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 14:18:12 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 14:18:12 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 14:18:12 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 14:18:12 INFO - building 'psutil._psutil_posix' extension 14:18:12 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 14:18:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:18:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:18:12 INFO - ^ 14:18:12 INFO - 1 warning generated. 14:18:12 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 14:18:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:12 INFO - Successfully installed psutil 14:18:12 INFO - Cleaning up... 14:18:12 INFO - Return code: 0 14:18:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:18:12 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')]} 14:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:12 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')]} 14:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:12 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:12 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 14:18:12 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 14:18:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:12 INFO - 'HOME': '/Users/cltbld', 14:18:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:12 INFO - 'LOGNAME': 'cltbld', 14:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:12 INFO - 'MOZ_NO_REMOTE': '1', 14:18:12 INFO - 'NO_EM_RESTART': '1', 14:18:12 INFO - 'PAGER': '/bin/cat', 14:18:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:12 INFO - 'PWD': '/builds/slave/test', 14:18:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:12 INFO - 'SHELL': '/bin/bash', 14:18:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:12 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:12 INFO - 'USER': 'cltbld', 14:18:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:12 INFO - 'XPC_FLAGS': '0x0', 14:18:12 INFO - 'XPC_SERVICE_NAME': '0', 14:18:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:18:15 INFO - Installing collected packages: mozsystemmonitor 14:18:15 INFO - Running setup.py install for mozsystemmonitor 14:18:15 INFO - Successfully installed mozsystemmonitor 14:18:15 INFO - Cleaning up... 14:18:15 INFO - Return code: 0 14:18:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:15 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:15 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 14:18:15 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 14:18:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:15 INFO - 'HOME': '/Users/cltbld', 14:18:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:15 INFO - 'LOGNAME': 'cltbld', 14:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:15 INFO - 'MOZ_NO_REMOTE': '1', 14:18:15 INFO - 'NO_EM_RESTART': '1', 14:18:15 INFO - 'PAGER': '/bin/cat', 14:18:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:15 INFO - 'PWD': '/builds/slave/test', 14:18:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:15 INFO - 'SHELL': '/bin/bash', 14:18:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:15 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:15 INFO - 'USER': 'cltbld', 14:18:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:15 INFO - 'XPC_FLAGS': '0x0', 14:18:15 INFO - 'XPC_SERVICE_NAME': '0', 14:18:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:15 INFO - Downloading/unpacking jsonschema==2.5.1 14:18:15 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 14:18:15 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 14:18:15 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 14:18:15 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 14:18:15 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 14:18:15 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 14:18:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:18:18 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 14:18:18 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 14:18:18 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 14:18:18 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 14:18:18 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 14:18:18 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 14:18:18 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:18 INFO - warning: no files found matching '*.txt' 14:18:18 INFO - no previously-included directories found matching 'build' 14:18:18 INFO - no previously-included directories found matching 'dist' 14:18:18 INFO - no previously-included directories found matching '.git*' 14:18:18 INFO - Installing collected packages: jsonschema, functools32 14:18:18 INFO - Running setup.py install for functools32 14:18:19 INFO - warning: no files found matching '*.txt' 14:18:19 INFO - no previously-included directories found matching 'build' 14:18:19 INFO - no previously-included directories found matching 'dist' 14:18:19 INFO - no previously-included directories found matching '.git*' 14:18:19 INFO - Successfully installed jsonschema functools32 14:18:19 INFO - Cleaning up... 14:18:19 INFO - Return code: 0 14:18:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:19 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:19 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 14:18:19 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 14:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:19 INFO - 'HOME': '/Users/cltbld', 14:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:19 INFO - 'LOGNAME': 'cltbld', 14:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:19 INFO - 'MOZ_NO_REMOTE': '1', 14:18:19 INFO - 'NO_EM_RESTART': '1', 14:18:19 INFO - 'PAGER': '/bin/cat', 14:18:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:19 INFO - 'PWD': '/builds/slave/test', 14:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:19 INFO - 'SHELL': '/bin/bash', 14:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:19 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:19 INFO - 'USER': 'cltbld', 14:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:19 INFO - 'XPC_FLAGS': '0x0', 14:18:19 INFO - 'XPC_SERVICE_NAME': '0', 14:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:18:19 INFO - Cleaning up... 14:18:19 INFO - Return code: 0 14:18:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:19 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:19 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 14:18:19 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 14:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:19 INFO - 'HOME': '/Users/cltbld', 14:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:19 INFO - 'LOGNAME': 'cltbld', 14:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:19 INFO - 'MOZ_NO_REMOTE': '1', 14:18:19 INFO - 'NO_EM_RESTART': '1', 14:18:19 INFO - 'PAGER': '/bin/cat', 14:18:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:19 INFO - 'PWD': '/builds/slave/test', 14:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:19 INFO - 'SHELL': '/bin/bash', 14:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:19 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:19 INFO - 'USER': 'cltbld', 14:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:19 INFO - 'XPC_FLAGS': '0x0', 14:18:19 INFO - 'XPC_SERVICE_NAME': '0', 14:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:19 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:22 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:23 INFO - Downloading docopt-0.6.1.tar.gz 14:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:23 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:23 INFO - Running setup.py install for blobuploader 14:18:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:23 INFO - Running setup.py install for requests 14:18:24 INFO - Running setup.py install for docopt 14:18:24 INFO - Successfully installed blobuploader requests docopt 14:18:24 INFO - Cleaning up... 14:18:24 INFO - Return code: 0 14:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:24 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:24 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 14:18:24 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 14:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:24 INFO - 'HOME': '/Users/cltbld', 14:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:24 INFO - 'LOGNAME': 'cltbld', 14:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:24 INFO - 'MOZ_NO_REMOTE': '1', 14:18:24 INFO - 'NO_EM_RESTART': '1', 14:18:24 INFO - 'PAGER': '/bin/cat', 14:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:24 INFO - 'PWD': '/builds/slave/test', 14:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:24 INFO - 'SHELL': '/bin/bash', 14:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:24 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:24 INFO - 'USER': 'cltbld', 14:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:24 INFO - 'XPC_FLAGS': '0x0', 14:18:24 INFO - 'XPC_SERVICE_NAME': '0', 14:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-UsGj1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-sVtHFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-2ZDRZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-5EfnQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:24 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-D6Y5fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-8vIi48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-qVs9NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-EsSVji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-UuEJVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-n9wupx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-x7nH3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-N2rWC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-6IMpqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-YmsnGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:25 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-9sDiHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:26 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-CV3jGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:26 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-XwdGR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:26 INFO - Running setup.py install for manifestparser 14:18:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:26 INFO - Running setup.py install for mozcrash 14:18:26 INFO - Running setup.py install for mozdebug 14:18:26 INFO - Running setup.py install for mozdevice 14:18:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:26 INFO - Running setup.py install for mozfile 14:18:27 INFO - Running setup.py install for mozhttpd 14:18:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:27 INFO - Running setup.py install for mozinfo 14:18:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:27 INFO - Running setup.py install for mozInstall 14:18:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:27 INFO - Running setup.py install for mozleak 14:18:27 INFO - Running setup.py install for mozlog 14:18:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:27 INFO - Running setup.py install for moznetwork 14:18:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:27 INFO - Running setup.py install for mozprocess 14:18:28 INFO - Running setup.py install for mozprofile 14:18:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:28 INFO - Running setup.py install for mozrunner 14:18:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:28 INFO - Running setup.py install for mozscreenshot 14:18:28 INFO - Running setup.py install for moztest 14:18:28 INFO - Running setup.py install for mozversion 14:18:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:28 INFO - Cleaning up... 14:18:28 INFO - Return code: 0 14:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:28 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')]} 14:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:28 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')]} 14:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:28 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:28 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 14:18:28 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 14:18:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:28 INFO - 'HOME': '/Users/cltbld', 14:18:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:28 INFO - 'LOGNAME': 'cltbld', 14:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:28 INFO - 'MOZ_NO_REMOTE': '1', 14:18:28 INFO - 'NO_EM_RESTART': '1', 14:18:28 INFO - 'PAGER': '/bin/cat', 14:18:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:28 INFO - 'PWD': '/builds/slave/test', 14:18:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:28 INFO - 'SHELL': '/bin/bash', 14:18:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:28 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:28 INFO - 'USER': 'cltbld', 14:18:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:28 INFO - 'XPC_FLAGS': '0x0', 14:18:28 INFO - 'XPC_SERVICE_NAME': '0', 14:18:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-mQUIqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:29 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)) 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Gvu4zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:29 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)) 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-LT6NMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:29 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)) 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-mCE_Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:29 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)) 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Wr0E4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:29 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)) 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-BdZuvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:29 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)) 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ytet6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:29 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)) 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-HGr1Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:29 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)) 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:29 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-oxMl_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Q6vJ6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Q_scYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-AD2gsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ZjvSns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-3MHf_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ECFCdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-tAjYSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:30 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)) 14:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:30 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-wvRPhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:30 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)) 14:18:30 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)) 14:18:30 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)) 14:18:30 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)) 14:18:30 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)) 14:18:30 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)) 14:18:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:30 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 14:18:30 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 14:18:30 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 14:18:30 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 14:18:30 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 14:18:30 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 14:18:33 INFO - Downloading blessings-1.6.tar.gz 14:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:33 INFO - Installing collected packages: blessings 14:18:33 INFO - Running setup.py install for blessings 14:18:33 INFO - Successfully installed blessings 14:18:33 INFO - Cleaning up... 14:18:33 INFO - Return code: 0 14:18:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:34 INFO - Reading from file tmpfile_stdout 14:18:34 INFO - Current package versions: 14:18:34 INFO - blessings == 1.6 14:18:34 INFO - blobuploader == 1.2.4 14:18:34 INFO - docopt == 0.6.1 14:18:34 INFO - functools32 == 3.2.3-2 14:18:34 INFO - jsonschema == 2.5.1 14:18:34 INFO - manifestparser == 1.1 14:18:34 INFO - mozInstall == 1.12 14:18:34 INFO - mozcrash == 0.17 14:18:34 INFO - mozdebug == 0.1 14:18:34 INFO - mozdevice == 0.48 14:18:34 INFO - mozfile == 1.2 14:18:34 INFO - mozhttpd == 0.7 14:18:34 INFO - mozinfo == 0.9 14:18:34 INFO - mozleak == 0.1 14:18:34 INFO - mozlog == 3.3 14:18:34 INFO - moznetwork == 0.27 14:18:34 INFO - mozprocess == 0.23 14:18:34 INFO - mozprofile == 0.28 14:18:34 INFO - mozrunner == 6.12 14:18:34 INFO - mozscreenshot == 0.1 14:18:34 INFO - mozsystemmonitor == 0.3 14:18:34 INFO - moztest == 0.7 14:18:34 INFO - mozversion == 1.4 14:18:34 INFO - psutil == 3.1.1 14:18:34 INFO - requests == 1.2.3 14:18:34 INFO - wsgiref == 0.1.2 14:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:34 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 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:34 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 14:18:34 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 14:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:34 INFO - 'HOME': '/Users/cltbld', 14:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:34 INFO - 'LOGNAME': 'cltbld', 14:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:34 INFO - 'MOZ_NO_REMOTE': '1', 14:18:34 INFO - 'NO_EM_RESTART': '1', 14:18:34 INFO - 'PAGER': '/bin/cat', 14:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:34 INFO - 'PWD': '/builds/slave/test', 14:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:34 INFO - 'SHELL': '/bin/bash', 14:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:34 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:34 INFO - 'USER': 'cltbld', 14:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:34 INFO - 'XPC_FLAGS': '0x0', 14:18:34 INFO - 'XPC_SERVICE_NAME': '0', 14:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 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)) 14:18:34 INFO - Cleaning up... 14:18:34 INFO - Return code: 0 14:18:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d24ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83f0592280>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, '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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 14:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:34 INFO - 'HOME': '/Users/cltbld', 14:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:34 INFO - 'LOGNAME': 'cltbld', 14:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:34 INFO - 'MOZ_NO_REMOTE': '1', 14:18:34 INFO - 'NO_EM_RESTART': '1', 14:18:34 INFO - 'PAGER': '/bin/cat', 14:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:34 INFO - 'PWD': '/builds/slave/test', 14:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:34 INFO - 'SHELL': '/bin/bash', 14:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:18:34 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:34 INFO - 'USER': 'cltbld', 14:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:34 INFO - 'XPC_FLAGS': '0x0', 14:18:34 INFO - 'XPC_SERVICE_NAME': '0', 14:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:18:34 INFO - Cleaning up... 14:18:34 INFO - Return code: 0 14:18:34 INFO - Running post-action listener: _resource_record_post_action 14:18:34 INFO - Running post-action listener: _start_resource_monitoring 14:18:34 INFO - Starting resource monitoring. 14:18:34 INFO - [mozharness: 2016-08-26 21:18:34.573677Z] Finished create-virtualenv step (success) 14:18:34 INFO - [mozharness: 2016-08-26 21:18:34.574660Z] Running install step. 14:18:34 INFO - Running pre-action listener: _resource_record_pre_action 14:18:34 INFO - Running main action method: install 14:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:34 INFO - Reading from file tmpfile_stdout 14:18:34 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:34 INFO - Reading from file tmpfile_stdout 14:18:34 INFO - Output received: 14:18:34 INFO - Usage: mozinstall [options] installer 14:18:34 INFO - Options: 14:18:34 INFO - -h, --help show this help message and exit 14:18:34 INFO - -d DEST, --destination=DEST 14:18:34 INFO - Directory to install application into. [default: 14:18:34 INFO - "/builds/slave/test"] 14:18:34 INFO - --app=APP Application being installed. [default: firefox] 14:18:34 INFO - mkdir: /builds/slave/test/build/application 14:18:34 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'] 14:18:34 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 14:19:09 INFO - Reading from file tmpfile_stdout 14:19:09 INFO - Output received: 14:19:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:19:09 INFO - Running post-action listener: _resource_record_post_action 14:19:09 INFO - [mozharness: 2016-08-26 21:19:09.274615Z] Finished install step (success) 14:19:09 INFO - [mozharness: 2016-08-26 21:19:09.274762Z] Running run-tests step. 14:19:09 INFO - Running pre-action listener: _resource_record_pre_action 14:19:09 INFO - Running main action method: run_tests 14:19:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:19:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:19:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:19:09 INFO - 2016-08-26 14:19:09.289 screenresolution[1722:8280] starting screenresolution argv=screenresolution get 14:19:09 INFO - 2016-08-26 14:19:09.292 screenresolution[1722:8280] Display 0: 1600x1200x32@60 14:19:09 INFO - 2016-08-26 14:19:09.298 screenresolution[1723:8282] starting screenresolution argv=screenresolution list 14:19:09 INFO - Available Modes on Display 0 14:19:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:19:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:19:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:19:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:19:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:19:09 INFO - Intel Iris: 14:19:09 INFO - Chipset Model: Intel Iris 14:19:09 INFO - Type: GPU 14:19:09 INFO - Bus: Built-In 14:19:09 INFO - VRAM (Dynamic, Max): 1536 MB 14:19:09 INFO - Vendor: Intel (0x8086) 14:19:09 INFO - Device ID: 0x0a2e 14:19:09 INFO - Revision ID: 0x0009 14:19:09 INFO - Displays: 14:19:09 INFO - Display: 14:19:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:19:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:19:09 INFO - Display Serial Number: 1600x1200 60 14:19:09 INFO - Main Display: Yes 14:19:09 INFO - Mirror: Off 14:19:09 INFO - Online: Yes 14:19:09 INFO - Rotation: Supported 14:19:09 INFO - Return code: 0 14:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:19:09 INFO - Python 2.7.3 14:19:09 INFO - Return code: 0 14:19:09 INFO - grabbing minidump binary from tooltool 14:19: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')]} 14:19:09 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 0x10d1b0d30>, '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 0x10cf15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1a8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:19:09 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 14:19:09 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 14:19:09 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 14:19:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:19:09 INFO - Return code: 0 14:19:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:19:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:19:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:19:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:19:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:19:09 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/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 14:19:09 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/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 14:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SjciwRs4Xk/Render', 14:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:19:09 INFO - 'HOME': '/Users/cltbld', 14:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:19:09 INFO - 'LOGNAME': 'cltbld', 14:19:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:19:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:09 INFO - 'MOZ_NO_REMOTE': '1', 14:19:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:19:09 INFO - 'NO_EM_RESTART': '1', 14:19:09 INFO - 'PAGER': '/bin/cat', 14:19:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:09 INFO - 'PWD': '/builds/slave/test', 14:19:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:19:09 INFO - 'SHELL': '/bin/bash', 14:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWHNE16Zc3/Listeners', 14:19:09 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 14:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:19:09 INFO - 'USER': 'cltbld', 14:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:09 INFO - 'XPC_FLAGS': '0x0', 14:19:09 INFO - 'XPC_SERVICE_NAME': '0', 14:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:19:09 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/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 14:19:09 INFO - mozversion application_buildid: 20160826130713 14:19:09 INFO - mozversion application_changeset: f1c8f78cd6f6e49a5f67b37567888473b898cb90 14:19:09 INFO - mozversion application_display_name: Nightly 14:19:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:19:09 INFO - mozversion application_name: Firefox 14:19:09 INFO - mozversion application_remotingname: firefox 14:19:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:19:09 INFO - mozversion application_vendor: Mozilla 14:19:09 INFO - mozversion application_version: 51.0a1 14:19:09 INFO - mozversion platform_buildid: 20160826130713 14:19:09 INFO - mozversion platform_changeset: f1c8f78cd6f6e49a5f67b37567888473b898cb90 14:19:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:19:09 INFO - mozversion platform_version: 51.0a1 14:19:09 INFO - using testdate: 1472246349 14:19:09 INFO - actual date: 1472246349 14:19:09 INFO - starting webserver on 'localhost:49262' 14:19:09 INFO - SUITE-START | Running 2 tests 14:19:09 INFO - TEST-START | dromaeo_css 14:19:09 INFO - operating with platform_type : mac_ 14:19:09 INFO - Initialising browser for dromaeo_css test... 14:19:09 INFO - TEST-INFO | started process 1733 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmp4e0gwp/profile http://localhost:49262/getInfo.html) 14:19:12 INFO - PROCESS | 1733 | __metrics Screen width/height:1600/1200 14:19:12 INFO - PROCESS | 1733 | colorDepth:24 14:19:12 INFO - PROCESS | 1733 | Browser inner width/height: 1024/689 14:19:12 INFO - PROCESS | 1733 | __metrics 14:19:12 INFO - PROCESS | 1733 | 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" 14:19:12 INFO - PROCESS | 1733 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:13 INFO - TEST-INFO | 1733: exit 0 14:19:13 INFO - Browser initialized. 14:19:13 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:13 INFO - TEST-INFO | started process 1737 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmp4e0gwp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:24 INFO - PROCESS | 1737 | RSS: Main: 233553920 14:19:24 INFO - PROCESS | 1737 | 14:20:16 INFO - PROCESS | 1737 | 1472246416797 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] 14:22:28 INFO - PROCESS | 1737 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 14:22:30 INFO - PROCESS | 1737 | RSS: Main: 375754752 14:22:30 INFO - PROCESS | 1737 | 14:25:33 INFO - PROCESS | 1737 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 14:25:34 INFO - PROCESS | 1737 | RSS: Main: 379596800 14:25:34 INFO - PROCESS | 1737 | 14:28:36 INFO - PROCESS | 1737 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 14:28:37 INFO - PROCESS | 1737 | RSS: Main: 338132992 14:28:37 INFO - PROCESS | 1737 | 14:31:39 INFO - PROCESS | 1737 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 14:31:40 INFO - PROCESS | 1737 | RSS: Main: 341000192 14:31:40 INFO - PROCESS | 1737 | 14:34:43 INFO - PROCESS | 1737 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 14:34:44 INFO - PROCESS | 1737 | RSS: Main: 332595200 14:34:44 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 14:37:47 INFO - PROCESS | 1737 | RSS: Main: 409206784 14:37:47 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | __start_tp_report 14:37:47 INFO - PROCESS | 1737 | _x_x_mozilla_page_load 14:37:47 INFO - PROCESS | 1737 | _x_x_mozilla_page_load_details 14:37:47 INFO - PROCESS | 1737 | |i|pagename|runs| 14:37:47 INFO - PROCESS | 1737 | |0;dojo.html;3090.845457727113;3334.9499757503636;3342.0809277448698;3396.133985833612;3420.8289585520733;4801.591864691505;5608.775648974041;5620.831375058755;5673.461021202989;5687.573431992597;5673.461021202989;5685.573581981347;5758.856028599287;5797.855053623662;5810.535157187425;5129.410117836441;5147.613928955325;5199.766010529516;5215.322008138936;5309.203619457074;5286.841394758144;5308.522232999029;5315.867103322428;5331.333583302087;5365.624406291561;5149;5157.226416037587;5198.428172900978;5222.086134926391;5237.188235823415;5217.634765566412;5223.6343455958095;5228.5555727763185;5231.60762942777;5232.3459567554055;5146.871328216787;5182.32629758129;5196.272521846944;5204.817831375922;5225.320708307933;5599.832005039814;5668.348139963916;5682.261306030231;5790.594658373873;5792.247007888947;6218.782342617987;6262.091996660504;6275.215598050244;6285.937140628581;6300.21247344082;6150.84622884427;6255.906161407537;6329.810105696836;6332.398422149889;6345.682715864188;5716.628419152742;5740.311162660424;5755.654660720286;5773.595848290579;5788.594798364074;6262.185915830913;6270.153529273581;6278.277998030285;6282.842928926722;6283.7800676976085;5928.081147422156;6059.878802423927;6161.322254551996;6173.722182501709;6194.4115309045565;6134.693265336716;6195.19462469876;6257.906131408033;6272.6550039747335;6295.653739044396;6191.25704915413;6192.969035154795;6215.160953271341;6216.285127210429;6222.28443728977;6099.420555047263;6210.782622608187;6226.719797609118;6244.2819075805955;6251.093591429309;4866.6106711463;4907.656464047483;4919.434265059493;4921.26181072842;4939.3084968104495;4313.439252897103;4432.047109871329;4463.531329210451;4473.105378924228;4473.3066374711325;4923.75381230937;5626.409227031103;5647.068233741469;5652.152177173375;5655.3779084300695;6107.267127944675;6172.22847144107;6175.84560385994;6182.783602573978;6199.442050215503;5584.52531534816;5588.357338905997;5594.160875868571;5596.524295434852;5601.383847776741;5310.468953104736;5375.19372094189;5393.325834270716;5450;5450.863728406822;6366;6366.586171898812;6376.011718183689;6382.585131966407;6388.105665206875;6236.376362363727;6323.810285691437;6330.208723909512;6334.398232167937;6335.239771227482;6242.344553821783;6266.592671476339;6305.905411418924;6315.936840631535;6339;6095.801078121576;6120.479759220516;6162.784302549389;6170.074488826712;6214.533909956681;5622.803201887914;6163.736434031102;6289.591176573508;6301.338359472373;6306.369363063657;6060.1212824139375;6121.357257488078;6150.661713605795;6153;6170.660613666291;5923.466887980103;5943.970280148572;5965.343812180743;6046.062860256668;6153.169322141453;4976.353074100344;5888.528917686489;5903.616264942765;5939.673317967553;6034.818955431168;6118.923762351488;6122.479351142269;6169.352218017223;6178.196834411498;6182.629042257299;5948.702564871653;5963.761449541969;5964.045752679551;5981.431763982415;6002.909956350745 14:37:47 INFO - PROCESS | 1737 | |1;ext.html;475.3131724657869;497.6591035140931;514.8790034341929;514.9588032957363;521.8154788629813;29923.70076299239;38348.61651383485;39497.605023949785;39645.80177099118;42070.36894446578;41619.58380416195;42104;42206;42228.15543689132;42355.78822105885;8695.478271303711;9582.760430989229;9781.364211326241;9796.461194634292;9798.706038818811;8599.183077607617;11816.7636647267;12032.458539365749;12036.398180091004;12230.510779568807;11862;11912.868277513666;11915.880841191607;11915.880841191607;11936.7612647747;11924.940375298154;12004.399780010965;12005.379273798013;12005.579804706837;12015.038796896315;11737.647870563811;11812.818718128205;11813;11813.527458901634;11814.763704725943;38875;39229.29248490199;39241;39267.607323926684;39285;3235.9352812943607;3308.602967643874;3438.9312213755834;3483.6168021517615;3667.651573100551;29533.556996645068;30126.24684382886;30882;30915.845420772977;31028.53457198144;3196.856141473616;3199.536067270256;3227.499737540685;3319.6016478022552;3326.6507016763135;465206;468594;470362;470843;476388;49169;56071.87856242934;56099.15851262234;56240.5939851507;56294.71852640711;58034;58092.41907580954;58147.41852581505;58264.70867645634;58292.708536457896;16029.278682459317;16230.675386492205;16245.268962896698;16247;16258;11592.826107608393;11836.289822610499;12651.683707907376;12803.743925121445;12955.5465558705;14085.366158522891;14401.207933563755;14703.55889323322;14780.852191478163;14834.851651483563;6930.653467326714;7066.3993560546905;7163.856722865514;7182.281771822776;7212.3148300911325;849.6728759427665;942.5428667096453;1013.1540163963173;1063.984040239397;1142.520141540555;28267.57598636022;28555.57166642502;28854.134375968755;29304.080491895016;29717;1030.5311083457009;1038.8337865941412;1050.4590136079926;1075.725689949058;1131.7889857852183;13325.267110309027;14326.49857255012;15051.774223386657;15235.009724367881;15573.922130389275;608495;611105;611670;612730;613829;54829.45170548323;54885.902281954935;54969.45030549643;55022;55189.44810551843;1242.1491278474275;1359.0758284366725;1382.9654258643413;1397.895157863144;1410.5063227870164;29322;30392.696073038987;30712.692873070984;30720;31104.37791244117;46850.76574617105;47243.05513889772;47259;47387.52612473969;47427.525724742314;520864;522243;522309.3884530553;522922;523355;24747.752522475264;25396.365090872878;25509.744902550738;26019.535897461745;26065.218043458728;45362.319565205886;45499.54500454953;45578.16327550761;46546.30180547227;46667.29999050085;31894.6810531901;36483;37514.249715006095;37910.052248694;39177.608223918534;37362.43956340603;37407.81296093502;37848.889686777766;38356.65751698677;38791;37377.62622373742;37676;38265;38272.61727382691;38395.80802095972;32285;33012.47451121499;33310.83344583261;33896.15259618431;34192;24628.50742985166;24755.876220618782;24857;25443.491130177663;25476.74523254818 14:37:47 INFO - PROCESS | 1737 | |2;jquery.html;350.236484463869;364.335088463554;372.644124860758;377.38109500419307;400.0458905510359;14775.63060923476;15209;20728.170873165072;21068.157273709072;21299.68050479244;18401.343879050884;19923.50191245216;20556.588868222625;20697;21556.814375209357;5301.860100078482;5796.188533605288;5962.612430192045;6116.663583502906;6131;3540.3627347077518;4087.1417002429525;5956.910646340287;6070.848228794272;6757.7972660820005;6724.865502689943;6731.427828634572;6733;6742.123523941881;6774.7290108395855;6418.614883107005;6596.274409814917;6663.800085997428;6674.8319044167565;6791.422729068036;4631.8378856739855;5765.971170144165;5769.826905192851;5777.5666824987875;5785.392533783935;25493.235202943757;25615.743842561522;25666.871665641553;25929.092481763237;25957.74042259572;2130.041481333406;2203.966940495894;2209.436593668604;2562.7821635161035;2606.452644944564;9727.756806079904;10250.9487452563;10349.896501035044;10363.378197308186;10385.688429347056;1842.7788665360108;1858.256697321069;1859.5072305838964;1886.2737845929278;1965.1058768260407;119762;121151.78848211493;122640.38679806633;122831.15753263798;125951;11212.775744485229;11523.250988685708;11552.6534203974;11561.942190289163;11744.236624619372;12831.807522887164;13363.665908352368;13480.528181513797;14258.572242832732;14289.928550357181;8386.454880432751;8515.594926837126;8544.273736732448;8662.913370866338;8723.651053957898;8462;8510.234078932926;8513.702020429255;8644.524551149621;8684.522351270742;4395.7362558246605;4476.350929115325;4489.461264648263;4557.772111394417;4567.908641827211;1843.4285371534868;1885.7333048519295;1905.4569447707338;1909.2935613822974;1953.1796645408963;845.6532821543137;879.4723166100416;925.047201382577;967.8596603492454;1039.7296702857311;21111.366659000254;21712.457188570414;21720.78279217219;21781;21784.237551685615;889.3596610440472;899.3165194452133;931.3713243560569;952.851813564653;964.8793900762405;11061.778764424667;11213.046891014355;11279.943600281946;11309;11326.886731132583;460883;474310;547162;559567;563419;118139.40930295293;121735.39132304282;123899;124072;127108;917.6925729880431;941.0777438110553;953.9046095390544;954.9331546791797;964.8842138943231;18019.094266742493;18870.71693924565;19076.713849291995;19292.13185406632;19298.71051934194;54927;54983;55304;55869;56064.15903761365;77654;78712.60643696744;78722.6063869677;78890.21109788828;78919.60540197263;7858.135605083322;8035.834803953511;8072.910157128713;8285.792855178668;8534.78663033429;11056.281341712764;12291.508339666314;12612.243265403738;12646.494140234288;12882.67793305175;11332.263402878787;11420.31478111316;11672.941635291769;11674.591389301333;11713.180077394842;10549.578016879239;10667.679969600924;10691.251612387057;10863.837042444527;10943.671689849318;11581.536738530365;11665;11705.707357316136;11820.70448238801;11940.522379105087;7077;7147.678354474165;7354.96322518384;7433.293837085468;8434.451760635538;9057.094112045937;11706.70733231676;11846.763064738485;11893.286402815858;11898.524059037542 14:37:47 INFO - PROCESS | 1737 | |3;mootools.html;1116.5645398294662;1417.5888992192265;1500.1973943939995;1665.1674162918541;1875.2030387085495;7722.266384693459;8366.748997530076;8667.826643467128;8679.869801952977;8717.564121793908;8382.497050176993;8569.200467901748;8577.785555361119;8653.956730216356;8683.869741953877;2326.081197926818;2377.940551486209;2378.714554253483;2379.3100000999775;2380.809535237177;2305.527366889792;2339.251439539348;2360;2367.147826782357;2372.525494901018;2339.7543257957923;2355.752645972174;2358.705161854768;2374.050379848057;2377.049180327874;2299.1263319938485;2323.5585238804656;2324.244620498336;2326.755690652474;2339.859608423483;2319.976800231993;2324.070371851273;2329.7670232976734;2331.044271848551;2332.5684748321614;8382.916170838274;8656.523891185981;8724.302055835582;8735.08281630426;8753.693620723308;5172.301739265189;5321.787128514855;5342.0651386007685;5370.5435038021815;5371;3543.0965103898598;3544.2557063016798;3604.9459258110887;3618.2220822523022;3619.9095022624647;931.9953400233023;1073.4686330266568;1076.6769969009265;1082.577794660083;1097.434821067151;11360.977512023957;11430.485628146753;11505.712357191138;11525.596604118815;11542.134339924456;4083.8570650027104;4497.662675299365;4581.335706322565;4646.907061858811;4843.467218605951;9943.15483183923;9944.303898727165;9952.00479951999;9960.651377201762;9976.401415915068;5264.710440925785;5359.732013399314;5367.409584945653;5370.946290537123;5371.811986580529;4375.453068366454;4396.538363471854;4562.703424277412;4735.502772208937;4872.512748725099;3906.0625449891822;3942.8422863085157;4038.45480860086;4067.1662309226535;4067.9796601017397;1279.4690203565601;1302.8110923915979;1308.0974127851753;1311.7573248948975;1317.6823176823177;848.1687945813014;865.9263962563126;897.6588896219525;902.9458232506071;958.9280803939732;5510.338759348904;5608.971955140199;5872.823815285548;5930.525557955353;6032.426919442646;920.2086205862953;925.9398139120935;937.8921424036187;945.4847108325979;963.8457846744627;3790.6967442604528;3828.655421012122;3828.8704832074604;3944.171723938005;3968.3650615901315;10444.738881528023;10681.679549613524;10777.83833242502;10798.460076996118;10816.891831081588;10712.678619641423;10724.89275107239;10739.570417183382;10751.83872241917;10752.569897204181;7660.61696915152;8028.879566806502;8035;8056.919430805617;8192.385571082194;5843.831233753182;5910.758740664509;5957.91063134062;5986.132010858314;5992.490638295793;9816.116549510578;10049.799004020026;10059.597616095274;10067.446290454096;10078.042585954323;8887.933447986024;9517.857232141385;10102.797944041225;10235.130013948898;10292.382457052601;7327.780166595011;7421.8144546386775;7426.331630153312;7525.510841795266;7534.886976695464;8088.231617996281;8151.877721834296;8167.918320816716;8170.591470426574;8186.181381862004;7163.7492687755675;7406.07424071991;7417.592032438052;7418.480706350504;7473.738419155304;7140.464465165237;7257.455690823103;7276.599787011765;7317.304856038668;7473.17795042534;6815.386615204656;6937.3062693732245;6944.4444444445335;6945.583265004116;6972.6513674315065;4847.756808005848;4928.236123400879;4970.577500912318;5004.974975125101;5085.872853178552;4229.97885010573;4382.123575284892;4876.804927802848;5064.037832811754;5191.325127733521 14:37:47 INFO - PROCESS | 1737 | |4;prototype.html;294.31277965949505;298.6326818013843;308.7715090832784;313.24039204928044;315.4605624382306;4151.31871592005;5342.305500284962;5348.73256337183;5367.597430192742;5404.324459442565;5192.71440070796;5243;5244.39689435715;5336.813211537587;5348.759305831237;3612.6929211016964;3773.33966555853;4068.5931406859227;4098.938515922264;4112.527059388164;3653.2328211075705;3663.6519530644678;3769.905752356199;3999.5800440953717;4065.715399922007;3993.660538854186;4048.4534587830562;4057.797110144496;4063.4920634920636;4066.3493840985448;3504.5794504659348;3701.148735790783;4024.7786371749544;4038.5961403859524;4055.371417430303;2799.6080548723194;3447.413939630244;3563.893083207482;3575.2827850833555;3584.5698516177963;4340.696151269412;4439.933400998988;5060.443351231362;5207.453217412155;5224.309480617485;4066.5120185577625;4597.862064138081;4617.629130734549;4627.976860115711;4646.86059418218;4815.771978145585;5105.902231020348;5194.584433245369;5452.563794896439;5506.256655351556;3278.5246139309666;3386.847591858372;3662.6154253803234;3770.7926064066464;3845.5193100862393;5011.924821127686;5183.248428977777;5650.039493286151;5741.62679425836;5792.335525658203;3447.3105378924315;3872.361060425055;3916.6475017248586;3920;3963.9405408918888;3371.005553361715;3654.1778099927305;3761.4545890845675;4036.1725846201457;4037.3338399164395;3523.3834079036064;4390.517043125254;4490.326451032306;4536.591706746409;4574.359589657451;5510.669359838423;5514.601148500416;5525.530329921921;5550.750216240279;5561.888762224733;1133.195431243826;1145.7364806094645;1211.6304527119137;1263.128441375448;1302.5441095616459;871.1549796697194;877.9034306226438;898.8876390451194;901.6213190460022;908.9547020925855;4288.871333859989;5091.261767043758;5091.261767043832;5100.923486147711;5108.948910510847;4687.742174180385;4805.014971930746;4863.878403039952;4942.579880710108;5712;4646.558576935186;4787.952120478821;5054.620903432257;5111.233315002779;5119.48805119485;2169.7721739217473;2193.8683678979314;2428.817838662072;2535.239428171541;2549.763364768123;4122.537068862171;4500.887477813081;4618.422697162855;4794.95205047952;4970.850874473772;4193.203291374629;4760;4818.566329030404;4820.566149046603;4903.926441103386;3861.5945325740954;3936.4488971544006;4197.488903994559;4579.923717926285;4686.055287055834;4192.895177620584;4368.801126659266;4574.954250457453;4879.731614761222;4886.682365646222;4221.788910554522;4290.334998075304;4384.81609965314;4689.296605509065;4723.976380118077;4346.6088052075465;5410.78356865721;5962.658401859547;6018.247719035121;6057.394260573908;3809.219110082482;3833.4824798651825;3833.754029940225;3840.57753647093;3847.5575308839843;4828;5220.817271395483;5383.573353061363;5920.259967504062;5923.911141332969;4951.8266860659705;5086.745662716923;5642.322921249476;5694.886102277848;5710.486056254957;5333.986542556901;5579.7489112990825;5582.609217354746;5598.272224610774;5677.460641239076;4260.957390426056;4621.976890115528;5002.674826136289;5206.765695543634;5471.470901268739;4750.788548920003;5569.610127291051;5603.926547177571;5615.578831587729;5627.971860140673;5393.110136827537;5497.175423686479;5510.366307874486;5517.558595312285;5558.805441809517 14:37:47 INFO - PROCESS | 1737 | |5;yui.html;617.5461036138438;716.7813816785881;768.5081547809403;810.6061730777798;812.5246730662562;14948.551543453686;15578.844211557882;15629.374825007015;15644.608884777886;15665.216739163054;14201.360938757754;14239;14255;14271.500497482564;14422.062565933207;657.9276279609239;815.3355015662246;825.7564018614509;840.369722707969;845.0957475501185;710.3287393413226;854.5214679779313;855.632078206371;855.6791203298762;856.4347530629785;908.0011986814517;908.8091500784843;909.231699214163;913.5569248914271;914.7621618379236;692.8129405060631;890.1676932068472;907.1427501011547;907.850204716221;916.1159481100703;667.6361383046251;668.6556423441931;671.1912145864222;671.4460570029745;671.4728937783865;14910.850891491054;14918.552443426715;14920.179390133539;14939;14965.925170374187;14437.06159099655;14709.338079786328;14728.705425891529;14731.263436828116;14843.851561484355;11802.763944721057;12093.213941093802;12276;12280.324582147978;12451.007838745847;3740.906477338061;3760.699144068468;3950.9012274693364;3982.8406863725418;3996.840126394941;105425;113629;114488;114757;116888.83111168865;11286;11339.943300283447;11413.086953043736;11648;11905.345206013579;23485.178018769602;23502.529949401258;23532.764672353398;23545.764542354358;23581.528369432515;7457.291557302047;7741.961290193625;7805.492642978188;7815.609219539114;7852.646630901509;3797.1646237827636;3856.8842934712;4290.549492303326;4371.103923695635;4493.707908985905;3404.3701915145284;3506.386382383073;3510.140015696171;3510.982445087809;3512.8946131616094;579.7246308003664;587.1574290892582;588.7556663984484;589.0633892111478;589.1104432307247;496.37952559300874;532.7968848810198;532.8561288452096;575.9654420734769;702.8929436138103;8720.607572659246;9252.768680783034;9396.530173491297;9493.240540756722;9550.713478595653;619.6127420362274;641.6631268583938;662.7542997177384;673.5115394977155;681.6843492060372;4455.933161002587;4513.751743654065;4612.5156858530045;4614.284785858197;4629.8148074077335;160540;161899;161917;164728;166432.02111809753;83856;101700.49149754204;130205.69794302125;142209;148172.2591387036;119891;121156.39421802835;125279;125982.37008814898;126642.99999999815;8679.435333070744;8822.382433229868;8828.073052329413;8837.779055523662;9041.638334466548;58229.54426139211;61337;61901.69049154905;65631.34368656253;67994.66002669955;95246.52376738071;101055;104629.4305585432;105134.47432762788;107481;11835.230710003822;11935.761284774082;11981.221220620631;12262.570810021607;12570.685732856751;12967.22196668203;13295.468181272641;13455.394507247001;13477.595672129852;13497;11868.762624747284;12301.384930753247;12327.630171094881;12450.25298482094;12630.747385052064;11907.106966977684;12030.518779248732;12148.39258037077;12346.629601111981;12453.1905426147;11855.940720296343;12001.579944701894;12059.879401206226;12080.275183489019;12144.75710485803;8287.544185069879;9379.765505862408;9583.712488625353;9817;9882.505874706092;8596.355273354398;9449.527523623929;10157;10176.796464070825;10214.642487512901 14:37:47 INFO - PROCESS | 1737 | __end_tp_report 14:37:47 INFO - PROCESS | 1737 | __start_cc_report 14:37:47 INFO - PROCESS | 1737 | _x_x_mozilla_cycle_collect,1455 14:37:47 INFO - PROCESS | 1737 | __end_cc_report 14:37:47 INFO - PROCESS | 1737 | __startTimestamp1472247467850__endTimestamp 14:37:47 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | ------- Summary: start ------- 14:37:47 INFO - PROCESS | 1737 | Number of tests: 6 14:37:47 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | [#0] dojo.html Cycles:165 Average:5727.08 Median:5943.97 stddev:653.94 (11.0%) stddev-sans-first:622.39 14:37:47 INFO - PROCESS | 1737 | Values: 3090.8 3334.9 3342.1 3396.1 3420.8 4801.6 5608.8 5620.8 5673.5 5687.6 5673.5 5685.6 5758.9 5797.9 5810.5 5129.4 5147.6 5199.8 5215.3 5309.2 5286.8 5308.5 5315.9 5331.3 5365.6 5149.0 5157.2 5198.4 5222.1 5237.2 5217.6 5223.6 5228.6 5231.6 5232.3 5146.9 5182.3 5196.3 5204.8 5225.3 5599.8 5668.3 5682.3 5790.6 5792.2 6218.8 6262.1 6275.2 6285.9 6300.2 6150.8 6255.9 6329.8 6332.4 6345.7 5716.6 5740.3 5755.7 5773.6 5788.6 6262.2 6270.2 6278.3 6282.8 6283.8 5928.1 6059.9 6161.3 6173.7 6194.4 6134.7 6195.2 6257.9 6272.7 6295.7 6191.3 6193.0 6215.2 6216.3 6222.3 6099.4 6210.8 6226.7 6244.3 6251.1 4866.6 4907.7 4919.4 4921.3 4939.3 4313.4 4432.0 4463.5 4473.1 4473.3 4923.8 5626.4 5647.1 5652.2 5655.4 6107.3 6172.2 6175.8 6182.8 6199.4 5584.5 5588.4 5594.2 5596.5 5601.4 5310.5 5375.2 5393.3 5450.0 5450.9 6366.0 6366.6 6376.0 6382.6 6388.1 6236.4 6323.8 6330.2 6334.4 6335.2 6242.3 6266.6 6305.9 6315.9 6339.0 6095.8 6120.5 6162.8 6170.1 6214.5 5622.8 6163.7 6289.6 6301.3 6306.4 6060.1 6121.4 6150.7 6153.0 6170.7 5923.5 5944.0 5965.3 6046.1 6153.2 4976.4 5888.5 5903.6 5939.7 6034.8 6118.9 6122.5 6169.4 6178.2 6182.6 5948.7 5963.8 5964.0 5981.4 6002.9 14:37:47 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | [#1] ext.html Cycles:180 Average:66748.05 Median:18815.47 stddev:143484.29 (762.6%) stddev-sans-first:143800.52 14:37:47 INFO - PROCESS | 1737 | Values: 475.3 497.7 514.9 515.0 521.8 29923.7 38348.6 39497.6 39645.8 42070.4 41619.6 42104.0 42206.0 42228.2 42355.8 8695.5 9582.8 9781.4 9796.5 9798.7 8599.2 11816.8 12032.5 12036.4 12230.5 11862.0 11912.9 11915.9 11915.9 11936.8 11924.9 12004.4 12005.4 12005.6 12015.0 11737.6 11812.8 11813.0 11813.5 11814.8 38875.0 39229.3 39241.0 39267.6 39285.0 3235.9 3308.6 3438.9 3483.6 3667.7 29533.6 30126.2 30882.0 30915.8 31028.5 3196.9 3199.5 3227.5 3319.6 3326.7 465206.0 468594.0 470362.0 470843.0 476388.0 49169.0 56071.9 56099.2 56240.6 56294.7 58034.0 58092.4 58147.4 58264.7 58292.7 16029.3 16230.7 16245.3 16247.0 16258.0 11592.8 11836.3 12651.7 12803.7 12955.5 14085.4 14401.2 14703.6 14780.9 14834.9 6930.7 7066.4 7163.9 7182.3 7212.3 849.7 942.5 1013.2 1064.0 1142.5 28267.6 28555.6 28854.1 29304.1 29717.0 1030.5 1038.8 1050.5 1075.7 1131.8 13325.3 14326.5 15051.8 15235.0 15573.9 608495.0 611105.0 611670.0 612730.0 613829.0 54829.5 54885.9 54969.5 55022.0 55189.4 1242.1 1359.1 1383.0 1397.9 1410.5 29322.0 30392.7 30712.7 30720.0 31104.4 46850.8 47243.1 47259.0 47387.5 47427.5 520864.0 522243.0 522309.4 522922.0 523355.0 24747.8 25396.4 25509.7 26019.5 26065.2 45362.3 45499.5 45578.2 46546.3 46667.3 31894.7 36483.0 37514.2 37910.1 39177.6 37362.4 37407.8 37848.9 38356.7 38791.0 37377.6 37676.0 38265.0 38272.6 38395.8 32285.0 33012.5 33310.8 33896.2 34192.0 24628.5 24755.9 24857.0 25443.5 25476.7 14:37:47 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | [#2] jquery.html Cycles:180 Average:32959.07 Median:25797.98 stddev:88074.37 (341.4%) stddev-sans-first:88287.41 14:37:47 INFO - PROCESS | 1737 | Values: 350.2 364.3 372.6 377.4 400.0 14775.6 15209.0 20728.2 21068.2 21299.7 18401.3 19923.5 20556.6 20697.0 21556.8 5301.9 5796.2 5962.6 6116.7 6131.0 3540.4 4087.1 5956.9 6070.8 6757.8 6724.9 6731.4 6733.0 6742.1 6774.7 6418.6 6596.3 6663.8 6674.8 6791.4 4631.8 5766.0 5769.8 5777.6 5785.4 25493.2 25615.7 25666.9 25929.1 25957.7 2130.0 2204.0 2209.4 2562.8 2606.5 9727.8 10250.9 10349.9 10363.4 10385.7 1842.8 1858.3 1859.5 1886.3 1965.1 119762.0 121151.8 122640.4 122831.2 125951.0 11212.8 11523.3 11552.7 11561.9 11744.2 12831.8 13363.7 13480.5 14258.6 14289.9 8386.5 8515.6 8544.3 8662.9 8723.7 8462.0 8510.2 8513.7 8644.5 8684.5 4395.7 4476.4 4489.5 4557.8 4567.9 1843.4 1885.7 1905.5 1909.3 1953.2 845.7 879.5 925.0 967.9 1039.7 21111.4 21712.5 21720.8 21781.0 21784.2 889.4 899.3 931.4 952.9 964.9 11061.8 11213.0 11279.9 11309.0 11326.9 460883.0 474310.0 547162.0 559567.0 563419.0 118139.4 121735.4 123899.0 124072.0 127108.0 917.7 941.1 953.9 954.9 964.9 18019.1 18870.7 19076.7 19292.1 19298.7 54927.0 54983.0 55304.0 55869.0 56064.2 77654.0 78712.6 78722.6 78890.2 78919.6 7858.1 8035.8 8072.9 8285.8 8534.8 11056.3 12291.5 12612.2 12646.5 12882.7 11332.3 11420.3 11672.9 11674.6 11713.2 10549.6 10667.7 10691.3 10863.8 10943.7 11581.5 11665.0 11705.7 11820.7 11940.5 7077.0 7147.7 7355.0 7433.3 8434.5 9057.1 11706.7 11846.8 11893.3 11898.5 14:37:47 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | [#3] mootools.html Cycles:180 Average:5657.09 Median:4949.41 stddev:3168.07 (64.0%) stddev-sans-first:3158.57 14:37:47 INFO - PROCESS | 1737 | Values: 1116.6 1417.6 1500.2 1665.2 1875.2 7722.3 8366.7 8667.8 8679.9 8717.6 8382.5 8569.2 8577.8 8654.0 8683.9 2326.1 2377.9 2378.7 2379.3 2380.8 2305.5 2339.3 2360.0 2367.1 2372.5 2339.8 2355.8 2358.7 2374.1 2377.0 2299.1 2323.6 2324.2 2326.8 2339.9 2320.0 2324.1 2329.8 2331.0 2332.6 8382.9 8656.5 8724.3 8735.1 8753.7 5172.3 5321.8 5342.1 5370.5 5371.0 3543.1 3544.3 3604.9 3618.2 3619.9 932.0 1073.5 1076.7 1082.6 1097.4 11361.0 11430.5 11505.7 11525.6 11542.1 4083.9 4497.7 4581.3 4646.9 4843.5 9943.2 9944.3 9952.0 9960.7 9976.4 5264.7 5359.7 5367.4 5370.9 5371.8 4375.5 4396.5 4562.7 4735.5 4872.5 3906.1 3942.8 4038.5 4067.2 4068.0 1279.5 1302.8 1308.1 1311.8 1317.7 848.2 865.9 897.7 902.9 958.9 5510.3 5609.0 5872.8 5930.5 6032.4 920.2 925.9 937.9 945.5 963.8 3790.7 3828.7 3828.9 3944.2 3968.4 10444.7 10681.7 10777.8 10798.5 10816.9 10712.7 10724.9 10739.6 10751.8 10752.6 7660.6 8028.9 8035.0 8056.9 8192.4 5843.8 5910.8 5957.9 5986.1 5992.5 9816.1 10049.8 10059.6 10067.4 10078.0 8887.9 9517.9 10102.8 10235.1 10292.4 7327.8 7421.8 7426.3 7525.5 7534.9 8088.2 8151.9 8167.9 8170.6 8186.2 7163.7 7406.1 7417.6 7418.5 7473.7 7140.5 7257.5 7276.6 7317.3 7473.2 6815.4 6937.3 6944.4 6945.6 6972.7 4847.8 4928.2 4970.6 5005.0 5085.9 4230.0 4382.1 4876.8 5064.0 5191.3 14:37:47 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | [#4] prototype.html Cycles:180 Average:4290.71 Median:4646.71 stddev:1321.40 (28.4%) stddev-sans-first:1290.61 14:37:47 INFO - PROCESS | 1737 | Values: 294.3 298.6 308.8 313.2 315.5 4151.3 5342.3 5348.7 5367.6 5404.3 5192.7 5243.0 5244.4 5336.8 5348.8 3612.7 3773.3 4068.6 4098.9 4112.5 3653.2 3663.7 3769.9 3999.6 4065.7 3993.7 4048.5 4057.8 4063.5 4066.3 3504.6 3701.1 4024.8 4038.6 4055.4 2799.6 3447.4 3563.9 3575.3 3584.6 4340.7 4439.9 5060.4 5207.5 5224.3 4066.5 4597.9 4617.6 4628.0 4646.9 4815.8 5105.9 5194.6 5452.6 5506.3 3278.5 3386.8 3662.6 3770.8 3845.5 5011.9 5183.2 5650.0 5741.6 5792.3 3447.3 3872.4 3916.6 3920.0 3963.9 3371.0 3654.2 3761.5 4036.2 4037.3 3523.4 4390.5 4490.3 4536.6 4574.4 5510.7 5514.6 5525.5 5550.8 5561.9 1133.2 1145.7 1211.6 1263.1 1302.5 871.2 877.9 898.9 901.6 909.0 4288.9 5091.3 5091.3 5100.9 5108.9 4687.7 4805.0 4863.9 4942.6 5712.0 4646.6 4788.0 5054.6 5111.2 5119.5 2169.8 2193.9 2428.8 2535.2 2549.8 4122.5 4500.9 4618.4 4795.0 4970.9 4193.2 4760.0 4818.6 4820.6 4903.9 3861.6 3936.4 4197.5 4579.9 4686.1 4192.9 4368.8 4575.0 4879.7 4886.7 4221.8 4290.3 4384.8 4689.3 4724.0 4346.6 5410.8 5962.7 6018.2 6057.4 3809.2 3833.5 3833.8 3840.6 3847.6 4828.0 5220.8 5383.6 5920.3 5923.9 4951.8 5086.7 5642.3 5694.9 5710.5 5334.0 5579.7 5582.6 5598.3 5677.5 4261.0 4622.0 5002.7 5206.8 5471.5 4750.8 5569.6 5603.9 5615.6 5628.0 5393.1 5497.2 5510.4 5517.6 5558.8 14:37:47 INFO - PROCESS | 1737 | 14:37:47 INFO - PROCESS | 1737 | [#5] yui.html Cycles:180 Average:25643.88 Median:3626.90 stddev:42240.06 (1164.6%) stddev-sans-first:42316.75 14:37:47 INFO - PROCESS | 1737 | Values: 617.5 716.8 768.5 810.6 812.5 14948.6 15578.8 15629.4 15644.6 15665.2 14201.4 14239.0 14255.0 14271.5 14422.1 657.9 815.3 825.8 840.4 845.1 710.3 854.5 855.6 855.7 856.4 908.0 908.8 909.2 913.6 914.8 692.8 890.2 907.1 907.9 916.1 667.6 668.7 671.2 671.4 671.5 14910.9 14918.6 14920.2 14939.0 14965.9 14437.1 14709.3 14728.7 14731.3 14843.9 11802.8 12093.2 12276.0 12280.3 12451.0 3740.9 3760.7 3950.9 3982.8 3996.8 105425.0 113629.0 114488.0 114757.0 116888.8 11286.0 11339.9 11413.1 11648.0 11905.3 23485.2 23502.5 23532.8 23545.8 23581.5 7457.3 7742.0 7805.5 7815.6 7852.6 3797.2 3856.9 4290.5 4371.1 4493.7 3404.4 3506.4 3510.1 3511.0 3512.9 579.7 587.2 588.8 589.1 589.1 496.4 532.8 532.9 576.0 702.9 8720.6 9252.8 9396.5 9493.2 9550.7 619.6 641.7 662.8 673.5 681.7 4455.9 4513.8 4612.5 4614.3 4629.8 160540.0 161899.0 161917.0 164728.0 166432.0 83856.0 101700.5 130205.7 142209.0 148172.3 119891.0 121156.4 125279.0 125982.4 126643.0 8679.4 8822.4 8828.1 8837.8 9041.6 58229.5 61337.0 61901.7 65631.3 67994.7 95246.5 101055.0 104629.4 105134.5 107481.0 11835.2 11935.8 11981.2 12262.6 12570.7 12967.2 13295.5 13455.4 13477.6 13497.0 11868.8 12301.4 12327.6 12450.3 12630.7 11907.1 12030.5 12148.4 12346.6 12453.2 11855.9 12001.6 12059.9 12080.3 12144.8 8287.5 9379.8 9583.7 9817.0 9882.5 8596.4 9449.5 10157.0 10176.8 10214.6 14:37:47 INFO - PROCESS | 1737 | -------- Summary: end -------- 14:37:47 INFO - PROCESS | 1737 | 14:37:48 INFO - TEST-INFO | 1737: exit 0 14:37:48 INFO - TEST-OK | dromaeo_css | took 1118575ms 14:37:48 INFO - TEST-START | kraken 14:37:48 INFO - operating with platform_type : mac_ 14:37:48 INFO - Initialising browser for kraken test... 14:37:48 INFO - TEST-INFO | started process 1855 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpxQw1nt/profile http://localhost:49262/getInfo.html) 14:37:50 INFO - PROCESS | 1855 | __metrics Screen width/height:1600/1200 14:37:50 INFO - PROCESS | 1855 | colorDepth:24 14:37:50 INFO - PROCESS | 1855 | Browser inner width/height: 1024/689 14:37:50 INFO - PROCESS | 1855 | __metrics 14:37:50 INFO - PROCESS | 1855 | 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" 14:37:50 INFO - PROCESS | 1855 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:37:51 INFO - TEST-INFO | 1855: exit 0 14:37:51 INFO - Browser initialized. 14:37:51 INFO - Running cycle 1/1 for kraken test... 14:37:51 INFO - TEST-INFO | started process 1856 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpxQw1nt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:03 INFO - PROCESS | 1856 | RSS: Main: 233353216 14:38:03 INFO - PROCESS | 1856 | 14:38:06 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:07 INFO - PROCESS | 1856 | RSS: Main: 291680256 14:38:07 INFO - PROCESS | 1856 | 14:38:09 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 14:38:10 INFO - PROCESS | 1856 | RSS: Main: 287674368 14:38:10 INFO - PROCESS | 1856 | 14:38:13 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 14:38:14 INFO - PROCESS | 1856 | RSS: Main: 378433536 14:38:14 INFO - PROCESS | 1856 | 14:38:16 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 14:38:17 INFO - PROCESS | 1856 | RSS: Main: 278601728 14:38:17 INFO - PROCESS | 1856 | 14:38:19 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:19 INFO - PROCESS | 1856 | RSS: Main: 282058752 14:38:19 INFO - PROCESS | 1856 | 14:38:22 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:23 INFO - PROCESS | 1856 | RSS: Main: 321200128 14:38:23 INFO - PROCESS | 1856 | 14:38:26 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:26 INFO - PROCESS | 1856 | RSS: Main: 321327104 14:38:26 INFO - PROCESS | 1856 | 14:38:29 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 14:38:30 INFO - PROCESS | 1856 | RSS: Main: 321683456 14:38:30 INFO - PROCESS | 1856 | 14:38:31 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:32 INFO - PROCESS | 1856 | RSS: Main: 297701376 14:38:32 INFO - PROCESS | 1856 | 14:38:34 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:34 INFO - PROCESS | 1856 | RSS: Main: 303833088 14:38:34 INFO - PROCESS | 1856 | 14:38:36 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:37 INFO - PROCESS | 1856 | RSS: Main: 302882816 14:38:37 INFO - PROCESS | 1856 | 14:38:40 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:41 INFO - PROCESS | 1856 | RSS: Main: 318443520 14:38:41 INFO - PROCESS | 1856 | 14:38:44 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:44 INFO - PROCESS | 1856 | RSS: Main: 314421248 14:38:44 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 14:38:46 INFO - PROCESS | 1856 | RSS: Main: 358363136 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | __start_tp_report 14:38:46 INFO - PROCESS | 1856 | _x_x_mozilla_page_load 14:38:46 INFO - PROCESS | 1856 | _x_x_mozilla_page_load_details 14:38:46 INFO - PROCESS | 1856 | |i|pagename|runs| 14:38:46 INFO - PROCESS | 1856 | |0;ai-astar;114;113;131;113;114;113;113;114;111;112 14:38:46 INFO - PROCESS | 1856 | |1;audio-beat-detection;146;118;111;157;123;156;150;102;197;135 14:38:46 INFO - PROCESS | 1856 | |2;audio-dft;184;183;186;182;182;185;179;181;180;183 14:38:46 INFO - PROCESS | 1856 | |3;audio-fft;77;73;76;152;56;58;58;71;138;57 14:38:46 INFO - PROCESS | 1856 | |4;audio-oscillator;82;85;133;69;73;73;118;69;69;117 14:38:46 INFO - PROCESS | 1856 | |5;imaging-gaussian-blur;93;129;91;87;90;87;91;88;91;87 14:38:46 INFO - PROCESS | 1856 | |6;imaging-darkroom;98;98;97;98;97;97;99;99;98;98 14:38:46 INFO - PROCESS | 1856 | |7;imaging-desaturate;84;86;84;84;83;86;86;86;85;84 14:38:46 INFO - PROCESS | 1856 | |8;json-parse-financial;54;53;55;54;53;54;53;53;53;54 14:38:46 INFO - PROCESS | 1856 | |9;json-stringify-tinderbox;65;64;81;76;71;70;68;71;68;70 14:38:46 INFO - PROCESS | 1856 | |10;stanford-crypto-aes;86;86;88;86;86;83;87;89;86;90 14:38:46 INFO - PROCESS | 1856 | |11;stanford-crypto-ccm;138;138;135;136;135;136;140;154;200;130 14:38:46 INFO - PROCESS | 1856 | |12;stanford-crypto-pbkdf2;175;171;174;186;238;203;170;171;171;170 14:38:46 INFO - PROCESS | 1856 | |13;stanford-crypto-sha256-iterative;66;68;68;68;68;67;67;67;67;65 14:38:46 INFO - PROCESS | 1856 | __end_tp_report 14:38:46 INFO - PROCESS | 1856 | __start_cc_report 14:38:46 INFO - PROCESS | 1856 | _x_x_mozilla_cycle_collect,2083 14:38:46 INFO - PROCESS | 1856 | __end_cc_report 14:38:46 INFO - PROCESS | 1856 | __startTimestamp1472247526748__endTimestamp 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | ------- Summary: start ------- 14:38:46 INFO - PROCESS | 1856 | Number of tests: 14 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#0] ai-astar Cycles:10 Average:114.80 Median:113.50 stddev:5.77 (5.1%) stddev-sans-first:6.11 14:38:46 INFO - PROCESS | 1856 | Values: 114.0 113.0 131.0 113.0 114.0 113.0 113.0 114.0 111.0 112.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:148.00 stddev:27.91 (18.9%) stddev-sans-first:29.50 14:38:46 INFO - PROCESS | 1856 | Values: 146.0 118.0 111.0 157.0 123.0 156.0 150.0 102.0 197.0 135.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:2.17 (1.2%) stddev-sans-first:2.24 14:38:46 INFO - PROCESS | 1856 | Values: 184.0 183.0 186.0 182.0 182.0 185.0 179.0 181.0 180.0 183.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#3] audio-fft Cycles:10 Average:81.60 Median:64.50 stddev:34.56 (53.6%) stddev-sans-first:36.62 14:38:46 INFO - PROCESS | 1856 | Values: 77.0 73.0 76.0 152.0 56.0 58.0 58.0 71.0 138.0 57.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:71.00 stddev:24.35 (34.3%) stddev-sans-first:25.71 14:38:46 INFO - PROCESS | 1856 | Values: 82.0 85.0 133.0 69.0 73.0 73.0 118.0 69.0 69.0 117.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:90.50 stddev:12.69 (14.0%) stddev-sans-first:13.45 14:38:46 INFO - PROCESS | 1856 | Values: 93.0 129.0 91.0 87.0 90.0 87.0 91.0 88.0 91.0 87.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:98.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 14:38:46 INFO - PROCESS | 1856 | Values: 98.0 98.0 97.0 98.0 97.0 97.0 99.0 99.0 98.0 98.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.50 stddev:1.14 (1.3%) stddev-sans-first:1.17 14:38:46 INFO - PROCESS | 1856 | Values: 84.0 86.0 84.0 84.0 83.0 86.0 86.0 86.0 85.0 84.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 14:38:46 INFO - PROCESS | 1856 | Values: 54.0 53.0 55.0 54.0 53.0 54.0 53.0 53.0 53.0 54.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:5.02 (7.1%) stddev-sans-first:4.92 14:38:46 INFO - PROCESS | 1856 | Values: 65.0 64.0 81.0 76.0 71.0 70.0 68.0 71.0 68.0 70.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.50 stddev:1.95 (2.3%) stddev-sans-first:2.05 14:38:46 INFO - PROCESS | 1856 | Values: 86.0 86.0 88.0 86.0 86.0 83.0 87.0 89.0 86.0 90.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:138.00 stddev:20.57 (14.9%) stddev-sans-first:21.70 14:38:46 INFO - PROCESS | 1856 | Values: 138.0 138.0 135.0 136.0 135.0 136.0 140.0 154.0 200.0 130.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:174.50 stddev:21.98 (12.6%) stddev-sans-first:23.13 14:38:46 INFO - PROCESS | 1856 | Values: 175.0 171.0 174.0 186.0 238.0 203.0 170.0 171.0 171.0 170.0 14:38:46 INFO - PROCESS | 1856 | 14:38:46 INFO - PROCESS | 1856 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:0.99 (1.5%) stddev-sans-first:0.97 14:38:46 INFO - PROCESS | 1856 | Values: 66.0 68.0 68.0 68.0 68.0 67.0 67.0 67.0 67.0 65.0 14:38:46 INFO - PROCESS | 1856 | -------- Summary: end -------- 14:38:46 INFO - PROCESS | 1856 | 14:38:47 INFO - TEST-INFO | 1856: exit 0 14:38:47 INFO - TEST-OK | kraken | took 59114ms 14:38:47 INFO - SUITE-END | took 1177s 14:38:47 INFO - Completed test suite (00:19:38) 14:38:47 INFO - javascript benchmark 14:38:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.845457727113, 3334.9499757503636, 3342.0809277448698, 3396.133985833612, 3420.8289585520733, 4801.591864691505, 5608.775648974041, 5620.831375058755, 5673.461021202989, 5687.573431992597, 5673.461021202989, 5685.573581981347, 5758.856028599287, 5797.855053623662, 5810.535157187425, 5129.410117836441, 5147.613928955325, 5199.766010529516, 5215.322008138936, 5309.203619457074, 5286.841394758144, 5308.522232999029, 5315.867103322428, 5331.333583302087, 5365.624406291561, 5149.0, 5157.226416037587, 5198.428172900978, 5222.086134926391, 5237.188235823415, 5217.634765566412, 5223.6343455958095, 5228.5555727763185, 5231.60762942777, 5232.3459567554055, 5146.871328216787, 5182.32629758129, 5196.272521846944, 5204.817831375922, 5225.320708307933, 5599.832005039814, 5668.348139963916, 5682.261306030231, 5790.594658373873, 5792.247007888947, 6218.782342617987, 6262.091996660504, 6275.215598050244, 6285.937140628581, 6300.21247344082, 6150.84622884427, 6255.906161407537, 6329.810105696836, 6332.398422149889, 6345.682715864188, 5716.628419152742, 5740.311162660424, 5755.654660720286, 5773.595848290579, 5788.594798364074, 6262.185915830913, 6270.153529273581, 6278.277998030285, 6282.842928926722, 6283.7800676976085, 5928.081147422156, 6059.878802423927, 6161.322254551996, 6173.722182501709, 6194.4115309045565, 6134.693265336716, 6195.19462469876, 6257.906131408033, 6272.6550039747335, 6295.653739044396, 6191.25704915413, 6192.969035154795, 6215.160953271341, 6216.285127210429, 6222.28443728977, 6099.420555047263, 6210.782622608187, 6226.719797609118, 6244.2819075805955, 6251.093591429309, 4866.6106711463, 4907.656464047483, 4919.434265059493, 4921.26181072842, 4939.3084968104495, 4313.439252897103, 4432.047109871329, 4463.531329210451, 4473.105378924228, 4473.3066374711325, 4923.75381230937, 5626.409227031103, 5647.068233741469, 5652.152177173375, 5655.3779084300695, 6107.267127944675, 6172.22847144107, 6175.84560385994, 6182.783602573978, 6199.442050215503, 5584.52531534816, 5588.357338905997, 5594.160875868571, 5596.524295434852, 5601.383847776741, 5310.468953104736, 5375.19372094189, 5393.325834270716, 5450.0, 5450.863728406822, 6366.0, 6366.586171898812, 6376.011718183689, 6382.585131966407, 6388.105665206875, 6236.376362363727, 6323.810285691437, 6330.208723909512, 6334.398232167937, 6335.239771227482, 6242.344553821783, 6266.592671476339, 6305.905411418924, 6315.936840631535, 6339.0, 6095.801078121576, 6120.479759220516, 6162.784302549389, 6170.074488826712, 6214.533909956681, 5622.803201887914, 6163.736434031102, 6289.591176573508, 6301.338359472373, 6306.369363063657, 6060.1212824139375, 6121.357257488078, 6150.661713605795, 6153.0, 6170.660613666291, 5923.466887980103, 5943.970280148572, 5965.343812180743, 6046.062860256668, 6153.169322141453, 4976.353074100344, 5888.528917686489, 5903.616264942765, 5939.673317967553, 6034.818955431168, 6118.923762351488, 6122.479351142269, 6169.352218017223, 6178.196834411498, 6182.629042257299, 5948.702564871653, 5963.761449541969, 5964.045752679551, 5981.431763982415, 6002.909956350745], "value": 5684.403617457011, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.3131724657869, 497.6591035140931, 514.8790034341929, 514.9588032957363, 521.8154788629813, 29923.70076299239, 38348.61651383485, 39497.605023949785, 39645.80177099118, 42070.36894446578, 41619.58380416195, 42104.0, 42206.0, 42228.15543689132, 42355.78822105885, 8695.478271303711, 9582.760430989229, 9781.364211326241, 9796.461194634292, 9798.706038818811, 8599.183077607617, 11816.7636647267, 12032.458539365749, 12036.398180091004, 12230.510779568807, 11862.0, 11912.868277513666, 11915.880841191607, 11915.880841191607, 11936.7612647747, 11924.940375298154, 12004.399780010965, 12005.379273798013, 12005.579804706837, 12015.038796896315, 11737.647870563811, 11812.818718128205, 11813.0, 11813.527458901634, 11814.763704725943, 38875.0, 39229.29248490199, 39241.0, 39267.607323926684, 39285.0, 3235.9352812943607, 3308.602967643874, 3438.9312213755834, 3483.6168021517615, 3667.651573100551, 29533.556996645068, 30126.24684382886, 30882.0, 30915.845420772977, 31028.53457198144, 3196.856141473616, 3199.536067270256, 3227.499737540685, 3319.6016478022552, 3326.6507016763135, 465206.0, 468594.0, 470362.0, 470843.0, 476388.0, 49169.0, 56071.87856242934, 56099.15851262234, 56240.5939851507, 56294.71852640711, 58034.0, 58092.41907580954, 58147.41852581505, 58264.70867645634, 58292.708536457896, 16029.278682459317, 16230.675386492205, 16245.268962896698, 16247.0, 16258.0, 11592.826107608393, 11836.289822610499, 12651.683707907376, 12803.743925121445, 12955.5465558705, 14085.366158522891, 14401.207933563755, 14703.55889323322, 14780.852191478163, 14834.851651483563, 6930.653467326714, 7066.3993560546905, 7163.856722865514, 7182.281771822776, 7212.3148300911325, 849.6728759427665, 942.5428667096453, 1013.1540163963173, 1063.984040239397, 1142.520141540555, 28267.57598636022, 28555.57166642502, 28854.134375968755, 29304.080491895016, 29717.0, 1030.5311083457009, 1038.8337865941412, 1050.4590136079926, 1075.725689949058, 1131.7889857852183, 13325.267110309027, 14326.49857255012, 15051.774223386657, 15235.009724367881, 15573.922130389275, 608495.0, 611105.0, 611670.0, 612730.0, 613829.0, 54829.45170548323, 54885.902281954935, 54969.45030549643, 55022.0, 55189.44810551843, 1242.1491278474275, 1359.0758284366725, 1382.9654258643413, 1397.895157863144, 1410.5063227870164, 29322.0, 30392.696073038987, 30712.692873070984, 30720.0, 31104.37791244117, 46850.76574617105, 47243.05513889772, 47259.0, 47387.52612473969, 47427.525724742314, 520864.0, 522243.0, 522309.3884530553, 522922.0, 523355.0, 24747.752522475264, 25396.365090872878, 25509.744902550738, 26019.535897461745, 26065.218043458728, 45362.319565205886, 45499.54500454953, 45578.16327550761, 46546.30180547227, 46667.29999050085, 31894.6810531901, 36483.0, 37514.249715006095, 37910.052248694, 39177.608223918534, 37362.43956340603, 37407.81296093502, 37848.889686777766, 38356.65751698677, 38791.0, 37377.62622373742, 37676.0, 38265.0, 38272.61727382691, 38395.80802095972, 32285.0, 33012.47451121499, 33310.83344583261, 33896.15259618431, 34192.0, 24628.50742985166, 24755.876220618782, 24857.0, 25443.491130177663, 25476.74523254818], "value": 19815.51362095585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.236484463869, 364.335088463554, 372.644124860758, 377.38109500419307, 400.0458905510359, 14775.63060923476, 15209.0, 20728.170873165072, 21068.157273709072, 21299.68050479244, 18401.343879050884, 19923.50191245216, 20556.588868222625, 20697.0, 21556.814375209357, 5301.860100078482, 5796.188533605288, 5962.612430192045, 6116.663583502906, 6131.0, 3540.3627347077518, 4087.1417002429525, 5956.910646340287, 6070.848228794272, 6757.7972660820005, 6724.865502689943, 6731.427828634572, 6733.0, 6742.123523941881, 6774.7290108395855, 6418.614883107005, 6596.274409814917, 6663.800085997428, 6674.8319044167565, 6791.422729068036, 4631.8378856739855, 5765.971170144165, 5769.826905192851, 5777.5666824987875, 5785.392533783935, 25493.235202943757, 25615.743842561522, 25666.871665641553, 25929.092481763237, 25957.74042259572, 2130.041481333406, 2203.966940495894, 2209.436593668604, 2562.7821635161035, 2606.452644944564, 9727.756806079904, 10250.9487452563, 10349.896501035044, 10363.378197308186, 10385.688429347056, 1842.7788665360108, 1858.256697321069, 1859.5072305838964, 1886.2737845929278, 1965.1058768260407, 119762.0, 121151.78848211493, 122640.38679806633, 122831.15753263798, 125951.0, 11212.775744485229, 11523.250988685708, 11552.6534203974, 11561.942190289163, 11744.236624619372, 12831.807522887164, 13363.665908352368, 13480.528181513797, 14258.572242832732, 14289.928550357181, 8386.454880432751, 8515.594926837126, 8544.273736732448, 8662.913370866338, 8723.651053957898, 8462.0, 8510.234078932926, 8513.702020429255, 8644.524551149621, 8684.522351270742, 4395.7362558246605, 4476.350929115325, 4489.461264648263, 4557.772111394417, 4567.908641827211, 1843.4285371534868, 1885.7333048519295, 1905.4569447707338, 1909.2935613822974, 1953.1796645408963, 845.6532821543137, 879.4723166100416, 925.047201382577, 967.8596603492454, 1039.7296702857311, 21111.366659000254, 21712.457188570414, 21720.78279217219, 21781.0, 21784.237551685615, 889.3596610440472, 899.3165194452133, 931.3713243560569, 952.851813564653, 964.8793900762405, 11061.778764424667, 11213.046891014355, 11279.943600281946, 11309.0, 11326.886731132583, 460883.0, 474310.0, 547162.0, 559567.0, 563419.0, 118139.40930295293, 121735.39132304282, 123899.0, 124072.0, 127108.0, 917.6925729880431, 941.0777438110553, 953.9046095390544, 954.9331546791797, 964.8842138943231, 18019.094266742493, 18870.71693924565, 19076.713849291995, 19292.13185406632, 19298.71051934194, 54927.0, 54983.0, 55304.0, 55869.0, 56064.15903761365, 77654.0, 78712.60643696744, 78722.6063869677, 78890.21109788828, 78919.60540197263, 7858.135605083322, 8035.834803953511, 8072.910157128713, 8285.792855178668, 8534.78663033429, 11056.281341712764, 12291.508339666314, 12612.243265403738, 12646.494140234288, 12882.67793305175, 11332.263402878787, 11420.31478111316, 11672.941635291769, 11674.591389301333, 11713.180077394842, 10549.578016879239, 10667.679969600924, 10691.251612387057, 10863.837042444527, 10943.671689849318, 11581.536738530365, 11665.0, 11705.707357316136, 11820.70448238801, 11940.522379105087, 7077.0, 7147.678354474165, 7354.96322518384, 7433.293837085468, 8434.451760635538, 9057.094112045937, 11706.70733231676, 11846.763064738485, 11893.286402815858, 11898.524059037542], "value": 9558.287098676576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1116.5645398294662, 1417.5888992192265, 1500.1973943939995, 1665.1674162918541, 1875.2030387085495, 7722.266384693459, 8366.748997530076, 8667.826643467128, 8679.869801952977, 8717.564121793908, 8382.497050176993, 8569.200467901748, 8577.785555361119, 8653.956730216356, 8683.869741953877, 2326.081197926818, 2377.940551486209, 2378.714554253483, 2379.3100000999775, 2380.809535237177, 2305.527366889792, 2339.251439539348, 2360.0, 2367.147826782357, 2372.525494901018, 2339.7543257957923, 2355.752645972174, 2358.705161854768, 2374.050379848057, 2377.049180327874, 2299.1263319938485, 2323.5585238804656, 2324.244620498336, 2326.755690652474, 2339.859608423483, 2319.976800231993, 2324.070371851273, 2329.7670232976734, 2331.044271848551, 2332.5684748321614, 8382.916170838274, 8656.523891185981, 8724.302055835582, 8735.08281630426, 8753.693620723308, 5172.301739265189, 5321.787128514855, 5342.0651386007685, 5370.5435038021815, 5371.0, 3543.0965103898598, 3544.2557063016798, 3604.9459258110887, 3618.2220822523022, 3619.9095022624647, 931.9953400233023, 1073.4686330266568, 1076.6769969009265, 1082.577794660083, 1097.434821067151, 11360.977512023957, 11430.485628146753, 11505.712357191138, 11525.596604118815, 11542.134339924456, 4083.8570650027104, 4497.662675299365, 4581.335706322565, 4646.907061858811, 4843.467218605951, 9943.15483183923, 9944.303898727165, 9952.00479951999, 9960.651377201762, 9976.401415915068, 5264.710440925785, 5359.732013399314, 5367.409584945653, 5370.946290537123, 5371.811986580529, 4375.453068366454, 4396.538363471854, 4562.703424277412, 4735.502772208937, 4872.512748725099, 3906.0625449891822, 3942.8422863085157, 4038.45480860086, 4067.1662309226535, 4067.9796601017397, 1279.4690203565601, 1302.8110923915979, 1308.0974127851753, 1311.7573248948975, 1317.6823176823177, 848.1687945813014, 865.9263962563126, 897.6588896219525, 902.9458232506071, 958.9280803939732, 5510.338759348904, 5608.971955140199, 5872.823815285548, 5930.525557955353, 6032.426919442646, 920.2086205862953, 925.9398139120935, 937.8921424036187, 945.4847108325979, 963.8457846744627, 3790.6967442604528, 3828.655421012122, 3828.8704832074604, 3944.171723938005, 3968.3650615901315, 10444.738881528023, 10681.679549613524, 10777.83833242502, 10798.460076996118, 10816.891831081588, 10712.678619641423, 10724.89275107239, 10739.570417183382, 10751.83872241917, 10752.569897204181, 7660.61696915152, 8028.879566806502, 8035.0, 8056.919430805617, 8192.385571082194, 5843.831233753182, 5910.758740664509, 5957.91063134062, 5986.132010858314, 5992.490638295793, 9816.116549510578, 10049.799004020026, 10059.597616095274, 10067.446290454096, 10078.042585954323, 8887.933447986024, 9517.857232141385, 10102.797944041225, 10235.130013948898, 10292.382457052601, 7327.780166595011, 7421.8144546386775, 7426.331630153312, 7525.510841795266, 7534.886976695464, 8088.231617996281, 8151.877721834296, 8167.918320816716, 8170.591470426574, 8186.181381862004, 7163.7492687755675, 7406.07424071991, 7417.592032438052, 7418.480706350504, 7473.738419155304, 7140.464465165237, 7257.455690823103, 7276.599787011765, 7317.304856038668, 7473.17795042534, 6815.386615204656, 6937.3062693732245, 6944.4444444445335, 6945.583265004116, 6972.6513674315065, 4847.756808005848, 4928.236123400879, 4970.577500912318, 5004.974975125101, 5085.872853178552, 4229.97885010573, 4382.123575284892, 4876.804927802848, 5064.037832811754, 5191.325127733521], "value": 4548.68252398051, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.31277965949505, 298.6326818013843, 308.7715090832784, 313.24039204928044, 315.4605624382306, 4151.31871592005, 5342.305500284962, 5348.73256337183, 5367.597430192742, 5404.324459442565, 5192.71440070796, 5243.0, 5244.39689435715, 5336.813211537587, 5348.759305831237, 3612.6929211016964, 3773.33966555853, 4068.5931406859227, 4098.938515922264, 4112.527059388164, 3653.2328211075705, 3663.6519530644678, 3769.905752356199, 3999.5800440953717, 4065.715399922007, 3993.660538854186, 4048.4534587830562, 4057.797110144496, 4063.4920634920636, 4066.3493840985448, 3504.5794504659348, 3701.148735790783, 4024.7786371749544, 4038.5961403859524, 4055.371417430303, 2799.6080548723194, 3447.413939630244, 3563.893083207482, 3575.2827850833555, 3584.5698516177963, 4340.696151269412, 4439.933400998988, 5060.443351231362, 5207.453217412155, 5224.309480617485, 4066.5120185577625, 4597.862064138081, 4617.629130734549, 4627.976860115711, 4646.86059418218, 4815.771978145585, 5105.902231020348, 5194.584433245369, 5452.563794896439, 5506.256655351556, 3278.5246139309666, 3386.847591858372, 3662.6154253803234, 3770.7926064066464, 3845.5193100862393, 5011.924821127686, 5183.248428977777, 5650.039493286151, 5741.62679425836, 5792.335525658203, 3447.3105378924315, 3872.361060425055, 3916.6475017248586, 3920.0, 3963.9405408918888, 3371.005553361715, 3654.1778099927305, 3761.4545890845675, 4036.1725846201457, 4037.3338399164395, 3523.3834079036064, 4390.517043125254, 4490.326451032306, 4536.591706746409, 4574.359589657451, 5510.669359838423, 5514.601148500416, 5525.530329921921, 5550.750216240279, 5561.888762224733, 1133.195431243826, 1145.7364806094645, 1211.6304527119137, 1263.128441375448, 1302.5441095616459, 871.1549796697194, 877.9034306226438, 898.8876390451194, 901.6213190460022, 908.9547020925855, 4288.871333859989, 5091.261767043758, 5091.261767043832, 5100.923486147711, 5108.948910510847, 4687.742174180385, 4805.014971930746, 4863.878403039952, 4942.579880710108, 5712.0, 4646.558576935186, 4787.952120478821, 5054.620903432257, 5111.233315002779, 5119.48805119485, 2169.7721739217473, 2193.8683678979314, 2428.817838662072, 2535.239428171541, 2549.763364768123, 4122.537068862171, 4500.887477813081, 4618.422697162855, 4794.95205047952, 4970.850874473772, 4193.203291374629, 4760.0, 4818.566329030404, 4820.566149046603, 4903.926441103386, 3861.5945325740954, 3936.4488971544006, 4197.488903994559, 4579.923717926285, 4686.055287055834, 4192.895177620584, 4368.801126659266, 4574.954250457453, 4879.731614761222, 4886.682365646222, 4221.788910554522, 4290.334998075304, 4384.81609965314, 4689.296605509065, 4723.976380118077, 4346.6088052075465, 5410.78356865721, 5962.658401859547, 6018.247719035121, 6057.394260573908, 3809.219110082482, 3833.4824798651825, 3833.754029940225, 3840.57753647093, 3847.5575308839843, 4828.0, 5220.817271395483, 5383.573353061363, 5920.259967504062, 5923.911141332969, 4951.8266860659705, 5086.745662716923, 5642.322921249476, 5694.886102277848, 5710.486056254957, 5333.986542556901, 5579.7489112990825, 5582.609217354746, 5598.272224610774, 5677.460641239076, 4260.957390426056, 4621.976890115528, 5002.674826136289, 5206.765695543634, 5471.470901268739, 4750.788548920003, 5569.610127291051, 5603.926547177571, 5615.578831587729, 5627.971860140673, 5393.110136827537, 5497.175423686479, 5510.366307874486, 5517.558595312285, 5558.805441809517], "value": 3877.714316864717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.5461036138438, 716.7813816785881, 768.5081547809403, 810.6061730777798, 812.5246730662562, 14948.551543453686, 15578.844211557882, 15629.374825007015, 15644.608884777886, 15665.216739163054, 14201.360938757754, 14239.0, 14255.0, 14271.500497482564, 14422.062565933207, 657.9276279609239, 815.3355015662246, 825.7564018614509, 840.369722707969, 845.0957475501185, 710.3287393413226, 854.5214679779313, 855.632078206371, 855.6791203298762, 856.4347530629785, 908.0011986814517, 908.8091500784843, 909.231699214163, 913.5569248914271, 914.7621618379236, 692.8129405060631, 890.1676932068472, 907.1427501011547, 907.850204716221, 916.1159481100703, 667.6361383046251, 668.6556423441931, 671.1912145864222, 671.4460570029745, 671.4728937783865, 14910.850891491054, 14918.552443426715, 14920.179390133539, 14939.0, 14965.925170374187, 14437.06159099655, 14709.338079786328, 14728.705425891529, 14731.263436828116, 14843.851561484355, 11802.763944721057, 12093.213941093802, 12276.0, 12280.324582147978, 12451.007838745847, 3740.906477338061, 3760.699144068468, 3950.9012274693364, 3982.8406863725418, 3996.840126394941, 105425.0, 113629.0, 114488.0, 114757.0, 116888.83111168865, 11286.0, 11339.943300283447, 11413.086953043736, 11648.0, 11905.345206013579, 23485.178018769602, 23502.529949401258, 23532.764672353398, 23545.764542354358, 23581.528369432515, 7457.291557302047, 7741.961290193625, 7805.492642978188, 7815.609219539114, 7852.646630901509, 3797.1646237827636, 3856.8842934712, 4290.549492303326, 4371.103923695635, 4493.707908985905, 3404.3701915145284, 3506.386382383073, 3510.140015696171, 3510.982445087809, 3512.8946131616094, 579.7246308003664, 587.1574290892582, 588.7556663984484, 589.0633892111478, 589.1104432307247, 496.37952559300874, 532.7968848810198, 532.8561288452096, 575.9654420734769, 702.8929436138103, 8720.607572659246, 9252.768680783034, 9396.530173491297, 9493.240540756722, 9550.713478595653, 619.6127420362274, 641.6631268583938, 662.7542997177384, 673.5115394977155, 681.6843492060372, 4455.933161002587, 4513.751743654065, 4612.5156858530045, 4614.284785858197, 4629.8148074077335, 160540.0, 161899.0, 161917.0, 164728.0, 166432.02111809753, 83856.0, 101700.49149754204, 130205.69794302125, 142209.0, 148172.2591387036, 119891.0, 121156.39421802835, 125279.0, 125982.37008814898, 126642.99999999815, 8679.435333070744, 8822.382433229868, 8828.073052329413, 8837.779055523662, 9041.638334466548, 58229.54426139211, 61337.0, 61901.69049154905, 65631.34368656253, 67994.66002669955, 95246.52376738071, 101055.0, 104629.4305585432, 105134.47432762788, 107481.0, 11835.230710003822, 11935.761284774082, 11981.221220620631, 12262.570810021607, 12570.685732856751, 12967.22196668203, 13295.468181272641, 13455.394507247001, 13477.595672129852, 13497.0, 11868.762624747284, 12301.384930753247, 12327.630171094881, 12450.25298482094, 12630.747385052064, 11907.106966977684, 12030.518779248732, 12148.39258037077, 12346.629601111981, 12453.1905426147, 11855.940720296343, 12001.579944701894, 12059.879401206226, 12080.275183489019, 12144.75710485803, 8287.544185069879, 9379.765505862408, 9583.712488625353, 9817.0, 9882.505874706092, 8596.355273354398, 9449.527523623929, 10157.0, 10176.796464070825, 10214.642487512901], "value": 7670.176903835016, "unit": "score"}], "name": "dromaeo_css", "value": 7253.778492163613, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 131.0, 113.0, 114.0, 113.0, 113.0, 114.0, 111.0, 112.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 111.0, 157.0, 123.0, 156.0, 150.0, 102.0, 197.0, 135.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 186.0, 182.0, 182.0, 185.0, 179.0, 181.0, 180.0, 183.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 76.0, 152.0, 56.0, 58.0, 58.0, 71.0, 138.0, 57.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 133.0, 69.0, 73.0, 73.0, 118.0, 69.0, 69.0, 117.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 129.0, 91.0, 87.0, 90.0, 87.0, 91.0, 88.0, 91.0, 87.0], "value": 93.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 97.0, 98.0, 97.0, 97.0, 99.0, 99.0, 98.0, 98.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 84.0, 83.0, 86.0, 86.0, 86.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 55.0, 54.0, 53.0, 54.0, 53.0, 53.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 81.0, 76.0, 71.0, 70.0, 68.0, 71.0, 68.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 88.0, 86.0, 86.0, 83.0, 87.0, 89.0, 86.0, 90.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 135.0, 136.0, 135.0, 136.0, 140.0, 154.0, 200.0, 130.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 174.0, 186.0, 238.0, 203.0, 170.0, 171.0, 171.0, 170.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1488.1999999999998, "alertThreshold": 2.0}]} 14:38:47 INFO - Return code: 0 14:38:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:38:48 INFO - # TBPL SUCCESS # 14:38:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:38:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:38:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:38:48 INFO - 2016-08-26 14:38:48.079 screenresolution[1866:10576] starting screenresolution argv=screenresolution get 14:38:48 INFO - 2016-08-26 14:38:48.081 screenresolution[1866:10576] Display 0: 1600x1200x32@60 14:38:48 INFO - 2016-08-26 14:38:48.087 screenresolution[1867:10579] starting screenresolution argv=screenresolution list 14:38:48 INFO - Available Modes on Display 0 14:38:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:38:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:38:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:38:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:38:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:38:48 INFO - Intel Iris: 14:38:48 INFO - Chipset Model: Intel Iris 14:38:48 INFO - Type: GPU 14:38:48 INFO - Bus: Built-In 14:38:48 INFO - VRAM (Dynamic, Max): 1536 MB 14:38:48 INFO - Vendor: Intel (0x8086) 14:38:48 INFO - Device ID: 0x0a2e 14:38:48 INFO - Revision ID: 0x0009 14:38:48 INFO - Displays: 14:38:48 INFO - Display: 14:38:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:38:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:38:48 INFO - Display Serial Number: 1600x1200 60 14:38:48 INFO - Main Display: Yes 14:38:48 INFO - Mirror: Off 14:38:48 INFO - Online: Yes 14:38:48 INFO - Rotation: Supported 14:38:48 INFO - Return code: 0 14:38:48 INFO - Running post-action listener: _resource_record_post_action 14:38:48 INFO - [mozharness: 2016-08-26 21:38:48.324513Z] Finished run-tests step (success) 14:38:48 INFO - Running post-run listener: _resource_record_post_run 14:38:48 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31480832; Write bytes: 707990528; Read time: 195; Write time: 2037 14:38:48 INFO - TinderboxPrint: CPU usage
53.6% 14:38:48 INFO - TinderboxPrint: I/O read bytes / time
31,480,832 / 195 14:38:48 INFO - TinderboxPrint: I/O write bytes / time
707,990,528 / 2,037 14:38:48 INFO - TinderboxPrint: CPU idle
2,252.6 (46.4%) 14:38:48 INFO - TinderboxPrint: CPU system
972.4 (20.0%) 14:38:48 INFO - TinderboxPrint: CPU user
1,628.5 (33.6%) 14:38:48 INFO - TinderboxPrint: Swap in / out
433,631,232 / 0 14:38:48 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392362496; Write bytes: 386729472; Read time: 29203; Write time: 802 14:38:48 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30542848; Write bytes: 299236864; Read time: 182; Write time: 1184 14:38:48 INFO - Running post-run listener: _upload_blobber_files 14:38:48 INFO - Blob upload gear active. 14:38:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:48 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 14:38:48 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'] 14:38:48 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 14:38:49 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:49 INFO - (blobuploader) - INFO - Done attempting. 14:38:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:50 INFO - (blobuploader) - INFO - Done attempting. 14:38:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:38:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:53 INFO - (blobuploader) - INFO - Done attempting. 14:38:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:53 INFO - Return code: 0 14:38:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a6d786bf47ca2982edc7a6b19288495ea981ec308aa0bb55dbb321ef285923b57b7a4f6f9e3ad23b9c644d3333130f731b427f0b6b0ced90432ea39d895a34a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d423153fa05cf0b2485fa6e8526024fb6d36d18004efc40d5f775171451fed6a4d6e57884e7d1fbd44580cc8ebd9ab81bf141365bae3fbdbd893019141899e20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f4d39bd24f05fe45defa55e96519696a433bffc0fbc8c0e2d113232c98601c0eb36f5fc826b05ca1b8922ec8ea09235c9d6ae1dd486c618248ed74fc98d71bf"} 14:38:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:53 INFO - Contents: 14:38:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a6d786bf47ca2982edc7a6b19288495ea981ec308aa0bb55dbb321ef285923b57b7a4f6f9e3ad23b9c644d3333130f731b427f0b6b0ced90432ea39d895a34a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d423153fa05cf0b2485fa6e8526024fb6d36d18004efc40d5f775171451fed6a4d6e57884e7d1fbd44580cc8ebd9ab81bf141365bae3fbdbd893019141899e20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f4d39bd24f05fe45defa55e96519696a433bffc0fbc8c0e2d113232c98601c0eb36f5fc826b05ca1b8922ec8ea09235c9d6ae1dd486c618248ed74fc98d71bf"} 14:38:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:53 INFO - Copying logs to upload dir... 14:38:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.728341 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-26 14:38:53.396874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 14:38:53.400407) ========= 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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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/6a6d786bf47ca2982edc7a6b19288495ea981ec308aa0bb55dbb321ef285923b57b7a4f6f9e3ad23b9c644d3333130f731b427f0b6b0ced90432ea39d895a34a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d423153fa05cf0b2485fa6e8526024fb6d36d18004efc40d5f775171451fed6a4d6e57884e7d1fbd44580cc8ebd9ab81bf141365bae3fbdbd893019141899e20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f4d39bd24f05fe45defa55e96519696a433bffc0fbc8c0e2d113232c98601c0eb36f5fc826b05ca1b8922ec8ea09235c9d6ae1dd486c618248ed74fc98d71bf"} build_url:https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/PFv2TWZbQl29xxl0w5Q4mw/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/6a6d786bf47ca2982edc7a6b19288495ea981ec308aa0bb55dbb321ef285923b57b7a4f6f9e3ad23b9c644d3333130f731b427f0b6b0ced90432ea39d895a34a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d423153fa05cf0b2485fa6e8526024fb6d36d18004efc40d5f775171451fed6a4d6e57884e7d1fbd44580cc8ebd9ab81bf141365bae3fbdbd893019141899e20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f4d39bd24f05fe45defa55e96519696a433bffc0fbc8c0e2d113232c98601c0eb36f5fc826b05ca1b8922ec8ea09235c9d6ae1dd486c618248ed74fc98d71bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 14:38:53.433787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 14:38:53.434124) ========= 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.SjciwRs4Xk/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.TWHNE16Zc3/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.004881 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 14:38:53.483111) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 14:38:53.483428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 14:38:53.483773) ========= ========= Total master_lag: 0.31 =========