builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0030 starttime: 1471504954.61 results: success (0) buildid: 20160817222415 builduid: dcf6f576d4e547ff9a98639b63032e67 revision: f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:34.606078) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:34.606975) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:34.607623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:34.643636) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:34.643979) ========= 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.CEFcdKdajG/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.IVCriRLRg8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-18 00:22:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.1M=0s 2016-08-18 00:22:35 (25.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.516307 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:35.183874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:35.184218) ========= 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.CEFcdKdajG/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.IVCriRLRg8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.029101 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:35.234328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:35.234724) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CEFcdKdajG/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.IVCriRLRg8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-18 00:22:35,216 truncating revision to first 12 chars 2016-08-18 00:22:35,217 Setting DEBUG logging. 2016-08-18 00:22:35,217 attempt 1/10 2016-08-18 00:22:35,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f5ed7f38160e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 00:22:35,884 unpacking tar archive at: autoland-f5ed7f38160e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933863 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:36.193461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:36.193994) ========= script_repo_revision: f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:36.194660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:36.195136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 00:22:36.215542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-08-18 00:22:36.215935) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CEFcdKdajG/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.IVCriRLRg8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:22:36 INFO - MultiFileLogger online at 20160818 00:22:36 in /builds/slave/test 00:22:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 00:22:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:22:36 INFO - {'append_to_log': False, 00:22:36 INFO - 'base_work_dir': '/builds/slave/test', 00:22:36 INFO - 'blob_upload_branch': 'Autoland', 00:22:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:22:36 INFO - 'branch': 'Autoland', 00:22:36 INFO - 'buildbot_json_path': 'buildprops.json', 00:22:36 INFO - 'config_files': ('talos/mac_config.py',), 00:22:36 INFO - 'default_actions': ('clobber', 00:22:36 INFO - 'read-buildbot-config', 00:22:36 INFO - 'download-and-extract', 00:22:36 INFO - 'populate-webroot', 00:22:36 INFO - 'create-virtualenv', 00:22:36 INFO - 'install', 00:22:36 INFO - 'run-tests'), 00:22:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:22:36 INFO - 'download_minidump_stackwalk': True, 00:22:36 INFO - 'download_symbols': 'ondemand', 00:22:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:22:36 INFO - 'tooltool.py': '/tools/tooltool.py', 00:22:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:22:36 INFO - '/tools/misc-python/virtualenv.py')}, 00:22:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:22:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:22:36 INFO - 'installer_path': 'installer.exe', 00:22:36 INFO - 'log_level': 'info', 00:22:36 INFO - 'log_name': 'talos', 00:22:36 INFO - 'log_to_console': True, 00:22:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:22:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:22:36 INFO - 'opt_config_files': (), 00:22:36 INFO - 'pip_index': False, 00:22:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:22:36 INFO - 'cmd': ('bash', 00:22:36 INFO - '-c', 00:22:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:22:36 INFO - 'enabled': True, 00:22:36 INFO - 'halt_on_failure': False, 00:22:36 INFO - 'name': 'check_screen_resolution'},), 00:22:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:22:36 INFO - 'cmd': ('bash', 00:22:36 INFO - '-c', 00:22:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:22:36 INFO - 'enabled': True, 00:22:36 INFO - 'halt_on_failure': False, 00:22:36 INFO - 'name': 'check_screen_resolution'},), 00:22:36 INFO - 'run_cmd_checks_enabled': True, 00:22:36 INFO - 'sps_profile': False, 00:22:36 INFO - 'sps_profile_interval': 0, 00:22:36 INFO - 'suite': 'dromaeojs', 00:22:36 INFO - 'system_bits': '32', 00:22:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:22:36 INFO - 'title': 't-yosemite-r7-0030', 00:22:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:22:36 INFO - 'use_talos_json': True, 00:22:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:22:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:22:36 INFO - 'work_dir': 'build'} 00:22:36 INFO - [mozharness: 2016-08-18 07:22:36.317286Z] Running clobber step. 00:22:36 INFO - Running pre-action listener: _resource_record_pre_action 00:22:36 INFO - Running main action method: clobber 00:22:36 INFO - rmtree: /builds/slave/test/build 00:22:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:22:38 INFO - Running post-action listener: _resource_record_post_action 00:22:38 INFO - [mozharness: 2016-08-18 07:22:38.435459Z] Finished clobber step (success) 00:22:38 INFO - [mozharness: 2016-08-18 07:22:38.435583Z] Running read-buildbot-config step. 00:22:38 INFO - Running pre-action listener: _resource_record_pre_action 00:22:38 INFO - Running main action method: read_buildbot_config 00:22:38 INFO - Using buildbot properties: 00:22:38 INFO - { 00:22:38 INFO - "project": "", 00:22:38 INFO - "product": "firefox", 00:22:38 INFO - "script_repo_revision": "production", 00:22:38 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 00:22:38 INFO - "repository": "", 00:22:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 00:22:38 INFO - "buildid": "20160817222415", 00:22:38 INFO - "pgo_build": "False", 00:22:38 INFO - "basedir": "/builds/slave/test", 00:22:38 INFO - "buildnumber": 105, 00:22:38 INFO - "slavename": "t-yosemite-r7-0030", 00:22:38 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 00:22:38 INFO - "platform": "yosemite_r7", 00:22:38 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 00:22:38 INFO - "branch": "autoland", 00:22:38 INFO - "repo_path": "integration/autoland", 00:22:38 INFO - "revision": "f5ed7f38160ed375a0ea04eb2ac847983b1da2f1", 00:22:38 INFO - "stage_platform": "macosx64", 00:22:38 INFO - "builduid": "dcf6f576d4e547ff9a98639b63032e67", 00:22:38 INFO - "slavebuilddir": "test" 00:22:38 INFO - } 00:22:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 00:22:38 INFO - Running post-action listener: _resource_record_post_action 00:22:38 INFO - [mozharness: 2016-08-18 07:22:38.439103Z] Finished read-buildbot-config step (success) 00:22:38 INFO - [mozharness: 2016-08-18 07:22:38.439232Z] Running download-and-extract step. 00:22:38 INFO - Running pre-action listener: _resource_record_pre_action 00:22:38 INFO - Running main action method: download_and_extract 00:22:38 INFO - mkdir: /builds/slave/test/build/tests 00:22:38 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')]} 00:22:38 INFO - trying https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 00:22:38 INFO - Downloading https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:22:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:22:39 INFO - Downloaded 1199 bytes. 00:22:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 00:22:39 INFO - Using the following test package requirements: 00:22:39 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:22:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:39 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 00:22:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:39 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 00:22:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:39 INFO - u'jsshell-mac.zip'], 00:22:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:39 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 00:22:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 00:22:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:39 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 00:22:39 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:39 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 00:22:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:39 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 00:22:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 00:22:39 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 00:22:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:22:39 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')]} 00:22:39 INFO - trying https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:22:39 INFO - Downloading https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:22:40 INFO - Downloaded 16339408 bytes. 00:22:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 00:22:47 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 00:22:47 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')]} 00:22:47 INFO - trying https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 00:22:47 INFO - Downloading https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:22:48 INFO - Downloaded 16339408 bytes. 00:22:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 00:22:54 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')]} 00:22:54 INFO - trying https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 00:22:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:22:55 INFO - Downloaded 14413981 bytes. 00:22:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 00:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:22:56 INFO - trying https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:22:56 INFO - Downloading https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 00:22:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/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 00:23:01 INFO - Downloaded 111261602 bytes. 00:23:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:23:01 INFO - mkdir: /builds/slave/test/properties 00:23:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:23:01 INFO - Writing to file /builds/slave/test/properties/build_url 00:23:01 INFO - Contents: 00:23:01 INFO - build_url:https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 00:23:01 INFO - Running post-action listener: _resource_record_post_action 00:23:01 INFO - Running post-action listener: set_extra_try_arguments 00:23:01 INFO - [mozharness: 2016-08-18 07:23:01.888119Z] Finished download-and-extract step (success) 00:23:01 INFO - [mozharness: 2016-08-18 07:23:01.888247Z] Running populate-webroot step. 00:23:01 INFO - Running pre-action listener: _resource_record_pre_action 00:23:01 INFO - Running main action method: populate_webroot 00:23:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:23:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:23:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:23:01 INFO - '--tppagecycles', 00:23:01 INFO - '7'], 00:23:01 INFO - 'tests': ['tsvgm']}}, 00:23:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:23:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:23:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:23:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:23:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:01 INFO - 'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:23:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:01 INFO - 'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['damp', 'tps']}, 00:23:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:01 INFO - 'tests': ['damp', 'tps']}, 00:23:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['dromaeo_dom']}, 00:23:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:23:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['basic_compositor_video']}, 00:23:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:23:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['a11yr', 00:23:01 INFO - 'ts_paint', 00:23:01 INFO - 'tpaint', 00:23:01 INFO - 'sessionrestore', 00:23:01 INFO - 'sessionrestore_no_auto_restore', 00:23:01 INFO - 'tabpaint']}, 00:23:01 INFO - 'other-e10s': {'tests': ['a11yr', 00:23:01 INFO - 'ts_paint', 00:23:01 INFO - 'tpaint', 00:23:01 INFO - 'sessionrestore', 00:23:01 INFO - 'sessionrestore_no_auto_restore', 00:23:01 INFO - 'tabpaint']}, 00:23:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:23:01 INFO - 'ts_paint', 00:23:01 INFO - 'tpaint', 00:23:01 INFO - 'sessionrestore', 00:23:01 INFO - 'sessionrestore_no_auto_restore', 00:23:01 INFO - 'tabpaint']}, 00:23:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:23:01 INFO - 'ts_paint', 00:23:01 INFO - 'tpaint', 00:23:01 INFO - 'sessionrestore', 00:23:01 INFO - 'sessionrestore_no_auto_restore', 00:23:01 INFO - 'tabpaint']}, 00:23:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['a11yr', 00:23:01 INFO - 'ts_paint', 00:23:01 INFO - 'tpaint', 00:23:01 INFO - 'sessionrestore', 00:23:01 INFO - 'sessionrestore_no_auto_restore', 00:23:01 INFO - 'tabpaint']}, 00:23:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['a11yr', 00:23:01 INFO - 'ts_paint', 00:23:01 INFO - 'tpaint', 00:23:01 INFO - 'sessionrestore', 00:23:01 INFO - 'sessionrestore_no_auto_restore', 00:23:01 INFO - 'tabpaint']}, 00:23:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['tsvgx', 00:23:01 INFO - 'tsvgr_opacity', 00:23:01 INFO - 'tart', 00:23:01 INFO - 'tscrollx', 00:23:01 INFO - 'cart']}, 00:23:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:23:01 INFO - 'tsvgr_opacity', 00:23:01 INFO - 'tart', 00:23:01 INFO - 'tscrollx', 00:23:01 INFO - 'cart']}, 00:23:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:01 INFO - 'talos_options': ['--disable-e10s'], 00:23:01 INFO - 'tests': ['tp5o']}, 00:23:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:01 INFO - 'tests': ['tp5o']}, 00:23:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:01 INFO - 'talos_options': ['--disable-e10s', 00:23:01 INFO - '--xperf_path', 00:23:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:01 INFO - 'tests': ['tp5n']}, 00:23:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:23:01 INFO - 'talos_options': ['--xperf_path', 00:23:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:23:01 INFO - 'tests': ['tp5n']}}, 00:23:01 INFO - 'talos.zip': {'path': '', 00:23:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:23:01 INFO - Running post-action listener: _resource_record_post_action 00:23:01 INFO - [mozharness: 2016-08-18 07:23:01.907591Z] Finished populate-webroot step (success) 00:23:01 INFO - [mozharness: 2016-08-18 07:23:01.907737Z] Running create-virtualenv step. 00:23:01 INFO - Running pre-action listener: _resource_record_pre_action 00:23:01 INFO - Running main action method: create_virtualenv 00:23:01 INFO - Creating virtualenv /builds/slave/test/build/venv 00:23:01 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 00:23:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:23:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:23:02 INFO - Using real prefix '/tools/python27' 00:23:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:23:02 INFO - Installing distribute.............................................................................................................................................................................................done. 00:23:05 INFO - Installing pip.................done. 00:23:05 INFO - Return code: 0 00:23:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:23:05 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')]} 00:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:05 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')]} 00:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:05 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:05 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 00:23:05 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 00:23:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:05 INFO - 'HOME': '/Users/cltbld', 00:23:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:05 INFO - 'LOGNAME': 'cltbld', 00:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:05 INFO - 'MOZ_NO_REMOTE': '1', 00:23:05 INFO - 'NO_EM_RESTART': '1', 00:23:05 INFO - 'PAGER': '/bin/cat', 00:23:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:05 INFO - 'PWD': '/builds/slave/test', 00:23:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:05 INFO - 'SHELL': '/bin/bash', 00:23:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:05 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:05 INFO - 'USER': 'cltbld', 00:23:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:05 INFO - 'XPC_FLAGS': '0x0', 00:23:05 INFO - 'XPC_SERVICE_NAME': '0', 00:23:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:05 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 00:23:05 INFO - Cleaning up... 00:23:05 INFO - Return code: 0 00:23:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:23:05 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')]} 00:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:05 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')]} 00:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:05 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:05 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 00:23:05 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 00:23:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:05 INFO - 'HOME': '/Users/cltbld', 00:23:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:05 INFO - 'LOGNAME': 'cltbld', 00:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:05 INFO - 'MOZ_NO_REMOTE': '1', 00:23:05 INFO - 'NO_EM_RESTART': '1', 00:23:05 INFO - 'PAGER': '/bin/cat', 00:23:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:05 INFO - 'PWD': '/builds/slave/test', 00:23:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:05 INFO - 'SHELL': '/bin/bash', 00:23:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:05 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:05 INFO - 'USER': 'cltbld', 00:23:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:05 INFO - 'XPC_FLAGS': '0x0', 00:23:05 INFO - 'XPC_SERVICE_NAME': '0', 00:23:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:06 INFO - Downloading/unpacking psutil>=3.1.1 00:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:09 INFO - Installing collected packages: psutil 00:23:09 INFO - Running setup.py install for psutil 00:23:09 INFO - building 'psutil._psutil_osx' extension 00:23:09 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 00:23:10 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 00:23:10 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 00:23:10 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 00:23:10 INFO - building 'psutil._psutil_posix' extension 00:23:10 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 00:23:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:23:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:23:10 INFO - ^ 00:23:10 INFO - 1 warning generated. 00:23:10 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 00:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:23:11 INFO - Successfully installed psutil 00:23:11 INFO - Cleaning up... 00:23:11 INFO - Return code: 0 00:23:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:11 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:11 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 00:23:11 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 00:23:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:11 INFO - 'HOME': '/Users/cltbld', 00:23:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:11 INFO - 'LOGNAME': 'cltbld', 00:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:11 INFO - 'MOZ_NO_REMOTE': '1', 00:23:11 INFO - 'NO_EM_RESTART': '1', 00:23:11 INFO - 'PAGER': '/bin/cat', 00:23:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:11 INFO - 'PWD': '/builds/slave/test', 00:23:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:11 INFO - 'SHELL': '/bin/bash', 00:23:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:11 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:11 INFO - 'USER': 'cltbld', 00:23:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:11 INFO - 'XPC_FLAGS': '0x0', 00:23:11 INFO - 'XPC_SERVICE_NAME': '0', 00:23:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:23:11 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 00:23:11 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 00:23:11 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 00:23:11 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 00:23:11 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 00:23:11 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 00:23:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:23:13 INFO - Installing collected packages: mozsystemmonitor 00:23:13 INFO - Running setup.py install for mozsystemmonitor 00:23:14 INFO - Successfully installed mozsystemmonitor 00:23:14 INFO - Cleaning up... 00:23:14 INFO - Return code: 0 00:23:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:14 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:14 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 00:23:14 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 00:23:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:14 INFO - 'HOME': '/Users/cltbld', 00:23:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:14 INFO - 'LOGNAME': 'cltbld', 00:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:14 INFO - 'MOZ_NO_REMOTE': '1', 00:23:14 INFO - 'NO_EM_RESTART': '1', 00:23:14 INFO - 'PAGER': '/bin/cat', 00:23:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:14 INFO - 'PWD': '/builds/slave/test', 00:23:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:14 INFO - 'SHELL': '/bin/bash', 00:23:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:14 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:14 INFO - 'USER': 'cltbld', 00:23:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:14 INFO - 'XPC_FLAGS': '0x0', 00:23:14 INFO - 'XPC_SERVICE_NAME': '0', 00:23:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:14 INFO - Downloading/unpacking jsonschema==2.5.1 00:23:14 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 00:23:14 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 00:23:14 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 00:23:14 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 00:23:14 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 00:23:14 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 00:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:23:16 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 00:23:16 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 00:23:16 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 00:23:16 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 00:23:16 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 00:23:16 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 00:23:17 INFO - Downloading functools32-3.2.3-2.tar.gz 00:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:23:17 INFO - warning: no files found matching '*.txt' 00:23:17 INFO - no previously-included directories found matching 'build' 00:23:17 INFO - no previously-included directories found matching 'dist' 00:23:17 INFO - no previously-included directories found matching '.git*' 00:23:17 INFO - Installing collected packages: jsonschema, functools32 00:23:17 INFO - Running setup.py install for functools32 00:23:17 INFO - warning: no files found matching '*.txt' 00:23:17 INFO - no previously-included directories found matching 'build' 00:23:17 INFO - no previously-included directories found matching 'dist' 00:23:17 INFO - no previously-included directories found matching '.git*' 00:23:17 INFO - Successfully installed jsonschema functools32 00:23:17 INFO - Cleaning up... 00:23:17 INFO - Return code: 0 00:23:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:23:17 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')]} 00:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:17 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')]} 00:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:17 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:17 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 00:23:17 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 00:23:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:17 INFO - 'HOME': '/Users/cltbld', 00:23:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:17 INFO - 'LOGNAME': 'cltbld', 00:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:17 INFO - 'MOZ_NO_REMOTE': '1', 00:23:17 INFO - 'NO_EM_RESTART': '1', 00:23:17 INFO - 'PAGER': '/bin/cat', 00:23:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:17 INFO - 'PWD': '/builds/slave/test', 00:23:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:17 INFO - 'SHELL': '/bin/bash', 00:23:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:17 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:17 INFO - 'USER': 'cltbld', 00:23:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:17 INFO - 'XPC_FLAGS': '0x0', 00:23:17 INFO - 'XPC_SERVICE_NAME': '0', 00:23:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:23:17 INFO - Cleaning up... 00:23:17 INFO - Return code: 0 00:23:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:23:17 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')]} 00:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:17 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')]} 00:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:17 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:17 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 00:23:17 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 00:23:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:17 INFO - 'HOME': '/Users/cltbld', 00:23:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:17 INFO - 'LOGNAME': 'cltbld', 00:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:17 INFO - 'MOZ_NO_REMOTE': '1', 00:23:17 INFO - 'NO_EM_RESTART': '1', 00:23:17 INFO - 'PAGER': '/bin/cat', 00:23:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:17 INFO - 'PWD': '/builds/slave/test', 00:23:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:17 INFO - 'SHELL': '/bin/bash', 00:23:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:17 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:17 INFO - 'USER': 'cltbld', 00:23:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:17 INFO - 'XPC_FLAGS': '0x0', 00:23:17 INFO - 'XPC_SERVICE_NAME': '0', 00:23:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:18 INFO - Downloading/unpacking blobuploader==1.2.4 00:23: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 00:23: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 00:23: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 00:23: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 00:23: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 00:23: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 00:23:20 INFO - Downloading blobuploader-1.2.4.tar.gz 00:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:23:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:23:20 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 00:23:20 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 00:23:20 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 00:23:20 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 00:23:20 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 00:23:20 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 00:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:23:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:21 INFO - Downloading docopt-0.6.1.tar.gz 00:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:23:21 INFO - Installing collected packages: blobuploader, requests, docopt 00:23:21 INFO - Running setup.py install for blobuploader 00:23:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:23:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:23:22 INFO - Running setup.py install for requests 00:23:22 INFO - Running setup.py install for docopt 00:23:22 INFO - Successfully installed blobuploader requests docopt 00:23:22 INFO - Cleaning up... 00:23:22 INFO - Return code: 0 00:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:22 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:22 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 00:23:22 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 00:23:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:22 INFO - 'HOME': '/Users/cltbld', 00:23:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:22 INFO - 'LOGNAME': 'cltbld', 00:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:22 INFO - 'MOZ_NO_REMOTE': '1', 00:23:22 INFO - 'NO_EM_RESTART': '1', 00:23:22 INFO - 'PAGER': '/bin/cat', 00:23:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:22 INFO - 'PWD': '/builds/slave/test', 00:23:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:22 INFO - 'SHELL': '/bin/bash', 00:23:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:22 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:22 INFO - 'USER': 'cltbld', 00:23:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:22 INFO - 'XPC_FLAGS': '0x0', 00:23:22 INFO - 'XPC_SERVICE_NAME': '0', 00:23:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-DCFi6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Jk2fin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-7yKtAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-9Bp4CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-t5nyan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-EGN0B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-PO3zuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-lKGVQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-u_EDtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:23 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Lc3GBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:24 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-EBqonJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:24 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-9K_j_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:24 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-TjEfBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:24 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Vgrpci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:24 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-aMbBt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:24 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Vngjn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:24 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-_3qDKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:23:24 INFO - Running setup.py install for manifestparser 00:23:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:23:24 INFO - Running setup.py install for mozcrash 00:23:25 INFO - Running setup.py install for mozdebug 00:23:25 INFO - Running setup.py install for mozdevice 00:23:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:23:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:23:25 INFO - Running setup.py install for mozfile 00:23:25 INFO - Running setup.py install for mozhttpd 00:23:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:23:25 INFO - Running setup.py install for mozinfo 00:23:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:23:25 INFO - Running setup.py install for mozInstall 00:23:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:23:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:23:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:23:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:23:25 INFO - Running setup.py install for mozleak 00:23:26 INFO - Running setup.py install for mozlog 00:23:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:23:26 INFO - Running setup.py install for moznetwork 00:23:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:23:26 INFO - Running setup.py install for mozprocess 00:23:26 INFO - Running setup.py install for mozprofile 00:23:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:23:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:23:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:23:26 INFO - Running setup.py install for mozrunner 00:23:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:23:26 INFO - Running setup.py install for mozscreenshot 00:23:27 INFO - Running setup.py install for moztest 00:23:27 INFO - Running setup.py install for mozversion 00:23:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:23:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:23:27 INFO - Cleaning up... 00:23:27 INFO - Return code: 0 00:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:27 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:27 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 00:23:27 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 00:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:27 INFO - 'HOME': '/Users/cltbld', 00:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:27 INFO - 'LOGNAME': 'cltbld', 00:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:27 INFO - 'MOZ_NO_REMOTE': '1', 00:23:27 INFO - 'NO_EM_RESTART': '1', 00:23:27 INFO - 'PAGER': '/bin/cat', 00:23:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:27 INFO - 'PWD': '/builds/slave/test', 00:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:27 INFO - 'SHELL': '/bin/bash', 00:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:27 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:27 INFO - 'USER': 'cltbld', 00:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:27 INFO - 'XPC_FLAGS': '0x0', 00:23:27 INFO - 'XPC_SERVICE_NAME': '0', 00:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:23:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-sR2B5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:23:27 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)) 00:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:23:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-dQ_Qjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:23:27 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)) 00:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:23:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QK0QIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:23:27 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)) 00:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:23:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-qoP6tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-w3NOWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-78495p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Ths6_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-XoRGPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Gnn5l5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-NHDC5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-I488K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Wyk3jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:23:28 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)) 00:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:23:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-n46A5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:23:29 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)) 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:23:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8U8Hoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:23:29 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)) 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-3Dx3l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:23:29 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)) 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:23:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-RbCogS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:23:29 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)) 00:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:23:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-omDrqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:23:29 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)) 00:23:29 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)) 00:23:29 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)) 00:23:29 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)) 00:23:29 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)) 00:23:29 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)) 00:23:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:23:31 INFO - Downloading blessings-1.6.tar.gz 00:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:23:32 INFO - Installing collected packages: blessings 00:23:32 INFO - Running setup.py install for blessings 00:23:32 INFO - Successfully installed blessings 00:23:32 INFO - Cleaning up... 00:23:32 INFO - Return code: 0 00:23:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:23:32 INFO - Reading from file tmpfile_stdout 00:23:32 INFO - Current package versions: 00:23:32 INFO - blessings == 1.6 00:23:32 INFO - blobuploader == 1.2.4 00:23:32 INFO - docopt == 0.6.1 00:23:32 INFO - functools32 == 3.2.3-2 00:23:32 INFO - jsonschema == 2.5.1 00:23:32 INFO - manifestparser == 1.1 00:23:32 INFO - mozInstall == 1.12 00:23:32 INFO - mozcrash == 0.17 00:23:32 INFO - mozdebug == 0.1 00:23:32 INFO - mozdevice == 0.48 00:23:32 INFO - mozfile == 1.2 00:23:32 INFO - mozhttpd == 0.7 00:23:32 INFO - mozinfo == 0.9 00:23:32 INFO - mozleak == 0.1 00:23:32 INFO - mozlog == 3.3 00:23:32 INFO - moznetwork == 0.27 00:23:32 INFO - mozprocess == 0.23 00:23:32 INFO - mozprofile == 0.28 00:23:32 INFO - mozrunner == 6.12 00:23:32 INFO - mozscreenshot == 0.1 00:23:32 INFO - mozsystemmonitor == 0.3 00:23:32 INFO - moztest == 0.7 00:23:32 INFO - mozversion == 1.4 00:23:32 INFO - psutil == 3.1.1 00:23:32 INFO - requests == 1.2.3 00:23:32 INFO - wsgiref == 0.1.2 00:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:32 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 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:32 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 00:23:32 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 00:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:32 INFO - 'HOME': '/Users/cltbld', 00:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:32 INFO - 'LOGNAME': 'cltbld', 00:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:32 INFO - 'MOZ_NO_REMOTE': '1', 00:23:32 INFO - 'NO_EM_RESTART': '1', 00:23:32 INFO - 'PAGER': '/bin/cat', 00:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:32 INFO - 'PWD': '/builds/slave/test', 00:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:32 INFO - 'SHELL': '/bin/bash', 00:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:32 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:32 INFO - 'USER': 'cltbld', 00:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:32 INFO - 'XPC_FLAGS': '0x0', 00:23:32 INFO - 'XPC_SERVICE_NAME': '0', 00:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 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)) 00:23:32 INFO - Cleaning up... 00:23:32 INFO - Return code: 0 00:23:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:23:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10573ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1057d3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91385c4b00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, '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.CEFcdKdajG/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.IVCriRLRg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 00:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:23:32 INFO - 'HOME': '/Users/cltbld', 00:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:23:32 INFO - 'LOGNAME': 'cltbld', 00:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:23:32 INFO - 'MOZ_NO_REMOTE': '1', 00:23:32 INFO - 'NO_EM_RESTART': '1', 00:23:32 INFO - 'PAGER': '/bin/cat', 00:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:23:32 INFO - 'PWD': '/builds/slave/test', 00:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:23:32 INFO - 'SHELL': '/bin/bash', 00:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:23:32 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:23:32 INFO - 'USER': 'cltbld', 00:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:23:32 INFO - 'XPC_FLAGS': '0x0', 00:23:32 INFO - 'XPC_SERVICE_NAME': '0', 00:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:23:33 INFO - Cleaning up... 00:23:33 INFO - Return code: 0 00:23:33 INFO - Running post-action listener: _resource_record_post_action 00:23:33 INFO - Running post-action listener: _start_resource_monitoring 00:23:33 INFO - Starting resource monitoring. 00:23:33 INFO - [mozharness: 2016-08-18 07:23:33.142763Z] Finished create-virtualenv step (success) 00:23:33 INFO - [mozharness: 2016-08-18 07:23:33.143752Z] Running install step. 00:23:33 INFO - Running pre-action listener: _resource_record_pre_action 00:23:33 INFO - Running main action method: install 00:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:23:33 INFO - Reading from file tmpfile_stdout 00:23:33 INFO - Detecting whether we're running mozinstall >=1.0... 00:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:23:33 INFO - Reading from file tmpfile_stdout 00:23:33 INFO - Output received: 00:23:33 INFO - Usage: mozinstall [options] installer 00:23:33 INFO - Options: 00:23:33 INFO - -h, --help show this help message and exit 00:23:33 INFO - -d DEST, --destination=DEST 00:23:33 INFO - Directory to install application into. [default: 00:23:33 INFO - "/builds/slave/test"] 00:23:33 INFO - --app=APP Application being installed. [default: firefox] 00:23:33 INFO - mkdir: /builds/slave/test/build/application 00:23:33 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'] 00:23:33 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 00:24:07 INFO - Reading from file tmpfile_stdout 00:24:07 INFO - Output received: 00:24:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:24:07 INFO - Running post-action listener: _resource_record_post_action 00:24:07 INFO - [mozharness: 2016-08-18 07:24:07.825940Z] Finished install step (success) 00:24:07 INFO - [mozharness: 2016-08-18 07:24:07.826077Z] Running run-tests step. 00:24:07 INFO - Running pre-action listener: _resource_record_pre_action 00:24:07 INFO - Running main action method: run_tests 00:24:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:24:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:24:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:24:07 INFO - 2016-08-18 00:24:07.840 screenresolution[1641:8663] starting screenresolution argv=screenresolution get 00:24:07 INFO - 2016-08-18 00:24:07.843 screenresolution[1641:8663] Display 0: 1600x1200x32@60 00:24:07 INFO - 2016-08-18 00:24:07.848 screenresolution[1642:8665] starting screenresolution argv=screenresolution list 00:24:07 INFO - Available Modes on Display 0 00:24:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:24:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:24:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:24:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:24:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:24:08 INFO - Intel Iris: 00:24:08 INFO - Chipset Model: Intel Iris 00:24:08 INFO - Type: GPU 00:24:08 INFO - Bus: Built-In 00:24:08 INFO - VRAM (Dynamic, Max): 1536 MB 00:24:08 INFO - Vendor: Intel (0x8086) 00:24:08 INFO - Device ID: 0x0a2e 00:24:08 INFO - Revision ID: 0x0009 00:24:08 INFO - Displays: 00:24:08 INFO - Display: 00:24:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:24:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:24:08 INFO - Display Serial Number: 1600x1200 60 00:24:08 INFO - Main Display: Yes 00:24:08 INFO - Mirror: Off 00:24:08 INFO - Online: Yes 00:24:08 INFO - Rotation: Supported 00:24:08 INFO - Return code: 0 00:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:24:08 INFO - Python 2.7.3 00:24:08 INFO - Return code: 0 00:24:08 INFO - grabbing minidump binary from tooltool 00:24:08 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')]} 00:24:08 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 0x1056a2d30>, '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 0x105407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10569ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:24:08 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 00:24:08 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 00:24:08 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 00:24:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:24:08 INFO - Return code: 0 00:24:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:24:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:24:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:24:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:24:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 00:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --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 00:24:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CEFcdKdajG/Render', 00:24:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:24:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:24:08 INFO - 'HOME': '/Users/cltbld', 00:24:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:24:08 INFO - 'LOGNAME': 'cltbld', 00:24:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:24:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:24:08 INFO - 'MOZ_NO_REMOTE': '1', 00:24:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:24:08 INFO - 'NO_EM_RESTART': '1', 00:24:08 INFO - 'PAGER': '/bin/cat', 00:24:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:24:08 INFO - 'PWD': '/builds/slave/test', 00:24:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:24:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:24:08 INFO - 'SHELL': '/bin/bash', 00:24:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IVCriRLRg8/Listeners', 00:24:08 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 00:24:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:24:08 INFO - 'USER': 'cltbld', 00:24:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:24:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:24:08 INFO - 'XPC_FLAGS': '0x0', 00:24:08 INFO - 'XPC_SERVICE_NAME': '0', 00:24:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:24:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 00:24:08 INFO - mozversion application_buildid: 20160817222415 00:24:08 INFO - mozversion application_changeset: f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 00:24:08 INFO - mozversion application_display_name: Nightly 00:24:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:24:08 INFO - mozversion application_name: Firefox 00:24:08 INFO - mozversion application_remotingname: firefox 00:24:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:24:08 INFO - mozversion application_vendor: Mozilla 00:24:08 INFO - mozversion application_version: 51.0a1 00:24:08 INFO - mozversion platform_buildid: 20160817222415 00:24:08 INFO - mozversion platform_changeset: f5ed7f38160ed375a0ea04eb2ac847983b1da2f1 00:24:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:24:08 INFO - mozversion platform_version: 51.0a1 00:24:08 INFO - using testdate: 1471505048 00:24:08 INFO - actual date: 1471505048 00:24:08 INFO - starting webserver on 'localhost:49265' 00:24:08 INFO - SUITE-START | Running 2 tests 00:24:08 INFO - TEST-START | dromaeo_css 00:24:08 INFO - operating with platform_type : mac_ 00:24:08 INFO - Initialising browser for dromaeo_css test... 00:24:08 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp_W2kNn/profile http://localhost:49265/getInfo.html) 00:24:10 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 00:24:10 INFO - PROCESS | 1652 | colorDepth:24 00:24:10 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 00:24:10 INFO - PROCESS | 1652 | __metrics 00:24:10 INFO - PROCESS | 1652 | 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" 00:24:10 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:24:11 INFO - TEST-INFO | 1652: exit 0 00:24:11 INFO - Browser initialized. 00:24:11 INFO - Running cycle 1/1 for dromaeo_css test... 00:24:11 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp_W2kNn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:23 INFO - PROCESS | 1655 | RSS: Main: 228298752 00:24:23 INFO - PROCESS | 1655 | 00:25:15 INFO - PROCESS | 1655 | 1471505115272 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] 00:27:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 00:27:28 INFO - PROCESS | 1655 | RSS: Main: 362962944 00:27:28 INFO - PROCESS | 1655 | 00:30:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 00:30:32 INFO - PROCESS | 1655 | RSS: Main: 382939136 00:30:32 INFO - PROCESS | 1655 | 00:33:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 00:33:35 INFO - PROCESS | 1655 | RSS: Main: 338079744 00:33:35 INFO - PROCESS | 1655 | 00:36:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 00:36:38 INFO - PROCESS | 1655 | RSS: Main: 342929408 00:36:38 INFO - PROCESS | 1655 | 00:39:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 00:39:42 INFO - PROCESS | 1655 | RSS: Main: 337457152 00:39:42 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 00:42:45 INFO - PROCESS | 1655 | RSS: Main: 491261952 00:42:45 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | __start_tp_report 00:42:45 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 00:42:45 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 00:42:45 INFO - PROCESS | 1655 | |i|pagename|runs| 00:42:45 INFO - PROCESS | 1655 | |0;dojo.html;2834.3339315260914;3379.8986030419096;3393.575803024621;3409.1136304560805;3413.8293085345726;5595.300587426572;5653.689047102408;5722.37053924068;5763.279590051244;5806.158107074471;5715.77136914524;5764.135379693048;5770.480656740892;5770.82687519374;5774.018416869132;5232.529072383485;5276.366835979668;5293.073712100387;5302.2311764794085;5352.973235133819;5352.170413585881;5360.303160589118;5366.91949620756;5367.838964831061;5372.489613486732;5228.424873263938;5234.0840352938085;5255.973720131394;5256.658317209388;5346.331708536433;4341.413909122275;5014.2979982802435;5329.307190065267;5339.199120131972;5358.4373640767935;5139.049275883936;5143.922841157386;5220.582353411756;5237.214417837316;5242.5281724644965;5640.097584386478;5720.656760594377;5733.054046082391;5737.540996720252;5784.623999440065;5263.789448422059;6235.501159907242;6297.118403423525;6301.747930082791;6315.273743519509;6196.659183744892;6246.750129994794;6255.718492667841;6328.905066424008;6344.429001389897;5836.416358364172;5912.379200184005;5932.911006334908;5939.198208241918;5941.940580594225;6297.937020629735;6303.810885673437;6304.653244071528;6322.304546499881;6326.051092336186;6029.065494848305;6097.451229389376;6129.328227221949;6218.9378106219265;6222.377762223832;6279.937200627935;6297.2128483939505;6312.053192021233;6319.58922670025;6320;6194.473469755031;6256.562040657111;6261.060840873814;6263.812085637438;6269.404406581368;6117.462039585284;6238.563300569007;6296.338884417162;6303.905441418382;6322.114903913456;4913.091078150554;4929.112759703288;4968.205087186033;4979.053979743837;4987.401511818605;4414.80133393998;4423.469183697913;4441.356003379557;4445.066536027471;4473;5612.5229355504425;5754.539636829128;5764.654120752768;5790;5830.300363956352;6195.535334849904;6249.593776404519;6251.187345645037;6295.3389894060465;6299.842503937438;4980.576650984634;5657.896710141566;5788.710564471844;5822.883542329215;5833.38749431312;5463.535599474009;5487.259220005328;5511.807086752025;5518.144687573433;5532.806351777749;5505.862353441196;6141.915626108588;6209.348018457997;6255.843603909939;6275.843103922439;4689.109069276827;6101.633901965719;6292.842678933063;6306.148669929685;6323.367663233824;6269.780557680459;6315.5894866833505;6326.082718005955;6356.4279214870885;6357.745690172342;6115.970584430425;6132.877342453036;6136.171616831849;6147.047207682816;6160.199174107337;6206.813795586139;6211.16149319836;6212.81361559154;6216.316205217332;6230.096635987847;6010.699465026643;6108.786192483241;6140.600860944024;6160.907586386118;6191.690415479298;6031.5476339273855;6095.847603809941;6120.9652521188555;6133.877322453615;6155.876882462236;5983.910241346471;6036.607620504653;6037.335893051673;6057.4760020063595;6070.878582428415;6155.753769849156;6179.134921110958;6179.969100154471;6181.84545386369;6187.876242475215;5009.699418034929;5903.173555702119;5953.851153721192;5968.46283834457;5992.250968628921 00:42:45 INFO - PROCESS | 1655 | |1;ext.html;481.790705329623;505.967112137711;516.1612379882691;517.3197245622007;526.4551189518846;30564.694353056464;32118.839405802966;32256.516152257675;40634;41678.37482437766;41463.37804932921;41960.74117776464;42016.369754453706;42105;42203.94490137748;9687.903120968806;9831.262655300845;9858.408495490257;9870.407775533455;9891.50542472877;9773.120419162275;9863;9874.851877221847;9875.209983201326;9910.405375677483;9837.163841073518;9908;9919;9919.752006199831;9927.602895884156;9826.754331141707;9901.306908516406;9907.356021858628;9908.851367229498;9911.008899110104;9681.757956051084;9719.757006074835;9764.974677658814;9774.902250977542;9818.9509052455;37863;38207.61792382096;38244;38247.4262886057;38266.808665956494;3443.8622455101768;3474.8436320365645;3479.878204262864;3489.1277180704824;3520.8767693130617;28279.434411311657;30358.54462183069;30945.535816962765;30955.101391966204;31056.844715776504;3184.8407579620925;3200.2799370141765;3244.9453927473664;3293.8847140350213;3321.966780332214;409259;430673;476708;480624;481173;54702.45297547053;54920.17619735707;54946.450535494936;54964.17553736697;55032.724836375564;33825.66174338274;34253;34473.827630861684;57835.42164578385;58051.41948580545;16423.753643695352;16472.25874835635;16473.34106635745;16474.83525164757;16479.423220187236;12616.17994830333;12670.809937850756;12686.492540298284;12702.745945081231;12753.171043882117;18462.907685461487;18484.353047643268;18490.68866391701;18526;18581.44255672332;7492.887606685904;7569.394448444111;7615.354633673454;7690.96154519235;7698.458708993926;869.6347534035721;912.2154946745793;923.7275003873873;938.2869019545059;944.2634744898852;26925.192244232705;29765.809367625054;30089.398212035638;30519;30642.38715225683;1015.1777060580953;1035.2701345551518;1063.6277302943909;1063.8297872340388;1098.983365524256;14443.49447769323;15282.617934551725;15421.537353879401;15515.767263491056;15881.841181588266;681272;689619;691490;692193;692855;57628.71185644045;57832.132518012266;57895;57922.8415431689;58092;1211.3156066822216;1336.1715736243398;1360.4830164537611;1361.6051345109806;1376.8141300924447;27211.727882721712;30087.428098612858;30469.847650761603;31122.844385777928;31261.000284199905;46759.53240467688;47217.76391118023;47402;47439;47445;443174;443723;447022;447296;456070;22970.42573935665;25422.237332880042;25808.741912581387;26127.869360653076;26253.868730656224;45374.77312613416;46067.76966115148;46490.53509464862;46619;47607.28589071236;38269.80865095657;38767.80616096901;38768.0889061349;39095.80452097835;39663.80168099141;38893.02767430837;38958;39212.803935981276;40337.79831100826;40577.79711101425;37251;38111.61888381081;38370;38374.052021936644;38451.615483844806;31282.21794455157;33698.15754606154;34564.48153277753;34612.48081278833;35184.64815351814;25390.238292851245;25476.872615636803;25494.235172944842;25636.61545076788;26270.080547180758 00:42:45 INFO - PROCESS | 1655 | |2;jquery.html;316.4936102236422;374.77138945243405;385.72035274426037;396.86704953840496;406.93489041753327;15870.682586348266;16001.759973600405;19734;20352.1859125635;20767.273145439933;14693.55919322422;19728.605427891434;20116;20439;21505.46236344088;5815;6076.756929722806;6081.695915204245;6088.056351265561;6092.817215483543;3979.86070487533;5746.827595172152;6019.398060193989;6357.332480089593;6703.564268322543;5758.3090029196555;6575.178102737158;6680.665966701646;6697;6707.597544147342;6373.23521177457;6589.868202635945;6596.274409814917;6627.304133066007;6636.900446493258;5245.291885595434;5542.0855558832745;5755.827325180251;5763.394843541451;5772.769089236425;13294.135881167693;13526.985476089234;13530.526431574848;13532.661683457894;22604.43488912774;2006.2276023730822;2094.717213176217;2095.3399679101035;2116.8729876207476;2316.5714342846627;9722.854157187649;10147.644832430904;10299.691009269734;10621.787564248672;10703.732406689816;1622.5862405086746;1876.587150826816;1892.9337473188373;1964.0965156028244;2019.2125071222235;118715;128889.35555322163;128956.35521822331;130349.34825325907;133806;11138.832917506244;11470.139739519569;11662.416879156008;11670.124740644316;11798.351090689923;12110.57612983559;14548.199849008406;14565.635859103395;14569.198694071927;14574.344154513072;8041.678332866737;8142.877856832152;8166.346692264605;8200.835983280302;8294.419390642597;6623.437007854386;7827.1390147083775;7839.84320313602;7957.482763620346;7997.720079797179;4081.4081958115908;4256.6807489438415;4523.977380113079;4532.138893610204;4611.400517932647;1867.6264747050373;1926.364299781069;1928.3829174664254;1928.7203355513373;1932.1015727686693;618.3105836991722;727.7628032345035;815.0545367373936;857.8327226190958;942.4816351007056;16976.32094716222;21312.254071107436;21572.892135539223;21710.457238568848;21852.344429667137;903.408267584733;947.0955237747934;962.2542529539663;966.9033096690415;996.6511720897773;10956.452177391098;11230.887691123147;11382.829257561143;11390.088792896548;11467.197296189186;559621;568255;570910;586936;622503;108866.45566772274;121693.3860226703;133341;133739;138633;906.2568693671126;954.8663187153804;968.5738275158908;970.1995853420815;974.2741657465092;14512.709745804814;16132.354705812106;17508.299668013646;18260.99564523964;18877.71683424722;40290.798546007085;52494.99999999847;53494.465055350505;53897.73051134876;54460;71246.28753712605;73050.63474682592;73555.63222183855;75412.86880696904;77087;5316.760745766527;5542.140968149944;7952.717318668037;8284.544350060805;8295.875561866698;11103.500342484445;12168.513259469522;12641.988640908889;12645.557405490763;12674.366281686063;10681.732956676145;10838.403887785931;11199.216054876406;11292.266002709797;11400.828987565028;11409.543618255177;11451.770964580495;11503.942480287546;11588.76822463529;11994.64016079519;5789.94210057894;7164.749233777001;11011.669649910515;11346.773064538827;11783.882161178279;6768.120144381199;8029.8394032120195;8050.919490805251;8348;8506.234438900528;8348.749537513884;10353.482325883526;11312.264702794291;11681.299122052364;11707.063434925356 00:42:45 INFO - PROCESS | 1655 | |3;mootools.html;1351.1555277951281;1378.765609846326;1513.0694622806977;1670.8162102168767;1839.6504664113825;7650.617469126542;8154.347652187826;8158.265756081952;8194.30348420385;8203.835923281531;8256.876146857787;8499.830003399928;8602.967643882743;8677.435966662162;8681.609327580258;1970.3891793544012;2377.702787151606;2387.6657267982496;2388.486475407787;2388.904443822245;2316.7683231676783;2358.1982126077132;2360.0677732295735;2361.2207971369494;2365.4914193448403;2330;2337.9181728639414;2351.3416243451775;2373.596488596943;2374.9406264843346;2316.791488766002;2340.508493216418;2350.6003979323555;2354.2701762453694;2375.0499800079933;2337.94155146121;2338.275134708246;2343.425860664131;2347.55396474671;2348.5655153796433;7593.886091708629;8570.828583428296;8687.826243475158;8770.561471926441;8788;4751.619870410394;5177.171652535576;5195.220716892459;5355.410904800468;5361.785528578852;3391.5251864738957;3561.8041007744564;3664.303782281358;3675.9448608270895;3685.1892583631557;1068.2362111090529;1076.359566058194;1096.199774164856;1103.3765922253901;1104.7624760676413;9621.470819104947;11468.827967580493;11513.827292590535;11533.365664888428;11563.884361156364;4626.282926146453;4653.208954477747;4731.621470282369;4804.879878003008;4810.326554282403;9977.052180042885;9977.301588888853;9984.400935943866;9994.950025249827;10014.148797352307;5369.0872551665525;5370.865728356823;5375.1131063374105;5375.354957405137;5380.73096345189;4802;4873.220284754493;4917.803287868517;4957;4966;3713.9071523211596;3765.7363984521367;3787.886363409102;3832.4442955771815;3857.035741064734;1237.047473445442;1240.1195151442578;1246.5138595947587;1254.9623511294676;1256.3718140929536;795.8129839487716;858.356232825381;884.9733316117262;921.1019256225127;924.713338864954;5760.193572899798;5945.16767652529;5945.643261404243;6099.2985806632805;6195.132681424604;940.2243149401634;945.4232917920064;961.1974001708652;965.1699538396973;987.3067688913547;2997.9100626981226;3834.9424758628643;3902.8829135125993;3972.781497017634;4059.7361171523758;9793.265505087005;10194.490275486196;10688.625898093685;10902.5093870776;10954.616588419367;10545.678111394885;10685.626003089854;10707.143428525855;10710.143188544898;10727.356358618508;7904.4071694623135;8128.268455839003;8136.633851476579;8139.715109971123;8170.550619715973;5627.634203776742;5875.118732190205;5937.851553711192;6051.243594550681;6093.969530152321;9911.752206194902;9938.602455901972;9939.602415903571;9959.651412200537;9975.506123469133;9730.659426920023;9829.4102353859;10000.199984001409;10158.796824063626;10173.389596624227;7280.7815765525;7500.324970752658;7597.126330471845;7599.240075992357;7614.048243969504;8191.918080819354;8289.834203315779;8302.460340078118;8309.750707478785;8311.002679678477;6621.900671490028;6817.454603631797;6900.689468973807;6966.512344135862;6967.7212911485;6713.261541230363;6766.5263431559315;6780.796576102724;6794.320567943166;6816.250212476524;6320.905186422116;6347.428731414195;6401.679916004088;6426.775062872777;6454.19322584677;4618.191816432044;4636.83771068011;4671.7430541320555;4700.670953033255;4757.3577567028005;4592.242280023758;4684;4783.354247176587;4907.705537667752;4936 00:42:45 INFO - PROCESS | 1655 | |4;prototype.html;283.7488822392183;290.1093642517471;292.1119795820705;295.3089769938344;301.82644979137;4387.868363949078;4409.845655402053;4626.722396656203;5050.41920179179;5354.894161386396;4001.679865610751;4730.787114579844;5165.328507294046;5221.877296381277;5275.788968441268;3617.620149884264;3754.5119134512474;3848.5189351331082;3854.8265328060165;3941.8226179821977;3521.806300653463;3551.1654761131113;3662.9084272893256;3941.8423263069444;4033.9596604034023;3968.3849003404516;3984.8605298814546;4003.4795476588;4029.4560234368278;4039.333509970866;3749.8125093745475;3817.828197731095;3974.721769476138;4000.659943904772;4060.2894493463527;3510.4032314506594;3516.7714098583765;3517.8241087945757;3518.2435776308216;3534.575850897883;4781.641376896712;4932.358793356841;5146.485351464861;5179.430262671103;5180.48195180479;4397.582229688174;4592.425946756655;4599.402077729874;4626.282926146419;4634.328022436762;4820;5538.446155384469;5539.307586551681;5545.805896793593;5617.80337688183;3289.8649965761774;3905.4337121117564;3907.179492306619;3921.3138999785238;3930.508686414198;4884.804607815648;4949.826756063557;5374.516293533601;5809.506191973645;5873.882522349529;3218.3885061838178;3368.696817286456;3791.7724936503896;3808.1622043150464;3837.218016937698;3450.861965521401;3916.9424255450867;3920.2551515212017;3921.098147426051;3923.1172986078473;3863.7102217333813;4537.500874903758;4566.543345665474;4575.519570445122;4584.541545845455;5415.241866138744;5573.27547418833;5585.88282343533;5599.900037485942;5624.831255062355;1289.574440434673;1311.9635487964592;1312.1143228321037;1315.0005995443341;1315.6842357834241;754.5397307642334;798.9054994657357;814.4014149600039;815.2173913043426;820.6225136437306;4377.0808130293;4662.743549104832;5011.6241281904;5054.570361519312;5150.223173005307;4603.194440972817;5636.210930469738;5686.914696279559;5704.600677952503;5720.082757793555;4371.475422949203;4966.8576227467165;5162.845114646567;5171.405288391883;5195.818146364859;2621.7902567794913;2911.315840777416;2952.1586347890748;2961.8370989595346;2967.554866770002;5368.758405871745;5857.970710146422;5870.207521984563;5872.592237182735;5908.454927043739;5377.811776587879;5756.740946657411;5777.24895763548;5791.884162316815;5829.47534721877;5546.500814926595;5592.692401917933;5833.67914764692;5840.532757379399;5852.882942341129;4363.47638283408;4778;5515.917261241005;5615.943840561542;5655.88688226225;4628.449469427779;5202.505761952609;5334.653247538898;5594.356648985418;5611.298587676541;5129.487051294841;5275.472452754694;5396.3524377075;5596.599281693186;5904.822855314347;2834.4331133772916;3285.225977971964;3530.61163272045;3755.511783468132;3789.7536660117003;4745.572898439157;4974.403071631427;5179.792808287626;5551.666899986014;5643.3510146332055;4834.057358815138;5286.656367336111;5464.480874316933;5483.506484416422;5519.641223320471;4658.976705116453;4930.7534623267975;5113.463086376026;5398.811041613525;5460.996451951331;4285.849995250152;5374.677519348852;5384;5388.4135614905845;5408.972955135357;4715.834945776881;5228.849653076317;5439.5648348132845;5486.31421072366;5598.888022239614;5392.703401312965;5399.406065332889;5425.856786569204;5426.891462170655;5434.266374039612 00:42:45 INFO - PROCESS | 1655 | |5;yui.html;635.5805168588731;681.1383599746325;789.0255534414996;807.5477732469814;832.9292010179134;15665.45170919018;16586.25361858716;16645.50063498094;16655.16724163793;16677.24952377143;15011.249437528135;15061;15152.54542363728;15159.772603410931;15235.162066086361;668.7893313606211;692.4045321023915;834.0658462521984;858.5535521528801;862.8619420892659;833.3208435125383;844.1094645149365;844.6156998565638;849.9022612399591;850.2220468271555;774.2953911940135;919.3564504846634;920.3097676742443;920.7513971227764;921.258386998466;715.7280233511284;913.3423934767023;914.6981496106268;915.1077699243218;915.8214148241095;660.3462572053633;684.555039224503;688.0230073295932;688.90355350251;690.7547820523693;14892.776608350883;14942.028768130145;14943.551693449213;14943.626409339744;14960.925195373953;13741.931290343484;13994.801987592438;14132.36404361796;14193.432262709479;14553.345099470549;12523.74952500954;12699.936500317439;12842.550510732079;12943.482260709654;13346.599602011955;4613.284940834176;4664.580187783082;4667.346571479996;4845.079434907391;4851.636127290467;116219.41890290579;116334.41832790781;116359;119485.40257298744;120935.79064209333;11184.496697648463;11205.215634905642;11235.831462527905;11255;11584.073274138049;21814.781852181593;21926.342209733415;21980.78019219819;21989.890050549646;22015.11939522433;6654.833629159213;7931.331497791795;8155.306798922158;8231.42380033404;8267.049289331684;4314.697971142053;4359.280718681445;4403.427554417905;4485.529019452911;4615.423072115986;2598.5712357460807;3232.9191770205935;3233.9838300808815;3236.821974791409;3237.3848968695875;625.352759893508;645.1000853808911;654.2214764430313;668.886289330815;672.028918213187;540.9377921539074;608.8903997280532;609.1289456077762;630.6468377708497;636.8471566824021;8578.313734901192;8688.348373871984;8694.176937278553;8879.378443509022;8926.419782714103;586.0025967177854;605.1346574398565;617.3240301869446;625.352759893508;641.8491654461197;4161.9375709364385;4205.873823785291;4408.647308215399;4415.227335216325;4524.9185374727995;97454;123464;123935.56386616832;130613;161836.53370261248;118368;121546;123004;123825;125617.11574326393;87384.56307718548;105830.47084764527;107756;109671.12959833653;109787.45106274736;9043.954780226057;9519.286053545873;9726.805463890541;9730.221582273543;9797.363171393836;56718.14922776244;56962.715186423804;57711.422885770604;59364.70317648384;60411.48971275753;83473.58263208646;83967.58016210124;86252.93645365647;88504.5574772122;89143.66284505867;12899;12950.611481655566;13122.054993339532;13197.604071877859;13411.262380568773;14828.036177648419;14960.754619869183;15059.849401505844;15113.47102851395;15264;13859.65350866196;14280.500182493563;14409.13545187292;14415.927920360331;14439.2058436787;13416.358629586368;13887.37506812216;14007;14015;14089;11081.39052352096;13376.732465350444;13696.726065478435;13719.432947433539;13897.791533127214;11030.724231894266;11359.54561817518;11469.31184128955;11688.415579221175;12001.63995080149;7023.894641580278;10686.358818470917;10743.409112498888;11304.830427543759;11587.420628968686 00:42:45 INFO - PROCESS | 1655 | __end_tp_report 00:42:45 INFO - PROCESS | 1655 | __start_cc_report 00:42:45 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1331 00:42:45 INFO - PROCESS | 1655 | __end_cc_report 00:42:45 INFO - PROCESS | 1655 | __startTimestamp1471506165745__endTimestamp 00:42:45 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | ------- Summary: start ------- 00:42:45 INFO - PROCESS | 1655 | Number of tests: 6 00:42:45 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5746.43 Median:5983.91 stddev:660.99 (11.0%) stddev-sans-first:622.29 00:42:45 INFO - PROCESS | 1655 | Values: 2834.3 3379.9 3393.6 3409.1 3413.8 5595.3 5653.7 5722.4 5763.3 5806.2 5715.8 5764.1 5770.5 5770.8 5774.0 5232.5 5276.4 5293.1 5302.2 5353.0 5352.2 5360.3 5366.9 5367.8 5372.5 5228.4 5234.1 5256.0 5256.7 5346.3 4341.4 5014.3 5329.3 5339.2 5358.4 5139.0 5143.9 5220.6 5237.2 5242.5 5640.1 5720.7 5733.1 5737.5 5784.6 5263.8 6235.5 6297.1 6301.7 6315.3 6196.7 6246.8 6255.7 6328.9 6344.4 5836.4 5912.4 5932.9 5939.2 5941.9 6297.9 6303.8 6304.7 6322.3 6326.1 6029.1 6097.5 6129.3 6218.9 6222.4 6279.9 6297.2 6312.1 6319.6 6320.0 6194.5 6256.6 6261.1 6263.8 6269.4 6117.5 6238.6 6296.3 6303.9 6322.1 4913.1 4929.1 4968.2 4979.1 4987.4 4414.8 4423.5 4441.4 4445.1 4473.0 5612.5 5754.5 5764.7 5790.0 5830.3 6195.5 6249.6 6251.2 6295.3 6299.8 4980.6 5657.9 5788.7 5822.9 5833.4 5463.5 5487.3 5511.8 5518.1 5532.8 5505.9 6141.9 6209.3 6255.8 6275.8 4689.1 6101.6 6292.8 6306.1 6323.4 6269.8 6315.6 6326.1 6356.4 6357.7 6116.0 6132.9 6136.2 6147.0 6160.2 6206.8 6211.2 6212.8 6216.3 6230.1 6010.7 6108.8 6140.6 6160.9 6191.7 6031.5 6095.8 6121.0 6133.9 6155.9 5983.9 6036.6 6037.3 6057.5 6070.9 6155.8 6179.1 6180.0 6181.8 6187.9 5009.7 5903.2 5953.9 5968.5 5992.3 00:42:45 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:66114.19 Median:39026.90 stddev:145260.10 (372.2%) stddev-sans-first:145584.01 00:42:45 INFO - PROCESS | 1655 | Values: 481.8 506.0 516.2 517.3 526.5 30564.7 32118.8 32256.5 40634.0 41678.4 41463.4 41960.7 42016.4 42105.0 42203.9 9687.9 9831.3 9858.4 9870.4 9891.5 9773.1 9863.0 9874.9 9875.2 9910.4 9837.2 9908.0 9919.0 9919.8 9927.6 9826.8 9901.3 9907.4 9908.9 9911.0 9681.8 9719.8 9765.0 9774.9 9819.0 37863.0 38207.6 38244.0 38247.4 38266.8 3443.9 3474.8 3479.9 3489.1 3520.9 28279.4 30358.5 30945.5 30955.1 31056.8 3184.8 3200.3 3244.9 3293.9 3322.0 409259.0 430673.0 476708.0 480624.0 481173.0 54702.5 54920.2 54946.5 54964.2 55032.7 33825.7 34253.0 34473.8 57835.4 58051.4 16423.8 16472.3 16473.3 16474.8 16479.4 12616.2 12670.8 12686.5 12702.7 12753.2 18462.9 18484.4 18490.7 18526.0 18581.4 7492.9 7569.4 7615.4 7691.0 7698.5 869.6 912.2 923.7 938.3 944.3 26925.2 29765.8 30089.4 30519.0 30642.4 1015.2 1035.3 1063.6 1063.8 1099.0 14443.5 15282.6 15421.5 15515.8 15881.8 681272.0 689619.0 691490.0 692193.0 692855.0 57628.7 57832.1 57895.0 57922.8 58092.0 1211.3 1336.2 1360.5 1361.6 1376.8 27211.7 30087.4 30469.8 31122.8 31261.0 46759.5 47217.8 47402.0 47439.0 47445.0 443174.0 443723.0 447022.0 447296.0 456070.0 22970.4 25422.2 25808.7 26127.9 26253.9 45374.8 46067.8 46490.5 46619.0 47607.3 38269.8 38767.8 38768.1 39095.8 39663.8 38893.0 38958.0 39212.8 40337.8 40577.8 37251.0 38111.6 38370.0 38374.1 38451.6 31282.2 33698.2 34564.5 34612.5 35184.6 25390.2 25476.9 25494.2 25636.6 26270.1 00:42:45 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34162.22 Median:1316.53 stddev:97597.55 (7413.2%) stddev-sans-first:97838.25 00:42:45 INFO - PROCESS | 1655 | Values: 316.5 374.8 385.7 396.9 406.9 15870.7 16001.8 19734.0 20352.2 20767.3 14693.6 19728.6 20116.0 20439.0 21505.5 5815.0 6076.8 6081.7 6088.1 6092.8 3979.9 5746.8 6019.4 6357.3 6703.6 5758.3 6575.2 6680.7 6697.0 6707.6 6373.2 6589.9 6596.3 6627.3 6636.9 5245.3 5542.1 5755.8 5763.4 5772.8 13294.1 13527.0 13530.5 13532.7 22604.4 2006.2 2094.7 2095.3 2116.9 2316.6 9722.9 10147.6 10299.7 10621.8 10703.7 1622.6 1876.6 1892.9 1964.1 2019.2 118715.0 128889.4 128956.4 130349.3 133806.0 11138.8 11470.1 11662.4 11670.1 11798.4 12110.6 14548.2 14565.6 14569.2 14574.3 8041.7 8142.9 8166.3 8200.8 8294.4 6623.4 7827.1 7839.8 7957.5 7997.7 4081.4 4256.7 4524.0 4532.1 4611.4 1867.6 1926.4 1928.4 1928.7 1932.1 618.3 727.8 815.1 857.8 942.5 16976.3 21312.3 21572.9 21710.5 21852.3 903.4 947.1 962.3 966.9 996.7 10956.5 11230.9 11382.8 11390.1 11467.2 559621.0 568255.0 570910.0 586936.0 622503.0 108866.5 121693.4 133341.0 133739.0 138633.0 906.3 954.9 968.6 970.2 974.3 14512.7 16132.4 17508.3 18261.0 18877.7 40290.8 52495.0 53494.5 53897.7 54460.0 71246.3 73050.6 73555.6 75412.9 77087.0 5316.8 5542.1 7952.7 8284.5 8295.9 11103.5 12168.5 12642.0 12645.6 12674.4 10681.7 10838.4 11199.2 11292.3 11400.8 11409.5 11451.8 11503.9 11588.8 11994.6 5789.9 7164.7 11011.7 11346.8 11783.9 6768.1 8029.8 8050.9 8348.0 8506.2 8348.7 10353.5 11312.3 11681.3 11707.1 00:42:45 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5592.97 Median:4946.50 stddev:3125.52 (63.2%) stddev-sans-first:3118.03 00:42:45 INFO - PROCESS | 1655 | Values: 1351.2 1378.8 1513.1 1670.8 1839.7 7650.6 8154.3 8158.3 8194.3 8203.8 8256.9 8499.8 8603.0 8677.4 8681.6 1970.4 2377.7 2387.7 2388.5 2388.9 2316.8 2358.2 2360.1 2361.2 2365.5 2330.0 2337.9 2351.3 2373.6 2374.9 2316.8 2340.5 2350.6 2354.3 2375.0 2337.9 2338.3 2343.4 2347.6 2348.6 7593.9 8570.8 8687.8 8770.6 8788.0 4751.6 5177.2 5195.2 5355.4 5361.8 3391.5 3561.8 3664.3 3675.9 3685.2 1068.2 1076.4 1096.2 1103.4 1104.8 9621.5 11468.8 11513.8 11533.4 11563.9 4626.3 4653.2 4731.6 4804.9 4810.3 9977.1 9977.3 9984.4 9995.0 10014.1 5369.1 5370.9 5375.1 5375.4 5380.7 4802.0 4873.2 4917.8 4957.0 4966.0 3713.9 3765.7 3787.9 3832.4 3857.0 1237.0 1240.1 1246.5 1255.0 1256.4 795.8 858.4 885.0 921.1 924.7 5760.2 5945.2 5945.6 6099.3 6195.1 940.2 945.4 961.2 965.2 987.3 2997.9 3834.9 3902.9 3972.8 4059.7 9793.3 10194.5 10688.6 10902.5 10954.6 10545.7 10685.6 10707.1 10710.1 10727.4 7904.4 8128.3 8136.6 8139.7 8170.6 5627.6 5875.1 5937.9 6051.2 6094.0 9911.8 9938.6 9939.6 9959.7 9975.5 9730.7 9829.4 10000.2 10158.8 10173.4 7280.8 7500.3 7597.1 7599.2 7614.0 8191.9 8289.8 8302.5 8309.8 8311.0 6621.9 6817.5 6900.7 6966.5 6967.7 6713.3 6766.5 6780.8 6794.3 6816.3 6320.9 6347.4 6401.7 6426.8 6454.2 4618.2 4636.8 4671.7 4700.7 4757.4 4592.2 4684.0 4783.4 4907.7 4936.0 00:42:45 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4414.76 Median:4931.56 stddev:1364.33 (27.7%) stddev-sans-first:1332.46 00:42:45 INFO - PROCESS | 1655 | Values: 283.7 290.1 292.1 295.3 301.8 4387.9 4409.8 4626.7 5050.4 5354.9 4001.7 4730.8 5165.3 5221.9 5275.8 3617.6 3754.5 3848.5 3854.8 3941.8 3521.8 3551.2 3662.9 3941.8 4034.0 3968.4 3984.9 4003.5 4029.5 4039.3 3749.8 3817.8 3974.7 4000.7 4060.3 3510.4 3516.8 3517.8 3518.2 3534.6 4781.6 4932.4 5146.5 5179.4 5180.5 4397.6 4592.4 4599.4 4626.3 4634.3 4820.0 5538.4 5539.3 5545.8 5617.8 3289.9 3905.4 3907.2 3921.3 3930.5 4884.8 4949.8 5374.5 5809.5 5873.9 3218.4 3368.7 3791.8 3808.2 3837.2 3450.9 3916.9 3920.3 3921.1 3923.1 3863.7 4537.5 4566.5 4575.5 4584.5 5415.2 5573.3 5585.9 5599.9 5624.8 1289.6 1312.0 1312.1 1315.0 1315.7 754.5 798.9 814.4 815.2 820.6 4377.1 4662.7 5011.6 5054.6 5150.2 4603.2 5636.2 5686.9 5704.6 5720.1 4371.5 4966.9 5162.8 5171.4 5195.8 2621.8 2911.3 2952.2 2961.8 2967.6 5368.8 5858.0 5870.2 5872.6 5908.5 5377.8 5756.7 5777.2 5791.9 5829.5 5546.5 5592.7 5833.7 5840.5 5852.9 4363.5 4778.0 5515.9 5615.9 5655.9 4628.4 5202.5 5334.7 5594.4 5611.3 5129.5 5275.5 5396.4 5596.6 5904.8 2834.4 3285.2 3530.6 3755.5 3789.8 4745.6 4974.4 5179.8 5551.7 5643.4 4834.1 5286.7 5464.5 5483.5 5519.6 4659.0 4930.8 5113.5 5398.8 5461.0 4285.8 5374.7 5384.0 5388.4 5409.0 4715.8 5228.8 5439.6 5486.3 5598.9 5392.7 5399.4 5425.9 5426.9 5434.3 00:42:45 INFO - PROCESS | 1655 | 00:42:45 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:23996.24 Median:3237.10 stddev:37297.68 (1152.2%) stddev-sans-first:37361.07 00:42:45 INFO - PROCESS | 1655 | Values: 635.6 681.1 789.0 807.5 832.9 15665.5 16586.3 16645.5 16655.2 16677.2 15011.2 15061.0 15152.5 15159.8 15235.2 668.8 692.4 834.1 858.6 862.9 833.3 844.1 844.6 849.9 850.2 774.3 919.4 920.3 920.8 921.3 715.7 913.3 914.7 915.1 915.8 660.3 684.6 688.0 688.9 690.8 14892.8 14942.0 14943.6 14943.6 14960.9 13741.9 13994.8 14132.4 14193.4 14553.3 12523.7 12699.9 12842.6 12943.5 13346.6 4613.3 4664.6 4667.3 4845.1 4851.6 116219.4 116334.4 116359.0 119485.4 120935.8 11184.5 11205.2 11235.8 11255.0 11584.1 21814.8 21926.3 21980.8 21989.9 22015.1 6654.8 7931.3 8155.3 8231.4 8267.0 4314.7 4359.3 4403.4 4485.5 4615.4 2598.6 3232.9 3234.0 3236.8 3237.4 625.4 645.1 654.2 668.9 672.0 540.9 608.9 609.1 630.6 636.8 8578.3 8688.3 8694.2 8879.4 8926.4 586.0 605.1 617.3 625.4 641.8 4161.9 4205.9 4408.6 4415.2 4524.9 97454.0 123464.0 123935.6 130613.0 161836.5 118368.0 121546.0 123004.0 123825.0 125617.1 87384.6 105830.5 107756.0 109671.1 109787.5 9044.0 9519.3 9726.8 9730.2 9797.4 56718.1 56962.7 57711.4 59364.7 60411.5 83473.6 83967.6 86252.9 88504.6 89143.7 12899.0 12950.6 13122.1 13197.6 13411.3 14828.0 14960.8 15059.8 15113.5 15264.0 13859.7 14280.5 14409.1 14415.9 14439.2 13416.4 13887.4 14007.0 14015.0 14089.0 11081.4 13376.7 13696.7 13719.4 13897.8 11030.7 11359.5 11469.3 11688.4 12001.6 7023.9 10686.4 10743.4 11304.8 11587.4 00:42:45 INFO - PROCESS | 1655 | -------- Summary: end -------- 00:42:45 INFO - PROCESS | 1655 | 00:42:46 INFO - TEST-INFO | 1655: exit 0 00:42:46 INFO - TEST-OK | dromaeo_css | took 1117942ms 00:42:46 INFO - TEST-START | kraken 00:42:46 INFO - operating with platform_type : mac_ 00:42:46 INFO - Initialising browser for kraken test... 00:42:46 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp8fbPKQ/profile http://localhost:49265/getInfo.html) 00:42:48 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 00:42:48 INFO - PROCESS | 1662 | colorDepth:24 00:42:48 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 00:42:48 INFO - PROCESS | 1662 | __metrics 00:42:48 INFO - PROCESS | 1662 | 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" 00:42:48 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:42:49 INFO - TEST-INFO | 1662: exit 0 00:42:49 INFO - Browser initialized. 00:42:49 INFO - Running cycle 1/1 for kraken test... 00:42:49 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp8fbPKQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:43:01 INFO - PROCESS | 1663 | RSS: Main: 228356096 00:43:01 INFO - PROCESS | 1663 | 00:43:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 00:43:04 INFO - PROCESS | 1663 | RSS: Main: 285401088 00:43:04 INFO - PROCESS | 1663 | 00:43:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 00:43:08 INFO - PROCESS | 1663 | RSS: Main: 293904384 00:43:08 INFO - PROCESS | 1663 | 00:43:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 00:43:12 INFO - PROCESS | 1663 | RSS: Main: 387141632 00:43:12 INFO - PROCESS | 1663 | 00:43:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 00:43:15 INFO - PROCESS | 1663 | RSS: Main: 289460224 00:43:15 INFO - PROCESS | 1663 | 00:43:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:43:17 INFO - PROCESS | 1663 | RSS: Main: 293777408 00:43:17 INFO - PROCESS | 1663 | 00:43:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 00:43:21 INFO - PROCESS | 1663 | RSS: Main: 330219520 00:43:21 INFO - PROCESS | 1663 | 00:43:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 00:43:24 INFO - PROCESS | 1663 | RSS: Main: 332468224 00:43:24 INFO - PROCESS | 1663 | 00:43:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 00:43:28 INFO - PROCESS | 1663 | RSS: Main: 332988416 00:43:28 INFO - PROCESS | 1663 | 00:43:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:43:30 INFO - PROCESS | 1663 | RSS: Main: 300670976 00:43:30 INFO - PROCESS | 1663 | 00:43:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:43:32 INFO - PROCESS | 1663 | RSS: Main: 307552256 00:43:32 INFO - PROCESS | 1663 | 00:43:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:43:35 INFO - PROCESS | 1663 | RSS: Main: 303869952 00:43:35 INFO - PROCESS | 1663 | 00:43:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:43:39 INFO - PROCESS | 1663 | RSS: Main: 313896960 00:43:39 INFO - PROCESS | 1663 | 00:43:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:43:42 INFO - PROCESS | 1663 | RSS: Main: 315121664 00:43:42 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 00:43:44 INFO - PROCESS | 1663 | RSS: Main: 358625280 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | __start_tp_report 00:43:44 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 00:43:44 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 00:43:44 INFO - PROCESS | 1663 | |i|pagename|runs| 00:43:44 INFO - PROCESS | 1663 | |0;ai-astar;103;113;112;112;110;112;110;112;113;112 00:43:44 INFO - PROCESS | 1663 | |1;audio-beat-detection;152;136;136;165;106;132;127;105;158;100 00:43:44 INFO - PROCESS | 1663 | |2;audio-dft;250;259;218;184;184;186;182;183;183;181 00:43:44 INFO - PROCESS | 1663 | |3;audio-fft;77;58;62;87;59;57;65;63;84;57 00:43:44 INFO - PROCESS | 1663 | |4;audio-oscillator;83;70;102;72;80;68;96;70;67;103 00:43:44 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;88;84;87;85;88;84;88;84;89;90 00:43:44 INFO - PROCESS | 1663 | |6;imaging-darkroom;94;93;94;95;92;94;94;95;93;93 00:43:44 INFO - PROCESS | 1663 | |7;imaging-desaturate;86;102;138;103;86;85;85;85;86;87 00:43:44 INFO - PROCESS | 1663 | |8;json-parse-financial;54;52;51;51;54;52;53;52;54;52 00:43:44 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;63;63;73;71;73;70;69;68;69;68 00:43:44 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;85;83;82;84;89;84;83;86;89;85 00:43:44 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;138;138;140;137;139;135;136;138;156;138 00:43:44 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;167;171;169;167;167;169;169;167;167;166 00:43:44 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;68;68;69;66;67;83;86;83;84 00:43:44 INFO - PROCESS | 1663 | __end_tp_report 00:43:44 INFO - PROCESS | 1663 | __start_cc_report 00:43:44 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2048 00:43:44 INFO - PROCESS | 1663 | __end_cc_report 00:43:44 INFO - PROCESS | 1663 | __startTimestamp1471506224732__endTimestamp 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | ------- Summary: start ------- 00:43:44 INFO - PROCESS | 1663 | Number of tests: 14 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.96 (2.6%) stddev-sans-first:1.09 00:43:44 INFO - PROCESS | 1663 | Values: 103.0 113.0 112.0 112.0 110.0 112.0 110.0 112.0 113.0 112.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:136.00 stddev:22.73 (16.7%) stddev-sans-first:22.89 00:43:44 INFO - PROCESS | 1663 | Values: 152.0 136.0 136.0 165.0 106.0 132.0 127.0 105.0 158.0 100.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:201.00 Median:185.00 stddev:30.31 (16.4%) stddev-sans-first:26.45 00:43:44 INFO - PROCESS | 1663 | Values: 250.0 259.0 218.0 184.0 184.0 186.0 182.0 183.0 183.0 181.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:66.90 Median:64.00 stddev:11.45 (17.9%) stddev-sans-first:11.54 00:43:44 INFO - PROCESS | 1663 | Values: 77.0 58.0 62.0 87.0 59.0 57.0 65.0 63.0 84.0 57.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:81.10 Median:71.00 stddev:14.31 (20.2%) stddev-sans-first:15.16 00:43:44 INFO - PROCESS | 1663 | Values: 83.0 70.0 102.0 72.0 80.0 68.0 96.0 70.0 67.0 103.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:2.26 (2.6%) stddev-sans-first:2.35 00:43:44 INFO - PROCESS | 1663 | Values: 88.0 84.0 87.0 85.0 88.0 84.0 88.0 84.0 89.0 90.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 00:43:44 INFO - PROCESS | 1663 | Values: 94.0 93.0 94.0 95.0 92.0 94.0 94.0 95.0 93.0 93.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:85.50 stddev:16.88 (19.7%) stddev-sans-first:17.63 00:43:44 INFO - PROCESS | 1663 | Values: 86.0 102.0 138.0 103.0 86.0 85.0 85.0 85.0 86.0 87.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:1.18 (2.2%) stddev-sans-first:1.12 00:43:44 INFO - PROCESS | 1663 | Values: 54.0 52.0 51.0 51.0 54.0 52.0 53.0 52.0 54.0 52.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.50 stddev:3.50 (5.0%) stddev-sans-first:3.04 00:43:44 INFO - PROCESS | 1663 | Values: 63.0 63.0 73.0 71.0 73.0 70.0 69.0 68.0 69.0 68.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.40 (2.8%) stddev-sans-first:2.55 00:43:44 INFO - PROCESS | 1663 | Values: 85.0 83.0 82.0 84.0 89.0 84.0 83.0 86.0 89.0 85.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:138.00 stddev:5.97 (4.3%) stddev-sans-first:6.30 00:43:44 INFO - PROCESS | 1663 | Values: 138.0 138.0 140.0 137.0 139.0 135.0 136.0 138.0 156.0 138.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.00 stddev:1.52 (0.9%) stddev-sans-first:1.58 00:43:44 INFO - PROCESS | 1663 | Values: 167.0 171.0 169.0 167.0 167.0 169.0 169.0 167.0 167.0 166.0 00:43:44 INFO - PROCESS | 1663 | 00:43:44 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:76.00 stddev:8.60 (11.3%) stddev-sans-first:8.72 00:43:44 INFO - PROCESS | 1663 | Values: 67.0 68.0 68.0 69.0 66.0 67.0 83.0 86.0 83.0 84.0 00:43:44 INFO - PROCESS | 1663 | -------- Summary: end -------- 00:43:44 INFO - PROCESS | 1663 | 00:43:45 INFO - TEST-INFO | 1663: exit 0 00:43:45 INFO - TEST-OK | kraken | took 59265ms 00:43:45 INFO - SUITE-END | took 1177s 00:43:45 INFO - Completed test suite (00:19:37) 00:43:45 INFO - javascript benchmark 00:43:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2834.3339315260914, 3379.8986030419096, 3393.575803024621, 3409.1136304560805, 3413.8293085345726, 5595.300587426572, 5653.689047102408, 5722.37053924068, 5763.279590051244, 5806.158107074471, 5715.77136914524, 5764.135379693048, 5770.480656740892, 5770.82687519374, 5774.018416869132, 5232.529072383485, 5276.366835979668, 5293.073712100387, 5302.2311764794085, 5352.973235133819, 5352.170413585881, 5360.303160589118, 5366.91949620756, 5367.838964831061, 5372.489613486732, 5228.424873263938, 5234.0840352938085, 5255.973720131394, 5256.658317209388, 5346.331708536433, 4341.413909122275, 5014.2979982802435, 5329.307190065267, 5339.199120131972, 5358.4373640767935, 5139.049275883936, 5143.922841157386, 5220.582353411756, 5237.214417837316, 5242.5281724644965, 5640.097584386478, 5720.656760594377, 5733.054046082391, 5737.540996720252, 5784.623999440065, 5263.789448422059, 6235.501159907242, 6297.118403423525, 6301.747930082791, 6315.273743519509, 6196.659183744892, 6246.750129994794, 6255.718492667841, 6328.905066424008, 6344.429001389897, 5836.416358364172, 5912.379200184005, 5932.911006334908, 5939.198208241918, 5941.940580594225, 6297.937020629735, 6303.810885673437, 6304.653244071528, 6322.304546499881, 6326.051092336186, 6029.065494848305, 6097.451229389376, 6129.328227221949, 6218.9378106219265, 6222.377762223832, 6279.937200627935, 6297.2128483939505, 6312.053192021233, 6319.58922670025, 6320.0, 6194.473469755031, 6256.562040657111, 6261.060840873814, 6263.812085637438, 6269.404406581368, 6117.462039585284, 6238.563300569007, 6296.338884417162, 6303.905441418382, 6322.114903913456, 4913.091078150554, 4929.112759703288, 4968.205087186033, 4979.053979743837, 4987.401511818605, 4414.80133393998, 4423.469183697913, 4441.356003379557, 4445.066536027471, 4473.0, 5612.5229355504425, 5754.539636829128, 5764.654120752768, 5790.0, 5830.300363956352, 6195.535334849904, 6249.593776404519, 6251.187345645037, 6295.3389894060465, 6299.842503937438, 4980.576650984634, 5657.896710141566, 5788.710564471844, 5822.883542329215, 5833.38749431312, 5463.535599474009, 5487.259220005328, 5511.807086752025, 5518.144687573433, 5532.806351777749, 5505.862353441196, 6141.915626108588, 6209.348018457997, 6255.843603909939, 6275.843103922439, 4689.109069276827, 6101.633901965719, 6292.842678933063, 6306.148669929685, 6323.367663233824, 6269.780557680459, 6315.5894866833505, 6326.082718005955, 6356.4279214870885, 6357.745690172342, 6115.970584430425, 6132.877342453036, 6136.171616831849, 6147.047207682816, 6160.199174107337, 6206.813795586139, 6211.16149319836, 6212.81361559154, 6216.316205217332, 6230.096635987847, 6010.699465026643, 6108.786192483241, 6140.600860944024, 6160.907586386118, 6191.690415479298, 6031.5476339273855, 6095.847603809941, 6120.9652521188555, 6133.877322453615, 6155.876882462236, 5983.910241346471, 6036.607620504653, 6037.335893051673, 6057.4760020063595, 6070.878582428415, 6155.753769849156, 6179.134921110958, 6179.969100154471, 6181.84545386369, 6187.876242475215, 5009.699418034929, 5903.173555702119, 5953.851153721192, 5968.46283834457, 5992.250968628921], "value": 5704.262058679962, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.790705329623, 505.967112137711, 516.1612379882691, 517.3197245622007, 526.4551189518846, 30564.694353056464, 32118.839405802966, 32256.516152257675, 40634.0, 41678.37482437766, 41463.37804932921, 41960.74117776464, 42016.369754453706, 42105.0, 42203.94490137748, 9687.903120968806, 9831.262655300845, 9858.408495490257, 9870.407775533455, 9891.50542472877, 9773.120419162275, 9863.0, 9874.851877221847, 9875.209983201326, 9910.405375677483, 9837.163841073518, 9908.0, 9919.0, 9919.752006199831, 9927.602895884156, 9826.754331141707, 9901.306908516406, 9907.356021858628, 9908.851367229498, 9911.008899110104, 9681.757956051084, 9719.757006074835, 9764.974677658814, 9774.902250977542, 9818.9509052455, 37863.0, 38207.61792382096, 38244.0, 38247.4262886057, 38266.808665956494, 3443.8622455101768, 3474.8436320365645, 3479.878204262864, 3489.1277180704824, 3520.8767693130617, 28279.434411311657, 30358.54462183069, 30945.535816962765, 30955.101391966204, 31056.844715776504, 3184.8407579620925, 3200.2799370141765, 3244.9453927473664, 3293.8847140350213, 3321.966780332214, 409259.0, 430673.0, 476708.0, 480624.0, 481173.0, 54702.45297547053, 54920.17619735707, 54946.450535494936, 54964.17553736697, 55032.724836375564, 33825.66174338274, 34253.0, 34473.827630861684, 57835.42164578385, 58051.41948580545, 16423.753643695352, 16472.25874835635, 16473.34106635745, 16474.83525164757, 16479.423220187236, 12616.17994830333, 12670.809937850756, 12686.492540298284, 12702.745945081231, 12753.171043882117, 18462.907685461487, 18484.353047643268, 18490.68866391701, 18526.0, 18581.44255672332, 7492.887606685904, 7569.394448444111, 7615.354633673454, 7690.96154519235, 7698.458708993926, 869.6347534035721, 912.2154946745793, 923.7275003873873, 938.2869019545059, 944.2634744898852, 26925.192244232705, 29765.809367625054, 30089.398212035638, 30519.0, 30642.38715225683, 1015.1777060580953, 1035.2701345551518, 1063.6277302943909, 1063.8297872340388, 1098.983365524256, 14443.49447769323, 15282.617934551725, 15421.537353879401, 15515.767263491056, 15881.841181588266, 681272.0, 689619.0, 691490.0, 692193.0, 692855.0, 57628.71185644045, 57832.132518012266, 57895.0, 57922.8415431689, 58092.0, 1211.3156066822216, 1336.1715736243398, 1360.4830164537611, 1361.6051345109806, 1376.8141300924447, 27211.727882721712, 30087.428098612858, 30469.847650761603, 31122.844385777928, 31261.000284199905, 46759.53240467688, 47217.76391118023, 47402.0, 47439.0, 47445.0, 443174.0, 443723.0, 447022.0, 447296.0, 456070.0, 22970.42573935665, 25422.237332880042, 25808.741912581387, 26127.869360653076, 26253.868730656224, 45374.77312613416, 46067.76966115148, 46490.53509464862, 46619.0, 47607.28589071236, 38269.80865095657, 38767.80616096901, 38768.0889061349, 39095.80452097835, 39663.80168099141, 38893.02767430837, 38958.0, 39212.803935981276, 40337.79831100826, 40577.79711101425, 37251.0, 38111.61888381081, 38370.0, 38374.052021936644, 38451.615483844806, 31282.21794455157, 33698.15754606154, 34564.48153277753, 34612.48081278833, 35184.64815351814, 25390.238292851245, 25476.872615636803, 25494.235172944842, 25636.61545076788, 26270.080547180758], "value": 19473.525661913038, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.4936102236422, 374.77138945243405, 385.72035274426037, 396.86704953840496, 406.93489041753327, 15870.682586348266, 16001.759973600405, 19734.0, 20352.1859125635, 20767.273145439933, 14693.55919322422, 19728.605427891434, 20116.0, 20439.0, 21505.46236344088, 5815.0, 6076.756929722806, 6081.695915204245, 6088.056351265561, 6092.817215483543, 3979.86070487533, 5746.827595172152, 6019.398060193989, 6357.332480089593, 6703.564268322543, 5758.3090029196555, 6575.178102737158, 6680.665966701646, 6697.0, 6707.597544147342, 6373.23521177457, 6589.868202635945, 6596.274409814917, 6627.304133066007, 6636.900446493258, 5245.291885595434, 5542.0855558832745, 5755.827325180251, 5763.394843541451, 5772.769089236425, 13294.135881167693, 13526.985476089234, 13530.526431574848, 13532.661683457894, 22604.43488912774, 2006.2276023730822, 2094.717213176217, 2095.3399679101035, 2116.8729876207476, 2316.5714342846627, 9722.854157187649, 10147.644832430904, 10299.691009269734, 10621.787564248672, 10703.732406689816, 1622.5862405086746, 1876.587150826816, 1892.9337473188373, 1964.0965156028244, 2019.2125071222235, 118715.0, 128889.35555322163, 128956.35521822331, 130349.34825325907, 133806.0, 11138.832917506244, 11470.139739519569, 11662.416879156008, 11670.124740644316, 11798.351090689923, 12110.57612983559, 14548.199849008406, 14565.635859103395, 14569.198694071927, 14574.344154513072, 8041.678332866737, 8142.877856832152, 8166.346692264605, 8200.835983280302, 8294.419390642597, 6623.437007854386, 7827.1390147083775, 7839.84320313602, 7957.482763620346, 7997.720079797179, 4081.4081958115908, 4256.6807489438415, 4523.977380113079, 4532.138893610204, 4611.400517932647, 1867.6264747050373, 1926.364299781069, 1928.3829174664254, 1928.7203355513373, 1932.1015727686693, 618.3105836991722, 727.7628032345035, 815.0545367373936, 857.8327226190958, 942.4816351007056, 16976.32094716222, 21312.254071107436, 21572.892135539223, 21710.457238568848, 21852.344429667137, 903.408267584733, 947.0955237747934, 962.2542529539663, 966.9033096690415, 996.6511720897773, 10956.452177391098, 11230.887691123147, 11382.829257561143, 11390.088792896548, 11467.197296189186, 559621.0, 568255.0, 570910.0, 586936.0, 622503.0, 108866.45566772274, 121693.3860226703, 133341.0, 133739.0, 138633.0, 906.2568693671126, 954.8663187153804, 968.5738275158908, 970.1995853420815, 974.2741657465092, 14512.709745804814, 16132.354705812106, 17508.299668013646, 18260.99564523964, 18877.71683424722, 40290.798546007085, 52494.99999999847, 53494.465055350505, 53897.73051134876, 54460.0, 71246.28753712605, 73050.63474682592, 73555.63222183855, 75412.86880696904, 77087.0, 5316.760745766527, 5542.140968149944, 7952.717318668037, 8284.544350060805, 8295.875561866698, 11103.500342484445, 12168.513259469522, 12641.988640908889, 12645.557405490763, 12674.366281686063, 10681.732956676145, 10838.403887785931, 11199.216054876406, 11292.266002709797, 11400.828987565028, 11409.543618255177, 11451.770964580495, 11503.942480287546, 11588.76822463529, 11994.64016079519, 5789.94210057894, 7164.749233777001, 11011.669649910515, 11346.773064538827, 11783.882161178279, 6768.120144381199, 8029.8394032120195, 8050.919490805251, 8348.0, 8506.234438900528, 8348.749537513884, 10353.482325883526, 11312.264702794291, 11681.299122052364, 11707.063434925356], "value": 9227.967759100273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.1555277951281, 1378.765609846326, 1513.0694622806977, 1670.8162102168767, 1839.6504664113825, 7650.617469126542, 8154.347652187826, 8158.265756081952, 8194.30348420385, 8203.835923281531, 8256.876146857787, 8499.830003399928, 8602.967643882743, 8677.435966662162, 8681.609327580258, 1970.3891793544012, 2377.702787151606, 2387.6657267982496, 2388.486475407787, 2388.904443822245, 2316.7683231676783, 2358.1982126077132, 2360.0677732295735, 2361.2207971369494, 2365.4914193448403, 2330.0, 2337.9181728639414, 2351.3416243451775, 2373.596488596943, 2374.9406264843346, 2316.791488766002, 2340.508493216418, 2350.6003979323555, 2354.2701762453694, 2375.0499800079933, 2337.94155146121, 2338.275134708246, 2343.425860664131, 2347.55396474671, 2348.5655153796433, 7593.886091708629, 8570.828583428296, 8687.826243475158, 8770.561471926441, 8788.0, 4751.619870410394, 5177.171652535576, 5195.220716892459, 5355.410904800468, 5361.785528578852, 3391.5251864738957, 3561.8041007744564, 3664.303782281358, 3675.9448608270895, 3685.1892583631557, 1068.2362111090529, 1076.359566058194, 1096.199774164856, 1103.3765922253901, 1104.7624760676413, 9621.470819104947, 11468.827967580493, 11513.827292590535, 11533.365664888428, 11563.884361156364, 4626.282926146453, 4653.208954477747, 4731.621470282369, 4804.879878003008, 4810.326554282403, 9977.052180042885, 9977.301588888853, 9984.400935943866, 9994.950025249827, 10014.148797352307, 5369.0872551665525, 5370.865728356823, 5375.1131063374105, 5375.354957405137, 5380.73096345189, 4802.0, 4873.220284754493, 4917.803287868517, 4957.0, 4966.0, 3713.9071523211596, 3765.7363984521367, 3787.886363409102, 3832.4442955771815, 3857.035741064734, 1237.047473445442, 1240.1195151442578, 1246.5138595947587, 1254.9623511294676, 1256.3718140929536, 795.8129839487716, 858.356232825381, 884.9733316117262, 921.1019256225127, 924.713338864954, 5760.193572899798, 5945.16767652529, 5945.643261404243, 6099.2985806632805, 6195.132681424604, 940.2243149401634, 945.4232917920064, 961.1974001708652, 965.1699538396973, 987.3067688913547, 2997.9100626981226, 3834.9424758628643, 3902.8829135125993, 3972.781497017634, 4059.7361171523758, 9793.265505087005, 10194.490275486196, 10688.625898093685, 10902.5093870776, 10954.616588419367, 10545.678111394885, 10685.626003089854, 10707.143428525855, 10710.143188544898, 10727.356358618508, 7904.4071694623135, 8128.268455839003, 8136.633851476579, 8139.715109971123, 8170.550619715973, 5627.634203776742, 5875.118732190205, 5937.851553711192, 6051.243594550681, 6093.969530152321, 9911.752206194902, 9938.602455901972, 9939.602415903571, 9959.651412200537, 9975.506123469133, 9730.659426920023, 9829.4102353859, 10000.199984001409, 10158.796824063626, 10173.389596624227, 7280.7815765525, 7500.324970752658, 7597.126330471845, 7599.240075992357, 7614.048243969504, 8191.918080819354, 8289.834203315779, 8302.460340078118, 8309.750707478785, 8311.002679678477, 6621.900671490028, 6817.454603631797, 6900.689468973807, 6966.512344135862, 6967.7212911485, 6713.261541230363, 6766.5263431559315, 6780.796576102724, 6794.320567943166, 6816.250212476524, 6320.905186422116, 6347.428731414195, 6401.679916004088, 6426.775062872777, 6454.19322584677, 4618.191816432044, 4636.83771068011, 4671.7430541320555, 4700.670953033255, 4757.3577567028005, 4592.242280023758, 4684.0, 4783.354247176587, 4907.705537667752, 4936.0], "value": 4509.17586146618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.7488822392183, 290.1093642517471, 292.1119795820705, 295.3089769938344, 301.82644979137, 4387.868363949078, 4409.845655402053, 4626.722396656203, 5050.41920179179, 5354.894161386396, 4001.679865610751, 4730.787114579844, 5165.328507294046, 5221.877296381277, 5275.788968441268, 3617.620149884264, 3754.5119134512474, 3848.5189351331082, 3854.8265328060165, 3941.8226179821977, 3521.806300653463, 3551.1654761131113, 3662.9084272893256, 3941.8423263069444, 4033.9596604034023, 3968.3849003404516, 3984.8605298814546, 4003.4795476588, 4029.4560234368278, 4039.333509970866, 3749.8125093745475, 3817.828197731095, 3974.721769476138, 4000.659943904772, 4060.2894493463527, 3510.4032314506594, 3516.7714098583765, 3517.8241087945757, 3518.2435776308216, 3534.575850897883, 4781.641376896712, 4932.358793356841, 5146.485351464861, 5179.430262671103, 5180.48195180479, 4397.582229688174, 4592.425946756655, 4599.402077729874, 4626.282926146419, 4634.328022436762, 4820.0, 5538.446155384469, 5539.307586551681, 5545.805896793593, 5617.80337688183, 3289.8649965761774, 3905.4337121117564, 3907.179492306619, 3921.3138999785238, 3930.508686414198, 4884.804607815648, 4949.826756063557, 5374.516293533601, 5809.506191973645, 5873.882522349529, 3218.3885061838178, 3368.696817286456, 3791.7724936503896, 3808.1622043150464, 3837.218016937698, 3450.861965521401, 3916.9424255450867, 3920.2551515212017, 3921.098147426051, 3923.1172986078473, 3863.7102217333813, 4537.500874903758, 4566.543345665474, 4575.519570445122, 4584.541545845455, 5415.241866138744, 5573.27547418833, 5585.88282343533, 5599.900037485942, 5624.831255062355, 1289.574440434673, 1311.9635487964592, 1312.1143228321037, 1315.0005995443341, 1315.6842357834241, 754.5397307642334, 798.9054994657357, 814.4014149600039, 815.2173913043426, 820.6225136437306, 4377.0808130293, 4662.743549104832, 5011.6241281904, 5054.570361519312, 5150.223173005307, 4603.194440972817, 5636.210930469738, 5686.914696279559, 5704.600677952503, 5720.082757793555, 4371.475422949203, 4966.8576227467165, 5162.845114646567, 5171.405288391883, 5195.818146364859, 2621.7902567794913, 2911.315840777416, 2952.1586347890748, 2961.8370989595346, 2967.554866770002, 5368.758405871745, 5857.970710146422, 5870.207521984563, 5872.592237182735, 5908.454927043739, 5377.811776587879, 5756.740946657411, 5777.24895763548, 5791.884162316815, 5829.47534721877, 5546.500814926595, 5592.692401917933, 5833.67914764692, 5840.532757379399, 5852.882942341129, 4363.47638283408, 4778.0, 5515.917261241005, 5615.943840561542, 5655.88688226225, 4628.449469427779, 5202.505761952609, 5334.653247538898, 5594.356648985418, 5611.298587676541, 5129.487051294841, 5275.472452754694, 5396.3524377075, 5596.599281693186, 5904.822855314347, 2834.4331133772916, 3285.225977971964, 3530.61163272045, 3755.511783468132, 3789.7536660117003, 4745.572898439157, 4974.403071631427, 5179.792808287626, 5551.666899986014, 5643.3510146332055, 4834.057358815138, 5286.656367336111, 5464.480874316933, 5483.506484416422, 5519.641223320471, 4658.976705116453, 4930.7534623267975, 5113.463086376026, 5398.811041613525, 5460.996451951331, 4285.849995250152, 5374.677519348852, 5384.0, 5388.4135614905845, 5408.972955135357, 4715.834945776881, 5228.849653076317, 5439.5648348132845, 5486.31421072366, 5598.888022239614, 5392.703401312965, 5399.406065332889, 5425.856786569204, 5426.891462170655, 5434.266374039612], "value": 3975.1811498919656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.5805168588731, 681.1383599746325, 789.0255534414996, 807.5477732469814, 832.9292010179134, 15665.45170919018, 16586.25361858716, 16645.50063498094, 16655.16724163793, 16677.24952377143, 15011.249437528135, 15061.0, 15152.54542363728, 15159.772603410931, 15235.162066086361, 668.7893313606211, 692.4045321023915, 834.0658462521984, 858.5535521528801, 862.8619420892659, 833.3208435125383, 844.1094645149365, 844.6156998565638, 849.9022612399591, 850.2220468271555, 774.2953911940135, 919.3564504846634, 920.3097676742443, 920.7513971227764, 921.258386998466, 715.7280233511284, 913.3423934767023, 914.6981496106268, 915.1077699243218, 915.8214148241095, 660.3462572053633, 684.555039224503, 688.0230073295932, 688.90355350251, 690.7547820523693, 14892.776608350883, 14942.028768130145, 14943.551693449213, 14943.626409339744, 14960.925195373953, 13741.931290343484, 13994.801987592438, 14132.36404361796, 14193.432262709479, 14553.345099470549, 12523.74952500954, 12699.936500317439, 12842.550510732079, 12943.482260709654, 13346.599602011955, 4613.284940834176, 4664.580187783082, 4667.346571479996, 4845.079434907391, 4851.636127290467, 116219.41890290579, 116334.41832790781, 116359.0, 119485.40257298744, 120935.79064209333, 11184.496697648463, 11205.215634905642, 11235.831462527905, 11255.0, 11584.073274138049, 21814.781852181593, 21926.342209733415, 21980.78019219819, 21989.890050549646, 22015.11939522433, 6654.833629159213, 7931.331497791795, 8155.306798922158, 8231.42380033404, 8267.049289331684, 4314.697971142053, 4359.280718681445, 4403.427554417905, 4485.529019452911, 4615.423072115986, 2598.5712357460807, 3232.9191770205935, 3233.9838300808815, 3236.821974791409, 3237.3848968695875, 625.352759893508, 645.1000853808911, 654.2214764430313, 668.886289330815, 672.028918213187, 540.9377921539074, 608.8903997280532, 609.1289456077762, 630.6468377708497, 636.8471566824021, 8578.313734901192, 8688.348373871984, 8694.176937278553, 8879.378443509022, 8926.419782714103, 586.0025967177854, 605.1346574398565, 617.3240301869446, 625.352759893508, 641.8491654461197, 4161.9375709364385, 4205.873823785291, 4408.647308215399, 4415.227335216325, 4524.9185374727995, 97454.0, 123464.0, 123935.56386616832, 130613.0, 161836.53370261248, 118368.0, 121546.0, 123004.0, 123825.0, 125617.11574326393, 87384.56307718548, 105830.47084764527, 107756.0, 109671.12959833653, 109787.45106274736, 9043.954780226057, 9519.286053545873, 9726.805463890541, 9730.221582273543, 9797.363171393836, 56718.14922776244, 56962.715186423804, 57711.422885770604, 59364.70317648384, 60411.48971275753, 83473.58263208646, 83967.58016210124, 86252.93645365647, 88504.5574772122, 89143.66284505867, 12899.0, 12950.611481655566, 13122.054993339532, 13197.604071877859, 13411.262380568773, 14828.036177648419, 14960.754619869183, 15059.849401505844, 15113.47102851395, 15264.0, 13859.65350866196, 14280.500182493563, 14409.13545187292, 14415.927920360331, 14439.2058436787, 13416.358629586368, 13887.37506812216, 14007.0, 14015.0, 14089.0, 11081.39052352096, 13376.732465350444, 13696.726065478435, 13719.432947433539, 13897.791533127214, 11030.724231894266, 11359.54561817518, 11469.31184128955, 11688.415579221175, 12001.63995080149, 7023.894641580278, 10686.358818470917, 10743.409112498888, 11304.830427543759, 11587.420628968686], "value": 7778.402610202988, "unit": "score"}], "name": "dromaeo_css", "value": 7230.863998244319, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 110.0, 112.0, 110.0, 112.0, 113.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 136.0, 136.0, 165.0, 106.0, 132.0, 127.0, 105.0, 158.0, 100.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [250.0, 259.0, 218.0, 184.0, 184.0, 186.0, 182.0, 183.0, 183.0, 181.0], "value": 201.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 62.0, 87.0, 59.0, 57.0, 65.0, 63.0, 84.0, 57.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 102.0, 72.0, 80.0, 68.0, 96.0, 70.0, 67.0, 103.0], "value": 81.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 85.0, 88.0, 84.0, 88.0, 84.0, 89.0, 90.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 95.0, 92.0, 94.0, 94.0, 95.0, 93.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 102.0, 138.0, 103.0, 86.0, 85.0, 85.0, 85.0, 86.0, 87.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 51.0, 54.0, 52.0, 53.0, 52.0, 54.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 73.0, 71.0, 73.0, 70.0, 69.0, 68.0, 69.0, 68.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 84.0, 89.0, 84.0, 83.0, 86.0, 89.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 140.0, 137.0, 139.0, 135.0, 136.0, 138.0, 156.0, 138.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 169.0, 167.0, 167.0, 169.0, 169.0, 167.0, 167.0, 166.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 69.0, 66.0, 67.0, 83.0, 86.0, 83.0, 84.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1454.0, "alertThreshold": 2.0}]} 00:43:45 INFO - Return code: 0 00:43:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:43:46 INFO - # TBPL SUCCESS # 00:43:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:43:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:43:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:43:46 INFO - 2016-08-18 00:43:46.042 screenresolution[1667:10808] starting screenresolution argv=screenresolution get 00:43:46 INFO - 2016-08-18 00:43:46.045 screenresolution[1667:10808] Display 0: 1600x1200x32@60 00:43:46 INFO - 2016-08-18 00:43:46.052 screenresolution[1668:10811] starting screenresolution argv=screenresolution list 00:43:46 INFO - Available Modes on Display 0 00:43:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:43:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:43:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:43:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:43:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:43:46 INFO - Intel Iris: 00:43:46 INFO - Chipset Model: Intel Iris 00:43:46 INFO - Type: GPU 00:43:46 INFO - Bus: Built-In 00:43:46 INFO - VRAM (Dynamic, Max): 1536 MB 00:43:46 INFO - Vendor: Intel (0x8086) 00:43:46 INFO - Device ID: 0x0a2e 00:43:46 INFO - Revision ID: 0x0009 00:43:46 INFO - Displays: 00:43:46 INFO - Display: 00:43:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:43:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:43:46 INFO - Display Serial Number: 1600x1200 60 00:43:46 INFO - Main Display: Yes 00:43:46 INFO - Mirror: Off 00:43:46 INFO - Online: Yes 00:43:46 INFO - Rotation: Supported 00:43:46 INFO - Return code: 0 00:43:46 INFO - Running post-action listener: _resource_record_post_action 00:43:46 INFO - [mozharness: 2016-08-18 07:43:46.291876Z] Finished run-tests step (success) 00:43:46 INFO - Running post-run listener: _resource_record_post_run 00:43:46 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 31431680; Write bytes: 704922112; Read time: 305; Write time: 1936 00:43:46 INFO - TinderboxPrint: CPU usage
53.5% 00:43:46 INFO - TinderboxPrint: I/O read bytes / time
31,431,680 / 305 00:43:46 INFO - TinderboxPrint: I/O write bytes / time
704,922,112 / 1,936 00:43:46 INFO - TinderboxPrint: CPU idle
2,255.4 (46.5%) 00:43:46 INFO - TinderboxPrint: CPU system
971.0 (20.0%) 00:43:46 INFO - TinderboxPrint: CPU user
1,623.3 (33.5%) 00:43:46 INFO - TinderboxPrint: Swap in / out
433,197,056 / 0 00:43:46 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392598016; Write bytes: 386692608; Read time: 29388; Write time: 671 00:43:46 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 29649920; Write bytes: 296119296; Read time: 287; Write time: 1217 00:43:46 INFO - Running post-run listener: _upload_blobber_files 00:43:46 INFO - Blob upload gear active. 00:43:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:43:46 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 00:43:46 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:43:46 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:43:47 INFO - (blobuploader) - INFO - Open directory for files ... 00:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:48 INFO - (blobuploader) - INFO - Done attempting. 00:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:43:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:49 INFO - (blobuploader) - INFO - Done attempting. 00:43:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:43:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:43:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:43:51 INFO - (blobuploader) - INFO - Done attempting. 00:43:51 INFO - (blobuploader) - INFO - Iteration through files over. 00:43:51 INFO - Return code: 0 00:43:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:43:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:43:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6e5bfe058b407e1dbf53f531de8d52e00f42efc20bfb7b0ef19292470d05d654159eb7bead572aa3ff44762ec6ecbc24c3e2bb6d27c2ebf6b336d8710e2b008", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2bc82aabafd1702b34d11e81b6a4d1003f7f8c268aa47050381921d7c5ce8e1bbb28bf213d85b103fc3410bd2bcdacaa7e996bcfd205090e8ba8c5f75cf148d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/48e3d53ff0697dcab34016365f34308bc6a07b62ad59d4f352f06f0c96dd4329f984f47512a444e306f84697166f93eb162c42801e0881382dadc5f53fcbdb7e"} 00:43:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:43:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:43:51 INFO - Contents: 00:43:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6e5bfe058b407e1dbf53f531de8d52e00f42efc20bfb7b0ef19292470d05d654159eb7bead572aa3ff44762ec6ecbc24c3e2bb6d27c2ebf6b336d8710e2b008", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2bc82aabafd1702b34d11e81b6a4d1003f7f8c268aa47050381921d7c5ce8e1bbb28bf213d85b103fc3410bd2bcdacaa7e996bcfd205090e8ba8c5f75cf148d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/48e3d53ff0697dcab34016365f34308bc6a07b62ad59d4f352f06f0c96dd4329f984f47512a444e306f84697166f93eb162c42801e0881382dadc5f53fcbdb7e"} 00:43:51 INFO - Running post-run listener: copy_logs_to_upload_dir 00:43:51 INFO - Copying logs to upload dir... 00:43:51 INFO - mkdir: /builds/slave/test/build/upload/logs 00:43:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.673975 ========= master_lag: 3.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-08-18 00:43:55.402232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 00:43:55.405654) ========= 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.CEFcdKdajG/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.IVCriRLRg8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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/Autoland/sha512/b6e5bfe058b407e1dbf53f531de8d52e00f42efc20bfb7b0ef19292470d05d654159eb7bead572aa3ff44762ec6ecbc24c3e2bb6d27c2ebf6b336d8710e2b008", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2bc82aabafd1702b34d11e81b6a4d1003f7f8c268aa47050381921d7c5ce8e1bbb28bf213d85b103fc3410bd2bcdacaa7e996bcfd205090e8ba8c5f75cf148d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/48e3d53ff0697dcab34016365f34308bc6a07b62ad59d4f352f06f0c96dd4329f984f47512a444e306f84697166f93eb162c42801e0881382dadc5f53fcbdb7e"} build_url:https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011527 build_url: 'https://queue.taskcluster.net/v1/task/RXNcgJfaQ9Gg_lrnyDOn1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b6e5bfe058b407e1dbf53f531de8d52e00f42efc20bfb7b0ef19292470d05d654159eb7bead572aa3ff44762ec6ecbc24c3e2bb6d27c2ebf6b336d8710e2b008", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2bc82aabafd1702b34d11e81b6a4d1003f7f8c268aa47050381921d7c5ce8e1bbb28bf213d85b103fc3410bd2bcdacaa7e996bcfd205090e8ba8c5f75cf148d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/48e3d53ff0697dcab34016365f34308bc6a07b62ad59d4f352f06f0c96dd4329f984f47512a444e306f84697166f93eb162c42801e0881382dadc5f53fcbdb7e"}' ========= master_lag: 0.93 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 00:43:56.344049) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:43:56.344390) ========= 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.CEFcdKdajG/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.IVCriRLRg8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005087 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 00:43:56.375610) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 00:43:56.375894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 00:43:56.376170) ========= ========= Total master_lag: 4.53 =========