builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0103 starttime: 1467737770.3 results: success (0) buildid: 20160705073512 builduid: f11ef69a890b45a9a24f57495fa5e290 revision: 059550e65473bb4a1cbb53c963e7ac7bc24b778a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:10.299155) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:10.299626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:10.299924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:10.350544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:10.350957) ========= 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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-07-05 09:56:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-07-05 09:56:10 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123500 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:10.496321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:10.496637) ========= 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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.020748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:10.545641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 09:56:10.546011) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 059550e65473bb4a1cbb53c963e7ac7bc24b778a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 059550e65473bb4a1cbb53c963e7ac7bc24b778a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JYQxcDIlnk/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.2i6Od9YMdu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-07-05 09:56:10,621 truncating revision to first 12 chars 2016-07-05 09:56:10,621 Setting DEBUG logging. 2016-07-05 09:56:10,621 attempt 1/10 2016-07-05 09:56:10,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/059550e65473?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 09:56:12,122 unpacking tar archive at: mozilla-beta-059550e65473/testing/mozharness/ program finished with exit code 0 elapsedTime=1.765481 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 09:56:12.333375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:12.333732) ========= script_repo_revision: 059550e65473bb4a1cbb53c963e7ac7bc24b778a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:12.334161) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:12.334470) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:56:12.353212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-05 09:56:12.353494) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JYQxcDIlnk/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.2i6Od9YMdu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:56:12 INFO - MultiFileLogger online at 20160705 09:56:12 in /builds/slave/test 09:56:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:56:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:12 INFO - {'append_to_log': False, 09:56:12 INFO - 'base_work_dir': '/builds/slave/test', 09:56:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:56:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:12 INFO - 'branch': 'Mozilla-Beta', 09:56:12 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:12 INFO - 'config_files': ('talos/mac_config.py',), 09:56:12 INFO - 'default_actions': ('clobber', 09:56:12 INFO - 'read-buildbot-config', 09:56:12 INFO - 'download-and-extract', 09:56:12 INFO - 'populate-webroot', 09:56:12 INFO - 'create-virtualenv', 09:56:12 INFO - 'install', 09:56:12 INFO - 'run-tests'), 09:56:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:12 INFO - 'download_minidump_stackwalk': True, 09:56:12 INFO - 'download_symbols': 'ondemand', 09:56:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:12 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:12 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:12 INFO - 'installer_path': 'installer.exe', 09:56:12 INFO - 'log_level': 'info', 09:56:12 INFO - 'log_name': 'talos', 09:56:12 INFO - 'log_to_console': True, 09:56:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:56:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:56:12 INFO - 'opt_config_files': (), 09:56:12 INFO - 'pip_index': False, 09:56:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:12 INFO - 'cmd': ('bash', 09:56:12 INFO - '-c', 09:56:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:12 INFO - 'enabled': True, 09:56:12 INFO - 'halt_on_failure': False, 09:56:12 INFO - 'name': 'check_screen_resolution'},), 09:56:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:12 INFO - 'cmd': ('bash', 09:56:12 INFO - '-c', 09:56:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:12 INFO - 'enabled': True, 09:56:12 INFO - 'halt_on_failure': False, 09:56:12 INFO - 'name': 'check_screen_resolution'},), 09:56:12 INFO - 'run_cmd_checks_enabled': True, 09:56:12 INFO - 'sps_profile': False, 09:56:12 INFO - 'sps_profile_interval': 0, 09:56:12 INFO - 'suite': 'dromaeojs', 09:56:12 INFO - 'system_bits': '32', 09:56:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:12 INFO - 'title': 't-yosemite-r7-0103', 09:56:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:12 INFO - 'use_talos_json': True, 09:56:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:12 INFO - 'work_dir': 'build'} 09:56:12 INFO - ##### 09:56:12 INFO - ##### Running clobber step. 09:56:12 INFO - ##### 09:56:12 INFO - Running pre-action listener: _resource_record_pre_action 09:56:12 INFO - Running main action method: clobber 09:56:12 INFO - rmtree: /builds/slave/test/build 09:56:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:14 INFO - Running post-action listener: _resource_record_post_action 09:56:14 INFO - ##### 09:56:14 INFO - ##### Running read-buildbot-config step. 09:56:14 INFO - ##### 09:56:14 INFO - Running pre-action listener: _resource_record_pre_action 09:56:14 INFO - Running main action method: read_buildbot_config 09:56:14 INFO - Using buildbot properties: 09:56:14 INFO - { 09:56:14 INFO - "project": "", 09:56:14 INFO - "product": "firefox", 09:56:14 INFO - "script_repo_revision": "production", 09:56:14 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:56:14 INFO - "repository": "", 09:56:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:56:14 INFO - "buildid": "20160705073512", 09:56:14 INFO - "pgo_build": "False", 09:56:14 INFO - "basedir": "/builds/slave/test", 09:56:14 INFO - "buildnumber": 17, 09:56:14 INFO - "slavename": "t-yosemite-r7-0103", 09:56:14 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:56:14 INFO - "platform": "yosemite_r7", 09:56:14 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:56:14 INFO - "branch": "mozilla-beta", 09:56:14 INFO - "repo_path": "releases/mozilla-beta", 09:56:14 INFO - "revision": "059550e65473bb4a1cbb53c963e7ac7bc24b778a", 09:56:14 INFO - "stage_platform": "macosx64", 09:56:14 INFO - "builduid": "f11ef69a890b45a9a24f57495fa5e290", 09:56:14 INFO - "slavebuilddir": "test" 09:56:14 INFO - } 09:56:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 09:56:14 INFO - Running post-action listener: _resource_record_post_action 09:56:14 INFO - ##### 09:56:14 INFO - ##### Running download-and-extract step. 09:56:14 INFO - ##### 09:56:14 INFO - Running pre-action listener: _resource_record_pre_action 09:56:14 INFO - Running main action method: download_and_extract 09:56:14 INFO - mkdir: /builds/slave/test/build/tests 09:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:14 INFO - https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 09:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 09:56:19 INFO - Downloaded 1165 bytes. 09:56:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 09:56:19 INFO - Using the following test package requirements: 09:56:19 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:56:19 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:56:19 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 09:56:19 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:56:19 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 09:56:19 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:56:19 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:56:19 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 09:56:19 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 09:56:19 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:56:19 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 09:56:19 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:56:19 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 09:56:19 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:56:19 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 09:56:19 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 09:56:19 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 09:56:19 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 09:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:19 INFO - https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 09:56:23 INFO - Downloaded 18351435 bytes. 09:56:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:56:27 INFO - Return code: 0 09:56:27 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:27 INFO - https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 09:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 09:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 09:56:33 INFO - Downloaded 18351435 bytes. 09:56:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:56:36 INFO - Return code: 0 09:56:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:36 INFO - https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 09:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 09:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 09:56:37 INFO - Downloaded 10840145 bytes. 09:56:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:56:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:56:37 INFO - Return code: 0 09:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:37 INFO - https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 09:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 09:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 09:56:40 INFO - Downloaded 86196451 bytes. 09:56:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:56:40 INFO - mkdir: /builds/slave/test/properties 09:56:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:56:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:56:40 INFO - Contents: 09:56:40 INFO - build_url:https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 09:56:41 INFO - Running post-action listener: _resource_record_post_action 09:56:41 INFO - Running post-action listener: set_extra_try_arguments 09:56:41 INFO - ##### 09:56:41 INFO - ##### Running populate-webroot step. 09:56:41 INFO - ##### 09:56:41 INFO - Running pre-action listener: _resource_record_pre_action 09:56:41 INFO - Running main action method: populate_webroot 09:56:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:41 INFO - '--tppagecycles', 09:56:41 INFO - '7'], 09:56:41 INFO - 'tests': ['tsvgm']}}, 09:56:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:56:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:56:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:56:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:41 INFO - 'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:41 INFO - 'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['damp', 'tps']}, 09:56:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:41 INFO - 'tests': ['damp', 'tps']}, 09:56:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['dromaeo_dom']}, 09:56:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['a11yr', 09:56:41 INFO - 'ts_paint', 09:56:41 INFO - 'tpaint', 09:56:41 INFO - 'sessionrestore', 09:56:41 INFO - 'sessionrestore_no_auto_restore', 09:56:41 INFO - 'tabpaint']}, 09:56:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:56:41 INFO - 'ts_paint', 09:56:41 INFO - 'tpaint', 09:56:41 INFO - 'sessionrestore', 09:56:41 INFO - 'sessionrestore_no_auto_restore', 09:56:41 INFO - 'tabpaint']}, 09:56:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:56:41 INFO - 'ts_paint', 09:56:41 INFO - 'tpaint', 09:56:41 INFO - 'sessionrestore', 09:56:41 INFO - 'sessionrestore_no_auto_restore', 09:56:41 INFO - 'tabpaint']}, 09:56:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:56:41 INFO - 'ts_paint', 09:56:41 INFO - 'tpaint', 09:56:41 INFO - 'sessionrestore', 09:56:41 INFO - 'sessionrestore_no_auto_restore', 09:56:41 INFO - 'tabpaint']}, 09:56:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['a11yr', 09:56:41 INFO - 'ts_paint', 09:56:41 INFO - 'tpaint', 09:56:41 INFO - 'sessionrestore', 09:56:41 INFO - 'sessionrestore_no_auto_restore', 09:56:41 INFO - 'tabpaint']}, 09:56:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['a11yr', 09:56:41 INFO - 'ts_paint', 09:56:41 INFO - 'tpaint', 09:56:41 INFO - 'sessionrestore', 09:56:41 INFO - 'sessionrestore_no_auto_restore', 09:56:41 INFO - 'tabpaint']}, 09:56:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['tsvgx', 09:56:41 INFO - 'tsvgr_opacity', 09:56:41 INFO - 'tart', 09:56:41 INFO - 'tscrollx', 09:56:41 INFO - 'cart']}, 09:56:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:56:41 INFO - 'tsvgr_opacity', 09:56:41 INFO - 'tart', 09:56:41 INFO - 'tscrollx', 09:56:41 INFO - 'cart']}, 09:56:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:41 INFO - 'talos_options': ['--disable-e10s'], 09:56:41 INFO - 'tests': ['tp5o']}, 09:56:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:41 INFO - 'tests': ['tp5o']}, 09:56:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:41 INFO - 'talos_options': ['--disable-e10s', 09:56:41 INFO - '--xperf_path', 09:56:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:41 INFO - 'tests': ['tp5n']}, 09:56:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:41 INFO - 'talos_options': ['--xperf_path', 09:56:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:41 INFO - 'tests': ['tp5n']}}, 09:56:41 INFO - 'talos.zip': {'path': '', 09:56:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:41 INFO - Running post-action listener: _resource_record_post_action 09:56:41 INFO - ##### 09:56:41 INFO - ##### Running create-virtualenv step. 09:56:41 INFO - ##### 09:56:41 INFO - Running pre-action listener: _resource_record_pre_action 09:56:41 INFO - Running main action method: create_virtualenv 09:56:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:56:41 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 09:56:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:56:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:42 INFO - Using real prefix '/tools/python27' 09:56:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:45 INFO - Installing pip.................done. 09:56:45 INFO - Return code: 0 09:56:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:45 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 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:56:45 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 09:56:45 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 09:56:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:56:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:45 INFO - 'HOME': '/Users/cltbld', 09:56:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:45 INFO - 'LOGNAME': 'cltbld', 09:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:45 INFO - 'MOZ_NO_REMOTE': '1', 09:56:45 INFO - 'NO_EM_RESTART': '1', 09:56:45 INFO - 'PAGER': '/bin/cat', 09:56:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:45 INFO - 'PWD': '/builds/slave/test', 09:56:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:45 INFO - 'SHELL': '/bin/bash', 09:56:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:56:45 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:56:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:45 INFO - 'USER': 'cltbld', 09:56:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:45 INFO - 'XPC_FLAGS': '0x0', 09:56:45 INFO - 'XPC_SERVICE_NAME': '0', 09:56:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:45 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 09:56:45 INFO - Cleaning up... 09:56:45 INFO - Return code: 0 09:56:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:45 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:56:45 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>=0.7.1'] in /builds/slave/test/build 09:56:45 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>=0.7.1 09:56:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:56:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:45 INFO - 'HOME': '/Users/cltbld', 09:56:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:45 INFO - 'LOGNAME': 'cltbld', 09:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:45 INFO - 'MOZ_NO_REMOTE': '1', 09:56:45 INFO - 'NO_EM_RESTART': '1', 09:56:45 INFO - 'PAGER': '/bin/cat', 09:56:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:45 INFO - 'PWD': '/builds/slave/test', 09:56:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:45 INFO - 'SHELL': '/bin/bash', 09:56:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:56:45 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:56:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:45 INFO - 'USER': 'cltbld', 09:56:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:45 INFO - 'XPC_FLAGS': '0x0', 09:56:45 INFO - 'XPC_SERVICE_NAME': '0', 09:56:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:46 INFO - Downloading/unpacking psutil>=0.7.1 09:56:46 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 09:56:46 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 09:56:46 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 09:56:46 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 09:56:46 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 09:56:46 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 09:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:49 INFO - Installing collected packages: psutil 09:56:49 INFO - Running setup.py install for psutil 09:56:49 INFO - building 'psutil._psutil_osx' extension 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 INFO - building 'psutil._psutil_posix' extension 09:56:49 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 09:56:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:56:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:56:49 INFO - ^ 09:56:49 INFO - 1 warning generated. 09:56:49 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 09:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:50 INFO - Successfully installed psutil 09:56:50 INFO - Cleaning up... 09:56:50 INFO - Return code: 0 09:56:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:50 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:56:50 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.0.0'] in /builds/slave/test/build 09:56:50 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.0.0 09:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:50 INFO - 'HOME': '/Users/cltbld', 09:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:50 INFO - 'LOGNAME': 'cltbld', 09:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:50 INFO - 'MOZ_NO_REMOTE': '1', 09:56:50 INFO - 'NO_EM_RESTART': '1', 09:56:50 INFO - 'PAGER': '/bin/cat', 09:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:50 INFO - 'PWD': '/builds/slave/test', 09:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:50 INFO - 'SHELL': '/bin/bash', 09:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:56:50 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:50 INFO - 'USER': 'cltbld', 09:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:50 INFO - 'XPC_FLAGS': '0x0', 09:56:50 INFO - 'XPC_SERVICE_NAME': '0', 09:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:56:52 INFO - Installing collected packages: mozsystemmonitor 09:56:52 INFO - Running setup.py install for mozsystemmonitor 09:56:53 INFO - Successfully installed mozsystemmonitor 09:56:53 INFO - Cleaning up... 09:56:53 INFO - Return code: 0 09:56:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:56:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:53 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 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:56:53 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 09:56:53 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 09:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:53 INFO - 'HOME': '/Users/cltbld', 09:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:53 INFO - 'LOGNAME': 'cltbld', 09:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:53 INFO - 'MOZ_NO_REMOTE': '1', 09:56:53 INFO - 'NO_EM_RESTART': '1', 09:56:53 INFO - 'PAGER': '/bin/cat', 09:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:53 INFO - 'PWD': '/builds/slave/test', 09:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:53 INFO - 'SHELL': '/bin/bash', 09:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:56:53 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:53 INFO - 'USER': 'cltbld', 09:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:53 INFO - 'XPC_FLAGS': '0x0', 09:56:53 INFO - 'XPC_SERVICE_NAME': '0', 09:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:53 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:53 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 09:56:53 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 09:56:53 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 09:56:53 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 09:56:53 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 09:56:53 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 09:56:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56:55 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 09:56:55 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 09:56:55 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 09:56:55 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 09:56:55 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 09:56:55 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 09:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:56:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:56 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 09:56:56 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 09:56:56 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 09:56:56 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 09:56:56 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 09:56:56 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 09:56:57 INFO - Downloading docopt-0.6.1.tar.gz 09:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:57 INFO - Running setup.py install for blobuploader 09:56:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:56:57 INFO - Running setup.py install for requests 09:56:57 INFO - Running setup.py install for docopt 09:56:57 INFO - Successfully installed blobuploader requests docopt 09:56:57 INFO - Cleaning up... 09:56:58 INFO - Return code: 0 09:56:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:58 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 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:56:58 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 09:56:58 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 09:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:56:58 INFO - 'HOME': '/Users/cltbld', 09:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:56:58 INFO - 'LOGNAME': 'cltbld', 09:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:58 INFO - 'MOZ_NO_REMOTE': '1', 09:56:58 INFO - 'NO_EM_RESTART': '1', 09:56:58 INFO - 'PAGER': '/bin/cat', 09:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:58 INFO - 'PWD': '/builds/slave/test', 09:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:56:58 INFO - 'SHELL': '/bin/bash', 09:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:56:58 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:56:58 INFO - 'USER': 'cltbld', 09:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:58 INFO - 'XPC_FLAGS': '0x0', 09:56:58 INFO - 'XPC_SERVICE_NAME': '0', 09:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:58 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-UPXLKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:58 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Pg4ghc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:58 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-sezqdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:58 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-eqYmNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:58 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-jA2kgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:58 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-pf0g9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:58 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-j1H4Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-f6yWo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-LXzpDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Y40tV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-mRXPaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-hrU3UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-navZ6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-KyCfVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ihe_L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:59 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-BTRaIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:00 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-eA4Y4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:00 INFO - Running setup.py install for manifestparser 09:57:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:00 INFO - Running setup.py install for mozcrash 09:57:00 INFO - Running setup.py install for mozdebug 09:57:00 INFO - Running setup.py install for mozdevice 09:57:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:00 INFO - Running setup.py install for mozfile 09:57:00 INFO - Running setup.py install for mozhttpd 09:57:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:00 INFO - Running setup.py install for mozinfo 09:57:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:01 INFO - Running setup.py install for mozInstall 09:57:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:01 INFO - Running setup.py install for mozleak 09:57:01 INFO - Running setup.py install for mozlog 09:57:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:01 INFO - Running setup.py install for moznetwork 09:57:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:01 INFO - Running setup.py install for mozprocess 09:57:01 INFO - Running setup.py install for mozprofile 09:57:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:02 INFO - Running setup.py install for mozrunner 09:57:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:02 INFO - Running setup.py install for mozscreenshot 09:57:02 INFO - Running setup.py install for moztest 09:57:02 INFO - Running setup.py install for mozversion 09:57:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:02 INFO - Cleaning up... 09:57:02 INFO - Return code: 0 09:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:02 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 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:57:02 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 09:57:02 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 09:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:02 INFO - 'HOME': '/Users/cltbld', 09:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:02 INFO - 'LOGNAME': 'cltbld', 09:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:02 INFO - 'MOZ_NO_REMOTE': '1', 09:57:02 INFO - 'NO_EM_RESTART': '1', 09:57:02 INFO - 'PAGER': '/bin/cat', 09:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:02 INFO - 'PWD': '/builds/slave/test', 09:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:02 INFO - 'SHELL': '/bin/bash', 09:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:57:02 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:02 INFO - 'USER': 'cltbld', 09:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:02 INFO - 'XPC_FLAGS': '0x0', 09:57:02 INFO - 'XPC_SERVICE_NAME': '0', 09:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:02 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-A53Rj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-pTqRxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-97RZ8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-7qOhH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-OK9k1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-j3lyxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-K8hLh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-3baZQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-mA09a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:03 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-BKbCJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 09:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:03 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-df7C_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:04 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)) 09:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:04 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-1PRxMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 09:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:04 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Ost840-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:04 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)) 09:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:04 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-tfcGLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 09:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:04 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-I4GYom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:04 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)) 09:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:04 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-lwSn4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:04 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)) 09:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:04 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-sQw28B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:04 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)) 09:57:04 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)) 09:57:04 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)) 09:57:04 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)) 09:57:04 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)) 09:57:04 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)) 09:57:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:04 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 09:57:04 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 09:57:04 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 09:57:04 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 09:57:04 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 09:57:04 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 09:57:07 INFO - Downloading blessings-1.6.tar.gz 09:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:07 INFO - Installing collected packages: blessings 09:57:07 INFO - Running setup.py install for blessings 09:57:07 INFO - Successfully installed blessings 09:57:07 INFO - Cleaning up... 09:57:07 INFO - Return code: 0 09:57:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:07 INFO - Reading from file tmpfile_stdout 09:57:07 INFO - Current package versions: 09:57:07 INFO - blessings == 1.6 09:57:07 INFO - blobuploader == 1.2.4 09:57:07 INFO - docopt == 0.6.1 09:57:07 INFO - manifestparser == 1.1 09:57:07 INFO - mozInstall == 1.12 09:57:07 INFO - mozcrash == 0.17 09:57:07 INFO - mozdebug == 0.1 09:57:07 INFO - mozdevice == 0.48 09:57:07 INFO - mozfile == 1.2 09:57:07 INFO - mozhttpd == 0.7 09:57:07 INFO - mozinfo == 0.9 09:57:07 INFO - mozleak == 0.1 09:57:07 INFO - mozlog == 3.1 09:57:07 INFO - moznetwork == 0.27 09:57:07 INFO - mozprocess == 0.22 09:57:07 INFO - mozprofile == 0.28 09:57:07 INFO - mozrunner == 6.11 09:57:07 INFO - mozscreenshot == 0.1 09:57:07 INFO - mozsystemmonitor == 0.0 09:57:07 INFO - moztest == 0.7 09:57:07 INFO - mozversion == 1.4 09:57:07 INFO - psutil == 3.1.1 09:57:07 INFO - requests == 1.2.3 09:57:07 INFO - wsgiref == 0.1.2 09:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:08 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 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:57:08 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 09:57:08 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 09:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:08 INFO - 'HOME': '/Users/cltbld', 09:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:08 INFO - 'LOGNAME': 'cltbld', 09:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:08 INFO - 'MOZ_NO_REMOTE': '1', 09:57:08 INFO - 'NO_EM_RESTART': '1', 09:57:08 INFO - 'PAGER': '/bin/cat', 09:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:08 INFO - 'PWD': '/builds/slave/test', 09:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:08 INFO - 'SHELL': '/bin/bash', 09:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:57:08 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:08 INFO - 'USER': 'cltbld', 09:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:08 INFO - 'XPC_FLAGS': '0x0', 09:57:08 INFO - 'XPC_SERVICE_NAME': '0', 09:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 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)) 09:57:08 INFO - Cleaning up... 09:57:08 INFO - Return code: 0 09:57:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:08 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 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:57:08 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 09:57:08 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 09:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:08 INFO - 'HOME': '/Users/cltbld', 09:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:08 INFO - 'LOGNAME': 'cltbld', 09:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:08 INFO - 'MOZ_NO_REMOTE': '1', 09:57:08 INFO - 'NO_EM_RESTART': '1', 09:57:08 INFO - 'PAGER': '/bin/cat', 09:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:08 INFO - 'PWD': '/builds/slave/test', 09:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:08 INFO - 'SHELL': '/bin/bash', 09:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:57:08 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:08 INFO - 'USER': 'cltbld', 09:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:08 INFO - 'XPC_FLAGS': '0x0', 09:57:08 INFO - 'XPC_SERVICE_NAME': '0', 09:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:08 INFO - Downloading/unpacking jsonschema 09:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:11 INFO - Downloading/unpacking functools32 (from jsonschema) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:11 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:11 INFO - warning: no files found matching '*.txt' 09:57:11 INFO - no previously-included directories found matching 'build' 09:57:11 INFO - no previously-included directories found matching 'dist' 09:57:11 INFO - no previously-included directories found matching '.git*' 09:57:11 INFO - Installing collected packages: jsonschema, functools32 09:57:11 INFO - Running setup.py install for functools32 09:57:11 INFO - warning: no files found matching '*.txt' 09:57:11 INFO - no previously-included directories found matching 'build' 09:57:11 INFO - no previously-included directories found matching 'dist' 09:57:11 INFO - no previously-included directories found matching '.git*' 09:57:11 INFO - Successfully installed jsonschema functools32 09:57:11 INFO - Cleaning up... 09:57:11 INFO - Return code: 0 09:57:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d96420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8540c8a4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, '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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 09:57: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', 'flake8'] in /builds/slave/test/build 09:57: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 flake8 09:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:11 INFO - 'HOME': '/Users/cltbld', 09:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:11 INFO - 'LOGNAME': 'cltbld', 09:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:11 INFO - 'MOZ_NO_REMOTE': '1', 09:57:11 INFO - 'NO_EM_RESTART': '1', 09:57:11 INFO - 'PAGER': '/bin/cat', 09:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:11 INFO - 'PWD': '/builds/slave/test', 09:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:11 INFO - 'SHELL': '/bin/bash', 09:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:57:11 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:11 INFO - 'USER': 'cltbld', 09:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:11 INFO - 'XPC_FLAGS': '0x0', 09:57:11 INFO - 'XPC_SERVICE_NAME': '0', 09:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:12 INFO - Downloading/unpacking flake8 09:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:57:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:57:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:57:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:15 INFO - no previously-included directories found matching 'docs/_build' 09:57:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:57:15 INFO - Running setup.py install for pep8 09:57:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:57:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:57:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:57:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:57:15 INFO - no previously-included directories found matching 'docs/_build' 09:57:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:57:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:57:16 INFO - Cleaning up... 09:57:16 INFO - Return code: 0 09:57:16 INFO - Running post-action listener: _resource_record_post_action 09:57:16 INFO - Running post-action listener: _start_resource_monitoring 09:57:16 INFO - Starting resource monitoring. 09:57:16 INFO - ##### 09:57:16 INFO - ##### Running install step. 09:57:16 INFO - ##### 09:57:16 INFO - Running pre-action listener: _resource_record_pre_action 09:57:16 INFO - Running main action method: install 09:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:16 INFO - Reading from file tmpfile_stdout 09:57:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:16 INFO - Reading from file tmpfile_stdout 09:57:16 INFO - Output received: 09:57:16 INFO - Usage: mozinstall [options] installer 09:57:16 INFO - Options: 09:57:16 INFO - -h, --help show this help message and exit 09:57:16 INFO - -d DEST, --destination=DEST 09:57:16 INFO - Directory to install application into. [default: 09:57:16 INFO - "/builds/slave/test"] 09:57:16 INFO - --app=APP Application being installed. [default: firefox] 09:57:16 INFO - mkdir: /builds/slave/test/build/application 09:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:57:38 INFO - Reading from file tmpfile_stdout 09:57:38 INFO - Output received: 09:57:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:57:38 INFO - Running post-action listener: _resource_record_post_action 09:57:38 INFO - ##### 09:57:38 INFO - ##### Running run-tests step. 09:57:38 INFO - ##### 09:57:38 INFO - Running pre-action listener: _resource_record_pre_action 09:57:38 INFO - Running main action method: run_tests 09:57:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:57:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:57:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:57:38 INFO - 2016-07-05 09:57:38.276 screenresolution[1979:10517] starting screenresolution argv=screenresolution get 09:57:38 INFO - 2016-07-05 09:57:38.279 screenresolution[1979:10517] Display 0: 1600x1200x32@60 09:57:38 INFO - 2016-07-05 09:57:38.285 screenresolution[1980:10519] starting screenresolution argv=screenresolution list 09:57:38 INFO - Available Modes on Display 0 09:57:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:57:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:57:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:57:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:57:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:57:38 INFO - Intel Iris: 09:57:38 INFO - Chipset Model: Intel Iris 09:57:38 INFO - Type: GPU 09:57:38 INFO - Bus: Built-In 09:57:38 INFO - VRAM (Dynamic, Max): 1536 MB 09:57:38 INFO - Vendor: Intel (0x8086) 09:57:38 INFO - Device ID: 0x0a2e 09:57:38 INFO - Revision ID: 0x0009 09:57:38 INFO - Displays: 09:57:38 INFO - Display: 09:57:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:57:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:57:38 INFO - Display Serial Number: 1600x1200 60 09:57:38 INFO - Main Display: Yes 09:57:38 INFO - Mirror: Off 09:57:38 INFO - Online: Yes 09:57:38 INFO - Rotation: Supported 09:57:38 INFO - Return code: 0 09:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:38 INFO - Python 2.7.3 09:57:38 INFO - Return code: 0 09:57:38 INFO - grabbing minidump binary from tooltool 09:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:38 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c25e00>, '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 0x108a8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c20b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:38 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 09:57:38 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 09:57:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:38 INFO - Return code: 0 09:57:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:57:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:57:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:57:39 INFO - Return code: 0 09:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--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 09:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --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 09:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JYQxcDIlnk/Render', 09:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:39 INFO - 'HOME': '/Users/cltbld', 09:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:39 INFO - 'LOGNAME': 'cltbld', 09:57:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:57:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:39 INFO - 'MOZ_NO_REMOTE': '1', 09:57:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:57:39 INFO - 'NO_EM_RESTART': '1', 09:57:39 INFO - 'PAGER': '/bin/cat', 09:57:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:39 INFO - 'PWD': '/builds/slave/test', 09:57:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:39 INFO - 'SHELL': '/bin/bash', 09:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2i6Od9YMdu/Listeners', 09:57:39 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 09:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:39 INFO - 'USER': 'cltbld', 09:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:39 INFO - 'XPC_FLAGS': '0x0', 09:57:39 INFO - 'XPC_SERVICE_NAME': '0', 09:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--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 09:57:39 INFO - mozversion application_buildid: 20160705073512 09:57:39 INFO - mozversion application_changeset: 059550e65473bb4a1cbb53c963e7ac7bc24b778a 09:57:39 INFO - mozversion application_display_name: Firefox 09:57:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:39 INFO - mozversion application_name: Firefox 09:57:39 INFO - mozversion application_remotingname: firefox 09:57:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:57:39 INFO - mozversion application_vendor: Mozilla 09:57:39 INFO - mozversion application_version: 48.0 09:57:39 INFO - mozversion platform_buildid: 20160705073512 09:57:39 INFO - mozversion platform_changeset: 059550e65473bb4a1cbb53c963e7ac7bc24b778a 09:57:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:57:39 INFO - mozversion platform_version: 48.0 09:57:39 INFO - using testdate: 1467737859 09:57:39 INFO - actual date: 1467737859 09:57:39 INFO - starting webserver on 'localhost:49394' 09:57:39 INFO - SUITE-START | Running 2 tests 09:57:39 INFO - TEST-START | dromaeo_css 09:57:39 INFO - operating with platform_type : mac_ 09:57:39 INFO - Initialising browser for dromaeo_css test... 09:57:39 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpHY_vWm/profile http://localhost:49394/getInfo.html) 09:57:42 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 09:57:42 INFO - PROCESS | 1998 | colorDepth:24 09:57:42 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 09:57:42 INFO - PROCESS | 1998 | __metrics 09:57:42 INFO - PROCESS | 1998 | 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" 09:57:42 ERROR - PROCESS | 1998 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:57:42 INFO - TEST-INFO | 1998: exit 0 09:57:42 INFO - Browser initialized. 09:57:42 INFO - Running cycle 1/1 for dromaeo_css test... 09:57:42 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpHY_vWm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:54 INFO - PROCESS | 2001 | RSS: Main: 161660928 09:57:54 INFO - PROCESS | 2001 | 09:58:46 INFO - PROCESS | 2001 | 1467737926039 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] 10:00:56 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49394/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49394/tests/dromaeo/cssquery-ext.html) 10:00:57 INFO - PROCESS | 2001 | RSS: Main: 302407680 10:00:57 INFO - PROCESS | 2001 | 10:04:00 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49394/tests/dromaeo/cssquery-ext.html (next: http://localhost:49394/tests/dromaeo/cssquery-jquery.html) 10:04:00 INFO - PROCESS | 2001 | RSS: Main: 304574464 10:04:00 INFO - PROCESS | 2001 | 10:07:02 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49394/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49394/tests/dromaeo/cssquery-mootools.html) 10:07:03 INFO - PROCESS | 2001 | RSS: Main: 313737216 10:07:03 INFO - PROCESS | 2001 | 10:10:05 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49394/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49394/tests/dromaeo/cssquery-prototype.html) 10:10:05 INFO - PROCESS | 2001 | RSS: Main: 307277824 10:10:05 INFO - PROCESS | 2001 | 10:13:08 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49394/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49394/tests/dromaeo/cssquery-yui.html) 10:13:09 INFO - PROCESS | 2001 | RSS: Main: 272568320 10:13:09 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49394/tests/dromaeo/cssquery-yui.html (next: http://localhost:49394/tests/dromaeo/cssquery-dojo.html) 10:16:12 INFO - PROCESS | 2001 | RSS: Main: 315879424 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | __start_tp_report 10:16:12 INFO - PROCESS | 2001 | _x_x_mozilla_page_load 10:16:12 INFO - PROCESS | 2001 | _x_x_mozilla_page_load_details 10:16:12 INFO - PROCESS | 2001 | |i|pagename|runs| 10:16:12 INFO - PROCESS | 2001 | |0;dojo.html;3488.5290485784417;3572.6248743881874;3609.404448266036;3617.819109044548;3673.9632603673954;5869.50109240714;5874.530037596993;5885.9993801053815;5913.172155898173;5939.049752039675;5857.970710146454;5893.5579831512705;5910;5911.615744976573;5926.525877929756;5259.395169555502;5270.262163297141;5337.946620533784;5349.277847490578;5389.568834493231;5324.680519168843;5399.352077750676;5408.4591540845795;5410.864728381783;5412.431694672062;5312.57499400049;5362.981033603623;5381.327334083239;5387.380451248097;5413.756380962846;5351.652142610717;5373.811916582901;5379.1662292344745;5388;5410.296661433988;5173.560247378978;5215.608829337815;5306.893862122774;5312.415634280226;5318.069337865897;5718.3709791923275;5739.053056245714;5779.826605201851;5785.450382213683;5812.128180772876;6253.468455181315;6260.217472815898;6308.653024083674;6315.242170939517;6344.714487848058;6220.751169953196;6229.37706229378;6277.497800175975;6301.842453938642;6312.526560507934;6017.458428741435;6021.531052872479;6040.964480165934;6077.301110372276;6086.726097325631;6367.7452901884335;6381.968090159519;6383.425491705769;6387.936120638734;6392.552521323462;6170.56806023583;6262.655553944577;6265.65538895356;6284.811455656338;6319.431251187415;6227.408396202353;6239;6312.084747711556;6324.873502530016;6335.556511044183;6294.118823364733;6305.779297724649;6310.148130002391;6325.652089135142;6334.904976425358;6215.595986260879;6245.28179259391;6289.622622642564;6296.055591661196;6306.211723534559;4982.028504441599;5010.3737032870895;5047.192449208109;5057.064443078042;5080.034793389244;4489.281714925662;4493.820247190076;4509.098180363941;4511.796969136331;4518.051209246095;5982.252218472691;6002.849928751816;6023.0965355196195;6032.638041717511;6045.425684559959;6209.720562574605;6209.720562574695;6254.21822272216;6262.373762623793;6267.874642507216;5994.520438364921;6029.728662210211;6055.2430946131735;6059.213680677582;6103.267607886994;5539.14143307788;5539.335279766373;5539.861503462365;5564.693941833157;5565.9443405566235;6355.3009168991375;6425.807225783234;6499.2200935887995;6500.187476565429;6509.446697030806;6256.186695729526;6260.937390626035;6263.154474145932;6270.7491700331475;6295.370462953668;5283;6431.5819471734185;6448.774292899726;6472.093906852951;6509.283978762427;6183.721732521957;6235.563510554218;6256.968715156395;6339.587926784744;6347.0479428086155;6271.090691849748;6288.874222515616;6289;6290.716917738621;6293.527985401021;6115.480184184395;6123.069106197319;6298.653574053288;6307.211598550181;6312.684365781784;6137.285055221507;6175.197224360804;6215.12988181664;6229.563930525001;6234.781782637586;6150.985087460519;6176.289726681489;6190.226221722285;6206.410391012847;6212.254529456494;6137.131844484677;6197.566170368212;6254.999200127958;6274.780382686584;6299.055141728777;6141.455323060992;6174.783882564088;6191.938080619136;6204.658743769136;6211 10:16:12 INFO - PROCESS | 2001 | |1;ext.html;496.37952559300874;539.1481459294314;542.5117394345092;547.8329109621567;596.7583128832824;31534.211644708892;32077.67922320776;39554.208915821706;40526.18947621046;40617.18765624686;46110;46965.76517117418;47077.29384059242;47079.52920470794;47098.52901470993;9918.504074796267;10099.495025248745;10126.544305506233;10127.848082278771;10137.797244055115;9300.860487092665;11856.940715296412;12148.93925530371;12177.93911030448;12200.511979520808;10293.845592316122;11293.435328233596;11780.998615117725;11887.881121188808;11888.227265227733;11715.531378744883;11759.294442333401;11837.112216583791;11861.64415067545;11866.228695134789;11612.012978896804;11744.882551174464;11762.58830940913;11765.176437649368;11894.226875253167;41089.589104108876;41515;41557.168856623;41628.79185604052;41649.79175104135;3257.853396597135;3424.5548078749603;3647.7628954118163;3668.669819716212;3961.643452089326;28113.859430702716;28995.13014609565;29096;29357.119286421228;29813.40373192524;2770.7783377329765;2789.3305606654258;2827.703091175438;2839.858007099637;2857.928276896164;483727;484208.57895710296;485872;486183;486566;36134.91595252146;36766.264674706894;36802.26395472129;68571;69290.30709692839;35782.64217357845;35857.8207108968;35958.280834383164;36003.63996360055;36068;15785.763213551805;16105.953113047615;16247.431339903047;16261.593460163354;16278.674426511403;12957.740845183233;12985;13003.609891703263;13821.170729756246;13854.93072534651;7819.335356494648;8469.3647976402;8648.870266946002;8669.263112635497;8692.652293908299;3411.4371128763974;3481.175220815221;3483.4426491761706;3493.4410494321296;3519.9120021999656;1079.4279032112993;1103.2167161315556;1148.1159507179425;1179.339569840892;1212.5452955141823;30259.546106808415;30405.39189216203;30486.237844054078;30869.84565077205;30956.535651964787;1089.8910108989037;1101.7080473674482;1130.63819577736;1157.2246594781516;1185.4783895086134;13040.608781736562;15596.610084747972;15771.29029193689;15935.12356820386;15951.920240398957;596131;957885;969066;970742.1462892641;971548;65369;65781.6710916452;66613.33386666072;66697.66651166714;66726.99999999903;1418.1916307704716;1432.4628264400849;1559.3996311419958;1564.9061056336657;1567.5219058187363;31129.53305700371;33443.83278083594;33501.66498335083;34637.13407164841;35193;62196.44508887133;63190;63326.36673633389;63375;63522.047169291574;578576;592288;594078;594630;594992;45071;46129.538704613864;47816.80457988578;47834.04331913412;47924.7603761979;49066.50933490619;49646.75883102951;50817.491825082754;51104.74447627738;51638.74180629073;39740.80129599333;40430.79784601058;40497.59502405056;41768;42216;30356.544651829798;38595.614043860325;39587.604123958394;40251.59748402479;40594.9851253721;39687;39829.80085099556;40909.79545102255;41268;42265;31844.363112737152;32930.34139317248;33387.16532086717;33506;33532.83233583817;21521.89239053795;22226.888865556215;25113.623295650945;26196.73803261943;26283.868580656974 10:16:12 INFO - PROCESS | 2001 | |2;jquery.html;330.9884154054608;407.9959200407995;409.64770297544106;413.3015204304725;423.2022637328636;19845.603087938267;20093.397198084043;20704.068316925735;20726.170953161873;20876.47808804777;21147.894260528716;21566.784332156672;22019.009144588494;22506.66240006401;22547;5787.82636520904;5881.470667639912;6019.819405417845;6058.1518587397795;6058.697065146747;5936.821895343125;6019.3980601939675;6037.486813620848;6046.758129674808;6046.939530604682;4574.542545745432;5688.2605261315975;5978;5986.640801551921;6200.069989501589;5890.116482527612;5916.940830591703;5942.613730107572;5958.612690175125;5965.88068238635;5119.129747942859;5171.896562068738;5244.370675518962;5253.133233016548;5288.65623734456;27135.86432067847;27238.86380568104;27516.312092197655;27803.721962780317;27898.860505697543;2223.3663405929397;2397.724261709908;2468.1114798672465;2629.7501737334924;2646.364872430622;14640.926795365955;15710.293036813371;15863.841361586467;16039.599010024725;16161.757573636405;1730.8528775054135;1837.6967800312932;1839.1815642039298;1879.2576932111876;1935.3129638978241;102357.46463803049;112773;113577.2126225767;113856.99999999917;115606;9505.993624758661;11328.376939268419;11562.76874462506;11696.590619328454;11799.17405781587;14927.925360373345;14948;14985.850141498664;14992.400303987719;15022.399104035716;6905.343992320722;9080.273578113734;9131.315151363542;9135.497547634945;9216.907830921738;9169.679061232824;9228.723138305862;9244.071269710346;9342.019087995799;9345.813083738287;4729.43246810385;4816.4220293564995;4827.903441931142;4859.854204373874;4872.19608764557;1983.1061336423681;2012.6578481658153;2015.8084981926693;2031.4819720971059;2049.815516603513;850.0691742541907;929.0755698080453;991.9156871665989;1030.7938412317567;1111.944402779874;20905.686414703792;21513.569728605653;21601.243956461447;21813.345599632037;21843.672344914838;956.8516879883629;1032.6643840751635;1077.5258886090096;1083.4853444613902;1088.586337191862;10405.47972601367;11367.976882080653;11429.942850285695;11480.138989575815;11490.080793536497;639555.6044439496;645335;657377;663676;667301;122137;124921;127040.36479817727;127900;137604;1028.0336483705294;1061.5170097605571;1072.84443755655;1076.2842709598185;1078.4823284823328;18514.243455405645;18865.90567047156;19096.61806763829;19115.139818707914;19451.3192038278;33930.982070537924;37287.81356093202;53258.4674153269;53711.19433208427;54991.900161997335;63077.053844193295;76209.47581048237;78735.60632196802;79818;81772.59113704393;8208.46644968075;8333.583320834055;8436.746897593082;8771.824563508566;8879.467231965844;11960.521579137085;13105.475780968654;13252.801207981694;13502.932485337511;13511.594652160451;11171;11517.25137866036;11558.537658493566;11582.015528680156;11669.533218671497;11305.71735706581;11401.372924489233;11425.31448113116;11576.24754390962;11669.241499302518;11691.883081169079;11770.88229117732;11972.940135299268;12021.939890300493;12086.879131208576;8512.574371281535;8524.445911015764;8559.486430814171;8649.61076751535;8671.869921951302;11326.980571748581;11669.241499302518;11877.940610297239;11884.286942783461;11950.848847207586 10:16:12 INFO - PROCESS | 2001 | |3;mootools.html;1479.3490864019836;1609.9758503622447;1631.5431679129845;1906.104131058403;2022.4842665120384;8475.83048339033;9097.499637519933;9225.630974761001;9237.353385263026;9237.76905577361;8914.242289405393;9207.309451791109;9212.769680757985;9224.262059035278;9224.584893679783;2547.9935425506915;2569.3062873024273;2580.6129080637866;2581.7805486533666;2587.8317909335833;2512.057978258153;2562.4362640219124;2566.140342985102;2567.7303883092286;2572.3954870605394;2275.397019789749;2518.3829961659326;2531.4430825218424;2568.2166939083572;2574.4078861861785;2428.2229686500327;2510.924672259826;2541.5552278351215;2545.058328418497;2564.1153801938303;2515.2831443038644;2555.7060937992183;2561.065211197918;2563.192594332798;2565.8588777617224;9014.684486043023;9279.44323340595;9341.252699784001;9343.159115679553;9361.391509551926;5649.830505084854;5745.626534275259;5747.482726554588;5797.623154494944;5833.066709326487;3654.14127679995;3693.8707145250055;3758.1585023338366;3766;3788.90527736806;1054.4569546683465;1056.7199692081604;1063.5320458998017;1078.417654466587;1088.4231357380602;12493.625191244186;12575.496980120784;12718.682032949251;12738.426770795337;12741.235525868478;4774.594159496412;4826.372571565744;4830.2513110467935;4844.249141383021;4905.1416002200185;9782.217422606174;9790.020997900154;9790.951045244728;9805.166560842266;9809.901900980898;5620.690862002629;5629.352624448241;5631.605787594829;5632.436756324417;5643.689597072118;4622.514635963243;4700.506446823103;5070.29015937769;5104.719240441811;5232.450592687789;3610.2959922815326;3868.0909986153233;3987.2057574091773;4111.9177616447505;4113;1187.8752730963297;1192.7375977285158;1197.0423661071109;1201.4713526048686;1242.9192102513307;951.9333646644807;988.268681175939;991.7782873172752;992.6724181020246;998.825205589019;6026.758929642765;6068.544859135583;6168.383161683885;6212.782552610637;6285.717142728588;413.7372768292156;420.15968063872253;422.2863360920035;423.91945530349136;431.25608325638024;3939.2318497893207;3962.445257663929;4043.2317859606583;4121.690873184463;4127;9494.098060684224;11115.388653623966;11585.015273701829;11650.951414372747;11655.825162622568;11219.60731374398;11273.549058037586;11374.488148033359;11374.658760237206;11459.942700286445;8353.415260931677;8680.739577812676;8707.085755995657;8888.24449921751;8897.866532002025;5968.8806223876145;5992.850178745566;6156.476699480415;6169.876602468015;6253.218347706536;9860.16188623975;10070.093691567794;10078.143357814668;10080.747981300527;10108.848367274644;9800.460974646177;10066.094051535398;10249.846252306072;10251.743706407102;10627.574897004033;7165.390941770008;7381.4094872409005;7616.619169041636;7856.5678887661725;8061;8541.957290213757;8562.229399353839;8621.784455388415;8628.439151455135;8641.870371944551;7454.142773581108;7546.320831125225;7602.695892164252;7665.923340766521;7685.346745526693;6721.630310332978;7044.823879403056;7429.219931907072;7454.701811927463;7573.2048134945035;7116.217216106121;7220.8916866246;7236.565806051653;7263.055802745609;7268.345848873415;4944.678595891256;5001.824936127364;5047.671901326402;5088.033273677989;5135.768890400016;5062.797488100435;5102.515261050195;5122.564582010571;5209.661372010807;5390.595705322195 10:16:12 INFO - PROCESS | 2001 | |4;prototype.html;324.5829109594172;328.7370103916867;339.9953138475804;340.8585437043627;344.7569463528213;6340.334264902188;6404.23149222094;6564.8030559083245;6631.739969405816;6674.365935236157;6373.872522549546;6581.045748366496;6600.636964966925;6602.207735071786;6643.169603799525;4932.654714170009;4963.106640804654;4966.106100901836;4971.403431588205;4990.850274491771;4708.764561771898;4959.851204463854;4964.652474326798;4968.30443737877;4974.228994505839;4704.411948506437;4872.512748725135;4872.951270487303;4890.853274401774;4900.460949295574;4849.836039350531;4864.057245366537;4864.635152363587;4885.682430642015;4892.608591312686;4143.7928103595;4150.667946564267;4158.792060396968;4160.625543701081;4179.498460184767;6257.092721555349;6263.185785847856;6288.9056664150075;6302;6309.3690630937;4550.317452382136;5672.34768001681;5689.288838895138;5696.601237913348;5700.600957932947;6724.562903411263;6970.79087627372;6991.510594258404;7000.194977577593;7002.964985175042;4685.929711054337;4730.266808644666;4730.32073613869;4736.52634736527;4740.170470167742;7376.483646144772;7388.113426388868;7392.7042918283205;7396.741114061036;7397.297256760599;4127.649149822299;4603.930941035887;4774.809007639725;4780.282957556325;4805.423349198119;4853.95146048535;4857.198562237262;4859.319695242669;4869.220924652039;4870;5532.695701736363;5745.798897038583;5772.538196944234;5778.248827652378;5794.88410231793;6107.267127944675;6940.305969403019;6998.090248267693;7048.365647091684;7057.576545407292;1504.8946573739952;1573.9921300393426;1604.903705777657;1645.407653244831;1704.5397742609673;1090.9727256818485;1104.0670633314837;1114.1866437500507;1122.421952694363;1127.1602656021153;6500.739970401226;6506.316836732075;6523.64119973406;6528.673566321665;6534.281229064799;7164.462665300123;7181.748638797617;7185.89221161683;7209.2069872314005;7216.170140433812;6500.609963402211;6506.60960342381;6511.804645860631;6517.674116294261;6519.022146678036;3765.9058523537133;3818.503594532693;3824.521934758155;3825.4261860721112;3832.405977073558;7266.600336981517;7530.736424225126;7538.434617403607;7548.433867459962;7554.43341749371;7345.522541034816;7394.149672787698;7404.37062849653;7409.036825212688;7441.1070671519765;7427.257274272638;7526.661300241502;7543.245675432523;7553.131389890233;7561.281678240668;6928.099347084847;7175.354218120394;7190.1731300901065;7191.460640452092;7200.099987501562;5757.510611598061;7081.902305142711;7086.822829429306;7125.608091554807;7135.964320178366;7490.02629658141;7549.849003019799;7560.508566943131;7562.7353042645445;7570.129435115033;4828;4830.734309612864;4836.782344794422;4842.7336496493035;4843.975780121077;5904.3210030845285;7196.460265480006;7198.388137008413;7207;7211.098612673416;6614.603123812587;6694.564853284521;7157.856842863218;7165.426765858614;7167.677454514664;6308.621482711052;6557;7069.293070692889;7125;7141.464390170654;6973.546719463218;6999.965000175171;7001.264867188872;7011.404030657247;7018.508704390643;6924.272951340238;7118.60847653384;7118.683043636944;7126.394256488256;7143.178534468395;5742.253507044057;6904.102466679299;6993.475489338218;6997.335253150943;7013.473989450709 10:16:12 INFO - PROCESS | 2001 | |5;yui.html;717.8133685241837;729.7081167532988;768.1703759939267;778.926002029807;808.6926967752249;14081.577552673423;14246.643833904158;14298.356573954185;14299.28503574821;14317.355718992645;14263.572092837205;14419.63950901228;14422.783658245135;14439.061461005054;14466;767.251929368865;790.9129995700468;912.7991841794794;967.4533888353093;968.7965527239253;840.9117042710488;959.5106495687215;960.7454024683465;963.5278713430404;964.1804466203741;1024.6157690865925;1026.5944951744057;1026.794641071785;1028.0387837372043;1029.5933106422997;838.4256784102909;852.995735021324;854.5556310718454;855.0295414704324;1007.3905287301151;769.0195001373238;771.8456308738218;775.5036776463069;775.8370742144157;776.7475570439573;12954.222746635232;15089.54731358061;15305.08169509833;15378.461753838674;15419.460318888785;12692.428840702098;12778.616641500677;12945.093843430963;12987.76616221467;13102;10115.443650599214;10300.175985921109;10310.587576496931;10448.634297799617;10733.570657173703;3490.2147016921244;3584.6415358463946;3586.4799604057266;3592.7844329340323;3663.8717644882568;84274.73587896186;86309;86373.56813215956;86540.56729716311;86577.70133448004;9435.386699864486;9748.805023899482;9968.950155249177;10163.847542286872;10414.791704165875;21890.45273868166;22048.779512204994;22132.66800997986;22174.334769956928;22254.666180007313;7696.037995250594;7801.258880406353;7835.843283134305;8043.919560804434;8067.3142782864115;4174.039970806732;4241.448611680462;4244.8514301999285;4275.29457639486;4319.805608747614;3809.7523660961947;3876.302265592164;3877.0307423144213;3877.8061096945603;3880.5149356330458;701.2216439751871;708.9153594999659;709.7622296530617;714.7812978871012;733.2008111158863;605.5942518512608;607.4472230270433;610.6305685060563;615.6983078291695;621.1025068775576;7939.404544659058;8005.839883202303;8195.95902020486;8314.875276870851;8394.79013024667;609.4758507683389;615.6952308607179;633.8383712153371;634.514596333805;637.4263163153199;3817.7136714746507;3853.499045124172;3878.2631300053463;3960.405939109157;4022.5374081980362;94296.52851735834;94800.52599736956;96993.51503242439;97053;97744.51127744457;68445.3155468449;74142;80060;80924.59537702274;81787.18212817915;71045.28954710386;71311.2868871315;72057;72322.63838680668;72435;8282.958585207036;8347.12355202695;8378.455400398954;8638.352123590881;8765.167309105625;36391.818040909624;48528.92233564259;48752.537423877344;49458.505414945386;49794;61994;66421.33578664345;66897.66551167212;68855.65572172106;68916.62166756736;11305.938251724736;11431.771364572496;11579.768404632028;11658.358790266617;11769.35268560203;12006.519739210335;12272.81590776157;12284.877151228373;12430.937845310715;12559.058070644922;11839.881601183877;11893.989010933821;11903.345316007702;11923.76152476963;11926.105542084551;11576.47905844256;11833.467493962964;11946.820797688215;12285.631431057083;12551.995840332935;11342.319460832046;11386.658400248005;11566.42167891619;11667.066634669036;12394.81407778902;9742.9025709742;9923.950380248052;10092.949535252277;10104.84842727345;10202.438865862448;9766.706998790047;10021.148202402586;10080.69757907264;10083.495825208563;10114.039166279192 10:16:12 INFO - PROCESS | 2001 | __end_tp_report 10:16:12 INFO - PROCESS | 2001 | __start_cc_report 10:16:12 INFO - PROCESS | 2001 | _x_x_mozilla_cycle_collect,1244 10:16:12 INFO - PROCESS | 2001 | __end_cc_report 10:16:12 INFO - PROCESS | 2001 | __startTimestamp1467738972422__endTimestamp 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | ------- Summary: start ------- 10:16:12 INFO - PROCESS | 2001 | Number of tests: 6 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | [#0] dojo.html Cycles:165 Average:5877.61 Median:6170.57 stddev:619.07 (10.0%) stddev-sans-first:591.92 10:16:12 INFO - PROCESS | 2001 | Values: 3488.5 3572.6 3609.4 3617.8 3674.0 5869.5 5874.5 5886.0 5913.2 5939.0 5858.0 5893.6 5910.0 5911.6 5926.5 5259.4 5270.3 5337.9 5349.3 5389.6 5324.7 5399.4 5408.5 5410.9 5412.4 5312.6 5363.0 5381.3 5387.4 5413.8 5351.7 5373.8 5379.2 5388.0 5410.3 5173.6 5215.6 5306.9 5312.4 5318.1 5718.4 5739.1 5779.8 5785.5 5812.1 6253.5 6260.2 6308.7 6315.2 6344.7 6220.8 6229.4 6277.5 6301.8 6312.5 6017.5 6021.5 6041.0 6077.3 6086.7 6367.7 6382.0 6383.4 6387.9 6392.6 6170.6 6262.7 6265.7 6284.8 6319.4 6227.4 6239.0 6312.1 6324.9 6335.6 6294.1 6305.8 6310.1 6325.7 6334.9 6215.6 6245.3 6289.6 6296.1 6306.2 4982.0 5010.4 5047.2 5057.1 5080.0 4489.3 4493.8 4509.1 4511.8 4518.1 5982.3 6002.8 6023.1 6032.6 6045.4 6209.7 6209.7 6254.2 6262.4 6267.9 5994.5 6029.7 6055.2 6059.2 6103.3 5539.1 5539.3 5539.9 5564.7 5565.9 6355.3 6425.8 6499.2 6500.2 6509.4 6256.2 6260.9 6263.2 6270.7 6295.4 5283.0 6431.6 6448.8 6472.1 6509.3 6183.7 6235.6 6257.0 6339.6 6347.0 6271.1 6288.9 6289.0 6290.7 6293.5 6115.5 6123.1 6298.7 6307.2 6312.7 6137.3 6175.2 6215.1 6229.6 6234.8 6151.0 6176.3 6190.2 6206.4 6212.3 6137.1 6197.6 6255.0 6274.8 6299.1 6141.5 6174.8 6191.9 6204.7 6211.0 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | [#1] ext.html Cycles:180 Average:77802.79 Median:3506.68 stddev:184580.48 (5263.7%) stddev-sans-first:185007.01 10:16:12 INFO - PROCESS | 2001 | Values: 496.4 539.1 542.5 547.8 596.8 31534.2 32077.7 39554.2 40526.2 40617.2 46110.0 46965.8 47077.3 47079.5 47098.5 9918.5 10099.5 10126.5 10127.8 10137.8 9300.9 11856.9 12148.9 12177.9 12200.5 10293.8 11293.4 11781.0 11887.9 11888.2 11715.5 11759.3 11837.1 11861.6 11866.2 11612.0 11744.9 11762.6 11765.2 11894.2 41089.6 41515.0 41557.2 41628.8 41649.8 3257.9 3424.6 3647.8 3668.7 3961.6 28113.9 28995.1 29096.0 29357.1 29813.4 2770.8 2789.3 2827.7 2839.9 2857.9 483727.0 484208.6 485872.0 486183.0 486566.0 36134.9 36766.3 36802.3 68571.0 69290.3 35782.6 35857.8 35958.3 36003.6 36068.0 15785.8 16106.0 16247.4 16261.6 16278.7 12957.7 12985.0 13003.6 13821.2 13854.9 7819.3 8469.4 8648.9 8669.3 8692.7 3411.4 3481.2 3483.4 3493.4 3519.9 1079.4 1103.2 1148.1 1179.3 1212.5 30259.5 30405.4 30486.2 30869.8 30956.5 1089.9 1101.7 1130.6 1157.2 1185.5 13040.6 15596.6 15771.3 15935.1 15951.9 596131.0 957885.0 969066.0 970742.1 971548.0 65369.0 65781.7 66613.3 66697.7 66727.0 1418.2 1432.5 1559.4 1564.9 1567.5 31129.5 33443.8 33501.7 34637.1 35193.0 62196.4 63190.0 63326.4 63375.0 63522.0 578576.0 592288.0 594078.0 594630.0 594992.0 45071.0 46129.5 47816.8 47834.0 47924.8 49066.5 49646.8 50817.5 51104.7 51638.7 39740.8 40430.8 40497.6 41768.0 42216.0 30356.5 38595.6 39587.6 40251.6 40595.0 39687.0 39829.8 40909.8 41268.0 42265.0 31844.4 32930.3 33387.2 33506.0 33532.8 21521.9 22226.9 25113.6 26196.7 26283.9 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | [#2] jquery.html Cycles:180 Average:36625.79 Median:21828.51 stddev:108540.87 (497.2%) stddev-sans-first:108811.14 10:16:12 INFO - PROCESS | 2001 | Values: 331.0 408.0 409.6 413.3 423.2 19845.6 20093.4 20704.1 20726.2 20876.5 21147.9 21566.8 22019.0 22506.7 22547.0 5787.8 5881.5 6019.8 6058.2 6058.7 5936.8 6019.4 6037.5 6046.8 6046.9 4574.5 5688.3 5978.0 5986.6 6200.1 5890.1 5916.9 5942.6 5958.6 5965.9 5119.1 5171.9 5244.4 5253.1 5288.7 27135.9 27238.9 27516.3 27803.7 27898.9 2223.4 2397.7 2468.1 2629.8 2646.4 14640.9 15710.3 15863.8 16039.6 16161.8 1730.9 1837.7 1839.2 1879.3 1935.3 102357.5 112773.0 113577.2 113857.0 115606.0 9506.0 11328.4 11562.8 11696.6 11799.2 14927.9 14948.0 14985.9 14992.4 15022.4 6905.3 9080.3 9131.3 9135.5 9216.9 9169.7 9228.7 9244.1 9342.0 9345.8 4729.4 4816.4 4827.9 4859.9 4872.2 1983.1 2012.7 2015.8 2031.5 2049.8 850.1 929.1 991.9 1030.8 1111.9 20905.7 21513.6 21601.2 21813.3 21843.7 956.9 1032.7 1077.5 1083.5 1088.6 10405.5 11368.0 11429.9 11480.1 11490.1 639555.6 645335.0 657377.0 663676.0 667301.0 122137.0 124921.0 127040.4 127900.0 137604.0 1028.0 1061.5 1072.8 1076.3 1078.5 18514.2 18865.9 19096.6 19115.1 19451.3 33931.0 37287.8 53258.5 53711.2 54991.9 63077.1 76209.5 78735.6 79818.0 81772.6 8208.5 8333.6 8436.7 8771.8 8879.5 11960.5 13105.5 13252.8 13502.9 13511.6 11171.0 11517.3 11558.5 11582.0 11669.5 11305.7 11401.4 11425.3 11576.2 11669.2 11691.9 11770.9 11972.9 12021.9 12086.9 8512.6 8524.4 8559.5 8649.6 8671.9 11327.0 11669.2 11877.9 11884.3 11950.8 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | [#3] mootools.html Cycles:180 Average:5918.00 Median:5024.75 stddev:3341.65 (66.5%) stddev-sans-first:3334.37 10:16:12 INFO - PROCESS | 2001 | Values: 1479.3 1610.0 1631.5 1906.1 2022.5 8475.8 9097.5 9225.6 9237.4 9237.8 8914.2 9207.3 9212.8 9224.3 9224.6 2548.0 2569.3 2580.6 2581.8 2587.8 2512.1 2562.4 2566.1 2567.7 2572.4 2275.4 2518.4 2531.4 2568.2 2574.4 2428.2 2510.9 2541.6 2545.1 2564.1 2515.3 2555.7 2561.1 2563.2 2565.9 9014.7 9279.4 9341.3 9343.2 9361.4 5649.8 5745.6 5747.5 5797.6 5833.1 3654.1 3693.9 3758.2 3766.0 3788.9 1054.5 1056.7 1063.5 1078.4 1088.4 12493.6 12575.5 12718.7 12738.4 12741.2 4774.6 4826.4 4830.3 4844.2 4905.1 9782.2 9790.0 9791.0 9805.2 9809.9 5620.7 5629.4 5631.6 5632.4 5643.7 4622.5 4700.5 5070.3 5104.7 5232.5 3610.3 3868.1 3987.2 4111.9 4113.0 1187.9 1192.7 1197.0 1201.5 1242.9 951.9 988.3 991.8 992.7 998.8 6026.8 6068.5 6168.4 6212.8 6285.7 413.7 420.2 422.3 423.9 431.3 3939.2 3962.4 4043.2 4121.7 4127.0 9494.1 11115.4 11585.0 11651.0 11655.8 11219.6 11273.5 11374.5 11374.7 11459.9 8353.4 8680.7 8707.1 8888.2 8897.9 5968.9 5992.9 6156.5 6169.9 6253.2 9860.2 10070.1 10078.1 10080.7 10108.8 9800.5 10066.1 10249.8 10251.7 10627.6 7165.4 7381.4 7616.6 7856.6 8061.0 8542.0 8562.2 8621.8 8628.4 8641.9 7454.1 7546.3 7602.7 7665.9 7685.3 6721.6 7044.8 7429.2 7454.7 7573.2 7116.2 7220.9 7236.6 7263.1 7268.3 4944.7 5001.8 5047.7 5088.0 5135.8 5062.8 5102.5 5122.6 5209.7 5390.6 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | [#4] prototype.html Cycles:180 Average:5752.57 Median:6506.46 stddev:1802.93 (27.7%) stddev-sans-first:1761.36 10:16:12 INFO - PROCESS | 2001 | Values: 324.6 328.7 340.0 340.9 344.8 6340.3 6404.2 6564.8 6631.7 6674.4 6373.9 6581.0 6600.6 6602.2 6643.2 4932.7 4963.1 4966.1 4971.4 4990.9 4708.8 4959.9 4964.7 4968.3 4974.2 4704.4 4872.5 4873.0 4890.9 4900.5 4849.8 4864.1 4864.6 4885.7 4892.6 4143.8 4150.7 4158.8 4160.6 4179.5 6257.1 6263.2 6288.9 6302.0 6309.4 4550.3 5672.3 5689.3 5696.6 5700.6 6724.6 6970.8 6991.5 7000.2 7003.0 4685.9 4730.3 4730.3 4736.5 4740.2 7376.5 7388.1 7392.7 7396.7 7397.3 4127.6 4603.9 4774.8 4780.3 4805.4 4854.0 4857.2 4859.3 4869.2 4870.0 5532.7 5745.8 5772.5 5778.2 5794.9 6107.3 6940.3 6998.1 7048.4 7057.6 1504.9 1574.0 1604.9 1645.4 1704.5 1091.0 1104.1 1114.2 1122.4 1127.2 6500.7 6506.3 6523.6 6528.7 6534.3 7164.5 7181.7 7185.9 7209.2 7216.2 6500.6 6506.6 6511.8 6517.7 6519.0 3765.9 3818.5 3824.5 3825.4 3832.4 7266.6 7530.7 7538.4 7548.4 7554.4 7345.5 7394.1 7404.4 7409.0 7441.1 7427.3 7526.7 7543.2 7553.1 7561.3 6928.1 7175.4 7190.2 7191.5 7200.1 5757.5 7081.9 7086.8 7125.6 7136.0 7490.0 7549.8 7560.5 7562.7 7570.1 4828.0 4830.7 4836.8 4842.7 4844.0 5904.3 7196.5 7198.4 7207.0 7211.1 6614.6 6694.6 7157.9 7165.4 7167.7 6308.6 6557.0 7069.3 7125.0 7141.5 6973.5 7000.0 7001.3 7011.4 7018.5 6924.3 7118.6 7118.7 7126.4 7143.2 5742.3 6904.1 6993.5 6997.3 7013.5 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - PROCESS | 2001 | [#5] yui.html Cycles:180 Average:18610.17 Median:26424.36 stddev:26224.07 (99.2%) stddev-sans-first:26263.23 10:16:12 INFO - PROCESS | 2001 | Values: 717.8 729.7 768.2 778.9 808.7 14081.6 14246.6 14298.4 14299.3 14317.4 14263.6 14419.6 14422.8 14439.1 14466.0 767.3 790.9 912.8 967.5 968.8 840.9 959.5 960.7 963.5 964.2 1024.6 1026.6 1026.8 1028.0 1029.6 838.4 853.0 854.6 855.0 1007.4 769.0 771.8 775.5 775.8 776.7 12954.2 15089.5 15305.1 15378.5 15419.5 12692.4 12778.6 12945.1 12987.8 13102.0 10115.4 10300.2 10310.6 10448.6 10733.6 3490.2 3584.6 3586.5 3592.8 3663.9 84274.7 86309.0 86373.6 86540.6 86577.7 9435.4 9748.8 9969.0 10163.8 10414.8 21890.5 22048.8 22132.7 22174.3 22254.7 7696.0 7801.3 7835.8 8043.9 8067.3 4174.0 4241.4 4244.9 4275.3 4319.8 3809.8 3876.3 3877.0 3877.8 3880.5 701.2 708.9 709.8 714.8 733.2 605.6 607.4 610.6 615.7 621.1 7939.4 8005.8 8196.0 8314.9 8394.8 609.5 615.7 633.8 634.5 637.4 3817.7 3853.5 3878.3 3960.4 4022.5 94296.5 94800.5 96993.5 97053.0 97744.5 68445.3 74142.0 80060.0 80924.6 81787.2 71045.3 71311.3 72057.0 72322.6 72435.0 8283.0 8347.1 8378.5 8638.4 8765.2 36391.8 48528.9 48752.5 49458.5 49794.0 61994.0 66421.3 66897.7 68855.7 68916.6 11305.9 11431.8 11579.8 11658.4 11769.4 12006.5 12272.8 12284.9 12430.9 12559.1 11839.9 11894.0 11903.3 11923.8 11926.1 11576.5 11833.5 11946.8 12285.6 12552.0 11342.3 11386.7 11566.4 11667.1 12394.8 9742.9 9924.0 10092.9 10104.8 10202.4 9766.7 10021.1 10080.7 10083.5 10114.0 10:16:12 INFO - PROCESS | 2001 | -------- Summary: end -------- 10:16:12 INFO - PROCESS | 2001 | 10:16:12 INFO - TEST-INFO | 2001: exit 0 10:16:12 INFO - TEST-OK | dromaeo_css | took 1113048ms 10:16:12 INFO - TEST-START | kraken 10:16:12 INFO - operating with platform_type : mac_ 10:16:12 INFO - Initialising browser for kraken test... 10:16:12 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpNHq_8s/profile http://localhost:49394/getInfo.html) 10:16:15 INFO - PROCESS | 2005 | __metrics Screen width/height:1600/1200 10:16:15 INFO - PROCESS | 2005 | colorDepth:24 10:16:15 INFO - PROCESS | 2005 | Browser inner width/height: 1024/689 10:16:15 INFO - PROCESS | 2005 | __metrics 10:16:15 INFO - PROCESS | 2005 | 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" 10:16:15 ERROR - PROCESS | 2005 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:16:15 INFO - TEST-INFO | 2005: exit 0 10:16:15 INFO - Browser initialized. 10:16:15 INFO - Running cycle 1/1 for kraken test... 10:16:15 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpNHq_8s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:27 INFO - PROCESS | 2008 | RSS: Main: 161656832 10:16:27 INFO - PROCESS | 2008 | 10:16:30 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49394/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:31 INFO - PROCESS | 2008 | RSS: Main: 223932416 10:16:31 INFO - PROCESS | 2008 | 10:16:33 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49394/tests/kraken/driver.html?testName=audio-dft) 10:16:34 INFO - PROCESS | 2008 | RSS: Main: 239697920 10:16:34 INFO - PROCESS | 2008 | 10:16:37 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49394/tests/kraken/driver.html?testName=audio-fft) 10:16:38 INFO - PROCESS | 2008 | RSS: Main: 324825088 10:16:38 INFO - PROCESS | 2008 | 10:16:40 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49394/tests/kraken/driver.html?testName=audio-oscillator) 10:16:40 INFO - PROCESS | 2008 | RSS: Main: 231493632 10:16:40 INFO - PROCESS | 2008 | 10:16:43 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49394/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:43 INFO - PROCESS | 2008 | RSS: Main: 232665088 10:16:43 INFO - PROCESS | 2008 | 10:16:46 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49394/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:46 INFO - PROCESS | 2008 | RSS: Main: 269729792 10:16:46 INFO - PROCESS | 2008 | 10:16:49 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49394/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:50 INFO - PROCESS | 2008 | RSS: Main: 269721600 10:16:50 INFO - PROCESS | 2008 | 10:16:53 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49394/tests/kraken/driver.html?testName=json-parse-financial) 10:16:53 INFO - PROCESS | 2008 | RSS: Main: 269537280 10:16:53 INFO - PROCESS | 2008 | 10:16:55 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49394/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:55 INFO - PROCESS | 2008 | RSS: Main: 260542464 10:16:55 INFO - PROCESS | 2008 | 10:16:57 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49394/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:58 INFO - PROCESS | 2008 | RSS: Main: 266964992 10:16:58 INFO - PROCESS | 2008 | 10:17:00 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49394/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:01 INFO - PROCESS | 2008 | RSS: Main: 271003648 10:17:01 INFO - PROCESS | 2008 | 10:17:03 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49394/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:04 INFO - PROCESS | 2008 | RSS: Main: 278171648 10:17:04 INFO - PROCESS | 2008 | 10:17:07 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49394/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:08 INFO - PROCESS | 2008 | RSS: Main: 275312640 10:17:08 INFO - PROCESS | 2008 | 10:17:09 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49394/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49394/tests/kraken/driver.html?testName=ai-astar) 10:17:10 INFO - PROCESS | 2008 | RSS: Main: 336302080 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | __start_tp_report 10:17:10 INFO - PROCESS | 2008 | _x_x_mozilla_page_load 10:17:10 INFO - PROCESS | 2008 | _x_x_mozilla_page_load_details 10:17:10 INFO - PROCESS | 2008 | |i|pagename|runs| 10:17:10 INFO - PROCESS | 2008 | |0;ai-astar;114;113;126;167;154;112;112;110;107;134 10:17:10 INFO - PROCESS | 2008 | |1;audio-beat-detection;162;149;184;162;120;147;168;143;162;115 10:17:10 INFO - PROCESS | 2008 | |2;audio-dft;185;187;185;182;188;185;183;186;185;184 10:17:10 INFO - PROCESS | 2008 | |3;audio-fft;69;79;74;155;56;56;57;65;130;56 10:17:10 INFO - PROCESS | 2008 | |4;audio-oscillator;92;93;140;80;92;88;125;80;77;128 10:17:10 INFO - PROCESS | 2008 | |5;imaging-gaussian-blur;89;87;89;87;89;86;89;86;89;85 10:17:10 INFO - PROCESS | 2008 | |6;imaging-darkroom;93;93;93;94;93;94;94;94;93;93 10:17:10 INFO - PROCESS | 2008 | |7;imaging-desaturate;84;83;87;84;84;85;84;86;87;86 10:17:10 INFO - PROCESS | 2008 | |8;json-parse-financial;60;62;61;61;61;63;63;80;59;56 10:17:10 INFO - PROCESS | 2008 | |9;json-stringify-tinderbox;62;62;69;67;70;73;70;67;67;68 10:17:10 INFO - PROCESS | 2008 | |10;stanford-crypto-aes;80;102;101;102;83;79;80;79;78;84 10:17:10 INFO - PROCESS | 2008 | |11;stanford-crypto-ccm;142;144;146;139;119;132;136;143;131;134 10:17:10 INFO - PROCESS | 2008 | |12;stanford-crypto-pbkdf2;163;163;163;164;164;169;164;168;192;165 10:17:10 INFO - PROCESS | 2008 | |13;stanford-crypto-sha256-iterative;65;69;68;69;68;65;68;66;69;67 10:17:10 INFO - PROCESS | 2008 | __end_tp_report 10:17:10 INFO - PROCESS | 2008 | __start_cc_report 10:17:10 INFO - PROCESS | 2008 | _x_x_mozilla_cycle_collect,1970 10:17:10 INFO - PROCESS | 2008 | __end_cc_report 10:17:10 INFO - PROCESS | 2008 | __startTimestamp1467739030006__endTimestamp 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | ------- Summary: start ------- 10:17:10 INFO - PROCESS | 2008 | Number of tests: 14 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#0] ai-astar Cycles:10 Average:124.90 Median:120.00 stddev:20.65 (17.2%) stddev-sans-first:21.53 10:17:10 INFO - PROCESS | 2008 | Values: 114.0 113.0 126.0 167.0 154.0 112.0 112.0 110.0 107.0 134.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:162.00 stddev:21.30 (13.1%) stddev-sans-first:22.23 10:17:10 INFO - PROCESS | 2008 | Values: 162.0 149.0 184.0 162.0 120.0 147.0 168.0 143.0 162.0 115.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.00 stddev:1.76 (1.0%) stddev-sans-first:1.87 10:17:10 INFO - PROCESS | 2008 | Values: 185.0 187.0 185.0 182.0 188.0 185.0 183.0 186.0 185.0 184.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#3] audio-fft Cycles:10 Average:79.70 Median:61.00 stddev:34.58 (56.7%) stddev-sans-first:36.46 10:17:10 INFO - PROCESS | 2008 | Values: 69.0 79.0 74.0 155.0 56.0 56.0 57.0 65.0 130.0 56.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#4] audio-oscillator Cycles:10 Average:99.50 Median:84.00 stddev:22.75 (27.1%) stddev-sans-first:23.96 10:17:10 INFO - PROCESS | 2008 | Values: 92.0 93.0 140.0 80.0 92.0 88.0 125.0 80.0 77.0 128.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:89.00 stddev:1.58 (1.8%) stddev-sans-first:1.59 10:17:10 INFO - PROCESS | 2008 | Values: 89.0 87.0 89.0 87.0 89.0 86.0 89.0 86.0 89.0 85.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 10:17:10 INFO - PROCESS | 2008 | Values: 93.0 93.0 93.0 94.0 93.0 94.0 94.0 94.0 93.0 93.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.41 (1.7%) stddev-sans-first:1.45 10:17:10 INFO - PROCESS | 2008 | Values: 84.0 83.0 87.0 84.0 84.0 85.0 84.0 86.0 87.0 86.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:61.50 stddev:6.45 (10.5%) stddev-sans-first:6.77 10:17:10 INFO - PROCESS | 2008 | Values: 60.0 62.0 61.0 61.0 61.0 63.0 63.0 80.0 59.0 56.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.50 stddev:3.44 (5.0%) stddev-sans-first:3.02 10:17:10 INFO - PROCESS | 2008 | Values: 62.0 62.0 69.0 67.0 70.0 73.0 70.0 67.0 67.0 68.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:79.50 stddev:10.42 (13.1%) stddev-sans-first:10.76 10:17:10 INFO - PROCESS | 2008 | Values: 80.0 102.0 101.0 102.0 83.0 79.0 80.0 79.0 78.0 84.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:140.50 stddev:8.09 (5.8%) stddev-sans-first:8.34 10:17:10 INFO - PROCESS | 2008 | Values: 142.0 144.0 146.0 139.0 119.0 132.0 136.0 143.0 131.0 134.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:164.50 stddev:8.86 (5.4%) stddev-sans-first:9.25 10:17:10 INFO - PROCESS | 2008 | Values: 163.0 163.0 163.0 164.0 164.0 169.0 164.0 168.0 192.0 165.0 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - PROCESS | 2008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.58 (2.3%) stddev-sans-first:1.41 10:17:10 INFO - PROCESS | 2008 | Values: 65.0 69.0 68.0 69.0 68.0 65.0 68.0 66.0 69.0 67.0 10:17:10 INFO - PROCESS | 2008 | -------- Summary: end -------- 10:17:10 INFO - PROCESS | 2008 | 10:17:10 INFO - TEST-INFO | 2008: exit 0 10:17:10 INFO - TEST-OK | kraken | took 57793ms 10:17:10 INFO - SUITE-END | took 1170s 10:17:11 INFO - Completed test suite (00:19:31) 10:17:11 INFO - javascript benchmark 10:17:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3488.5290485784417, 3572.6248743881874, 3609.404448266036, 3617.819109044548, 3673.9632603673954, 5869.50109240714, 5874.530037596993, 5885.9993801053815, 5913.172155898173, 5939.049752039675, 5857.970710146454, 5893.5579831512705, 5910.0, 5911.615744976573, 5926.525877929756, 5259.395169555502, 5270.262163297141, 5337.946620533784, 5349.277847490578, 5389.568834493231, 5324.680519168843, 5399.352077750676, 5408.4591540845795, 5410.864728381783, 5412.431694672062, 5312.57499400049, 5362.981033603623, 5381.327334083239, 5387.380451248097, 5413.756380962846, 5351.652142610717, 5373.811916582901, 5379.1662292344745, 5388.0, 5410.296661433988, 5173.560247378978, 5215.608829337815, 5306.893862122774, 5312.415634280226, 5318.069337865897, 5718.3709791923275, 5739.053056245714, 5779.826605201851, 5785.450382213683, 5812.128180772876, 6253.468455181315, 6260.217472815898, 6308.653024083674, 6315.242170939517, 6344.714487848058, 6220.751169953196, 6229.37706229378, 6277.497800175975, 6301.842453938642, 6312.526560507934, 6017.458428741435, 6021.531052872479, 6040.964480165934, 6077.301110372276, 6086.726097325631, 6367.7452901884335, 6381.968090159519, 6383.425491705769, 6387.936120638734, 6392.552521323462, 6170.56806023583, 6262.655553944577, 6265.65538895356, 6284.811455656338, 6319.431251187415, 6227.408396202353, 6239.0, 6312.084747711556, 6324.873502530016, 6335.556511044183, 6294.118823364733, 6305.779297724649, 6310.148130002391, 6325.652089135142, 6334.904976425358, 6215.595986260879, 6245.28179259391, 6289.622622642564, 6296.055591661196, 6306.211723534559, 4982.028504441599, 5010.3737032870895, 5047.192449208109, 5057.064443078042, 5080.034793389244, 4489.281714925662, 4493.820247190076, 4509.098180363941, 4511.796969136331, 4518.051209246095, 5982.252218472691, 6002.849928751816, 6023.0965355196195, 6032.638041717511, 6045.425684559959, 6209.720562574605, 6209.720562574695, 6254.21822272216, 6262.373762623793, 6267.874642507216, 5994.520438364921, 6029.728662210211, 6055.2430946131735, 6059.213680677582, 6103.267607886994, 5539.14143307788, 5539.335279766373, 5539.861503462365, 5564.693941833157, 5565.9443405566235, 6355.3009168991375, 6425.807225783234, 6499.2200935887995, 6500.187476565429, 6509.446697030806, 6256.186695729526, 6260.937390626035, 6263.154474145932, 6270.7491700331475, 6295.370462953668, 5283.0, 6431.5819471734185, 6448.774292899726, 6472.093906852951, 6509.283978762427, 6183.721732521957, 6235.563510554218, 6256.968715156395, 6339.587926784744, 6347.0479428086155, 6271.090691849748, 6288.874222515616, 6289.0, 6290.716917738621, 6293.527985401021, 6115.480184184395, 6123.069106197319, 6298.653574053288, 6307.211598550181, 6312.684365781784, 6137.285055221507, 6175.197224360804, 6215.12988181664, 6229.563930525001, 6234.781782637586, 6150.985087460519, 6176.289726681489, 6190.226221722285, 6206.410391012847, 6212.254529456494, 6137.131844484677, 6197.566170368212, 6254.999200127958, 6274.780382686584, 6299.055141728777, 6141.455323060992, 6174.783882564088, 6191.938080619136, 6204.658743769136, 6211.0], "value": 5840.02847811224, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.37952559300874, 539.1481459294314, 542.5117394345092, 547.8329109621567, 596.7583128832824, 31534.211644708892, 32077.67922320776, 39554.208915821706, 40526.18947621046, 40617.18765624686, 46110.0, 46965.76517117418, 47077.29384059242, 47079.52920470794, 47098.52901470993, 9918.504074796267, 10099.495025248745, 10126.544305506233, 10127.848082278771, 10137.797244055115, 9300.860487092665, 11856.940715296412, 12148.93925530371, 12177.93911030448, 12200.511979520808, 10293.845592316122, 11293.435328233596, 11780.998615117725, 11887.881121188808, 11888.227265227733, 11715.531378744883, 11759.294442333401, 11837.112216583791, 11861.64415067545, 11866.228695134789, 11612.012978896804, 11744.882551174464, 11762.58830940913, 11765.176437649368, 11894.226875253167, 41089.589104108876, 41515.0, 41557.168856623, 41628.79185604052, 41649.79175104135, 3257.853396597135, 3424.5548078749603, 3647.7628954118163, 3668.669819716212, 3961.643452089326, 28113.859430702716, 28995.13014609565, 29096.0, 29357.119286421228, 29813.40373192524, 2770.7783377329765, 2789.3305606654258, 2827.703091175438, 2839.858007099637, 2857.928276896164, 483727.0, 484208.57895710296, 485872.0, 486183.0, 486566.0, 36134.91595252146, 36766.264674706894, 36802.26395472129, 68571.0, 69290.30709692839, 35782.64217357845, 35857.8207108968, 35958.280834383164, 36003.63996360055, 36068.0, 15785.763213551805, 16105.953113047615, 16247.431339903047, 16261.593460163354, 16278.674426511403, 12957.740845183233, 12985.0, 13003.609891703263, 13821.170729756246, 13854.93072534651, 7819.335356494648, 8469.3647976402, 8648.870266946002, 8669.263112635497, 8692.652293908299, 3411.4371128763974, 3481.175220815221, 3483.4426491761706, 3493.4410494321296, 3519.9120021999656, 1079.4279032112993, 1103.2167161315556, 1148.1159507179425, 1179.339569840892, 1212.5452955141823, 30259.546106808415, 30405.39189216203, 30486.237844054078, 30869.84565077205, 30956.535651964787, 1089.8910108989037, 1101.7080473674482, 1130.63819577736, 1157.2246594781516, 1185.4783895086134, 13040.608781736562, 15596.610084747972, 15771.29029193689, 15935.12356820386, 15951.920240398957, 596131.0, 957885.0, 969066.0, 970742.1462892641, 971548.0, 65369.0, 65781.6710916452, 66613.33386666072, 66697.66651166714, 66726.99999999903, 1418.1916307704716, 1432.4628264400849, 1559.3996311419958, 1564.9061056336657, 1567.5219058187363, 31129.53305700371, 33443.83278083594, 33501.66498335083, 34637.13407164841, 35193.0, 62196.44508887133, 63190.0, 63326.36673633389, 63375.0, 63522.047169291574, 578576.0, 592288.0, 594078.0, 594630.0, 594992.0, 45071.0, 46129.538704613864, 47816.80457988578, 47834.04331913412, 47924.7603761979, 49066.50933490619, 49646.75883102951, 50817.491825082754, 51104.74447627738, 51638.74180629073, 39740.80129599333, 40430.79784601058, 40497.59502405056, 41768.0, 42216.0, 30356.544651829798, 38595.614043860325, 39587.604123958394, 40251.59748402479, 40594.9851253721, 39687.0, 39829.80085099556, 40909.79545102255, 41268.0, 42265.0, 31844.363112737152, 32930.34139317248, 33387.16532086717, 33506.0, 33532.83233583817, 21521.89239053795, 22226.888865556215, 25113.623295650945, 26196.73803261943, 26283.868580656974], "value": 20177.907376404066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.9884154054608, 407.9959200407995, 409.64770297544106, 413.3015204304725, 423.2022637328636, 19845.603087938267, 20093.397198084043, 20704.068316925735, 20726.170953161873, 20876.47808804777, 21147.894260528716, 21566.784332156672, 22019.009144588494, 22506.66240006401, 22547.0, 5787.82636520904, 5881.470667639912, 6019.819405417845, 6058.1518587397795, 6058.697065146747, 5936.821895343125, 6019.3980601939675, 6037.486813620848, 6046.758129674808, 6046.939530604682, 4574.542545745432, 5688.2605261315975, 5978.0, 5986.640801551921, 6200.069989501589, 5890.116482527612, 5916.940830591703, 5942.613730107572, 5958.612690175125, 5965.88068238635, 5119.129747942859, 5171.896562068738, 5244.370675518962, 5253.133233016548, 5288.65623734456, 27135.86432067847, 27238.86380568104, 27516.312092197655, 27803.721962780317, 27898.860505697543, 2223.3663405929397, 2397.724261709908, 2468.1114798672465, 2629.7501737334924, 2646.364872430622, 14640.926795365955, 15710.293036813371, 15863.841361586467, 16039.599010024725, 16161.757573636405, 1730.8528775054135, 1837.6967800312932, 1839.1815642039298, 1879.2576932111876, 1935.3129638978241, 102357.46463803049, 112773.0, 113577.2126225767, 113856.99999999917, 115606.0, 9505.993624758661, 11328.376939268419, 11562.76874462506, 11696.590619328454, 11799.17405781587, 14927.925360373345, 14948.0, 14985.850141498664, 14992.400303987719, 15022.399104035716, 6905.343992320722, 9080.273578113734, 9131.315151363542, 9135.497547634945, 9216.907830921738, 9169.679061232824, 9228.723138305862, 9244.071269710346, 9342.019087995799, 9345.813083738287, 4729.43246810385, 4816.4220293564995, 4827.903441931142, 4859.854204373874, 4872.19608764557, 1983.1061336423681, 2012.6578481658153, 2015.8084981926693, 2031.4819720971059, 2049.815516603513, 850.0691742541907, 929.0755698080453, 991.9156871665989, 1030.7938412317567, 1111.944402779874, 20905.686414703792, 21513.569728605653, 21601.243956461447, 21813.345599632037, 21843.672344914838, 956.8516879883629, 1032.6643840751635, 1077.5258886090096, 1083.4853444613902, 1088.586337191862, 10405.47972601367, 11367.976882080653, 11429.942850285695, 11480.138989575815, 11490.080793536497, 639555.6044439496, 645335.0, 657377.0, 663676.0, 667301.0, 122137.0, 124921.0, 127040.36479817727, 127900.0, 137604.0, 1028.0336483705294, 1061.5170097605571, 1072.84443755655, 1076.2842709598185, 1078.4823284823328, 18514.243455405645, 18865.90567047156, 19096.61806763829, 19115.139818707914, 19451.3192038278, 33930.982070537924, 37287.81356093202, 53258.4674153269, 53711.19433208427, 54991.900161997335, 63077.053844193295, 76209.47581048237, 78735.60632196802, 79818.0, 81772.59113704393, 8208.46644968075, 8333.583320834055, 8436.746897593082, 8771.824563508566, 8879.467231965844, 11960.521579137085, 13105.475780968654, 13252.801207981694, 13502.932485337511, 13511.594652160451, 11171.0, 11517.25137866036, 11558.537658493566, 11582.015528680156, 11669.533218671497, 11305.71735706581, 11401.372924489233, 11425.31448113116, 11576.24754390962, 11669.241499302518, 11691.883081169079, 11770.88229117732, 11972.940135299268, 12021.939890300493, 12086.879131208576, 8512.574371281535, 8524.445911015764, 8559.486430814171, 8649.61076751535, 8671.869921951302, 11326.980571748581, 11669.241499302518, 11877.940610297239, 11884.286942783461, 11950.848847207586], "value": 9958.288814567733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.3490864019836, 1609.9758503622447, 1631.5431679129845, 1906.104131058403, 2022.4842665120384, 8475.83048339033, 9097.499637519933, 9225.630974761001, 9237.353385263026, 9237.76905577361, 8914.242289405393, 9207.309451791109, 9212.769680757985, 9224.262059035278, 9224.584893679783, 2547.9935425506915, 2569.3062873024273, 2580.6129080637866, 2581.7805486533666, 2587.8317909335833, 2512.057978258153, 2562.4362640219124, 2566.140342985102, 2567.7303883092286, 2572.3954870605394, 2275.397019789749, 2518.3829961659326, 2531.4430825218424, 2568.2166939083572, 2574.4078861861785, 2428.2229686500327, 2510.924672259826, 2541.5552278351215, 2545.058328418497, 2564.1153801938303, 2515.2831443038644, 2555.7060937992183, 2561.065211197918, 2563.192594332798, 2565.8588777617224, 9014.684486043023, 9279.44323340595, 9341.252699784001, 9343.159115679553, 9361.391509551926, 5649.830505084854, 5745.626534275259, 5747.482726554588, 5797.623154494944, 5833.066709326487, 3654.14127679995, 3693.8707145250055, 3758.1585023338366, 3766.0, 3788.90527736806, 1054.4569546683465, 1056.7199692081604, 1063.5320458998017, 1078.417654466587, 1088.4231357380602, 12493.625191244186, 12575.496980120784, 12718.682032949251, 12738.426770795337, 12741.235525868478, 4774.594159496412, 4826.372571565744, 4830.2513110467935, 4844.249141383021, 4905.1416002200185, 9782.217422606174, 9790.020997900154, 9790.951045244728, 9805.166560842266, 9809.901900980898, 5620.690862002629, 5629.352624448241, 5631.605787594829, 5632.436756324417, 5643.689597072118, 4622.514635963243, 4700.506446823103, 5070.29015937769, 5104.719240441811, 5232.450592687789, 3610.2959922815326, 3868.0909986153233, 3987.2057574091773, 4111.9177616447505, 4113.0, 1187.8752730963297, 1192.7375977285158, 1197.0423661071109, 1201.4713526048686, 1242.9192102513307, 951.9333646644807, 988.268681175939, 991.7782873172752, 992.6724181020246, 998.825205589019, 6026.758929642765, 6068.544859135583, 6168.383161683885, 6212.782552610637, 6285.717142728588, 413.7372768292156, 420.15968063872253, 422.2863360920035, 423.91945530349136, 431.25608325638024, 3939.2318497893207, 3962.445257663929, 4043.2317859606583, 4121.690873184463, 4127.0, 9494.098060684224, 11115.388653623966, 11585.015273701829, 11650.951414372747, 11655.825162622568, 11219.60731374398, 11273.549058037586, 11374.488148033359, 11374.658760237206, 11459.942700286445, 8353.415260931677, 8680.739577812676, 8707.085755995657, 8888.24449921751, 8897.866532002025, 5968.8806223876145, 5992.850178745566, 6156.476699480415, 6169.876602468015, 6253.218347706536, 9860.16188623975, 10070.093691567794, 10078.143357814668, 10080.747981300527, 10108.848367274644, 9800.460974646177, 10066.094051535398, 10249.846252306072, 10251.743706407102, 10627.574897004033, 7165.390941770008, 7381.4094872409005, 7616.619169041636, 7856.5678887661725, 8061.0, 8541.957290213757, 8562.229399353839, 8621.784455388415, 8628.439151455135, 8641.870371944551, 7454.142773581108, 7546.320831125225, 7602.695892164252, 7665.923340766521, 7685.346745526693, 6721.630310332978, 7044.823879403056, 7429.219931907072, 7454.701811927463, 7573.2048134945035, 7116.217216106121, 7220.8916866246, 7236.565806051653, 7263.055802745609, 7268.345848873415, 4944.678595891256, 5001.824936127364, 5047.671901326402, 5088.033273677989, 5135.768890400016, 5062.797488100435, 5102.515261050195, 5122.564582010571, 5209.661372010807, 5390.595705322195], "value": 4668.298914024751, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.5829109594172, 328.7370103916867, 339.9953138475804, 340.8585437043627, 344.7569463528213, 6340.334264902188, 6404.23149222094, 6564.8030559083245, 6631.739969405816, 6674.365935236157, 6373.872522549546, 6581.045748366496, 6600.636964966925, 6602.207735071786, 6643.169603799525, 4932.654714170009, 4963.106640804654, 4966.106100901836, 4971.403431588205, 4990.850274491771, 4708.764561771898, 4959.851204463854, 4964.652474326798, 4968.30443737877, 4974.228994505839, 4704.411948506437, 4872.512748725135, 4872.951270487303, 4890.853274401774, 4900.460949295574, 4849.836039350531, 4864.057245366537, 4864.635152363587, 4885.682430642015, 4892.608591312686, 4143.7928103595, 4150.667946564267, 4158.792060396968, 4160.625543701081, 4179.498460184767, 6257.092721555349, 6263.185785847856, 6288.9056664150075, 6302.0, 6309.3690630937, 4550.317452382136, 5672.34768001681, 5689.288838895138, 5696.601237913348, 5700.600957932947, 6724.562903411263, 6970.79087627372, 6991.510594258404, 7000.194977577593, 7002.964985175042, 4685.929711054337, 4730.266808644666, 4730.32073613869, 4736.52634736527, 4740.170470167742, 7376.483646144772, 7388.113426388868, 7392.7042918283205, 7396.741114061036, 7397.297256760599, 4127.649149822299, 4603.930941035887, 4774.809007639725, 4780.282957556325, 4805.423349198119, 4853.95146048535, 4857.198562237262, 4859.319695242669, 4869.220924652039, 4870.0, 5532.695701736363, 5745.798897038583, 5772.538196944234, 5778.248827652378, 5794.88410231793, 6107.267127944675, 6940.305969403019, 6998.090248267693, 7048.365647091684, 7057.576545407292, 1504.8946573739952, 1573.9921300393426, 1604.903705777657, 1645.407653244831, 1704.5397742609673, 1090.9727256818485, 1104.0670633314837, 1114.1866437500507, 1122.421952694363, 1127.1602656021153, 6500.739970401226, 6506.316836732075, 6523.64119973406, 6528.673566321665, 6534.281229064799, 7164.462665300123, 7181.748638797617, 7185.89221161683, 7209.2069872314005, 7216.170140433812, 6500.609963402211, 6506.60960342381, 6511.804645860631, 6517.674116294261, 6519.022146678036, 3765.9058523537133, 3818.503594532693, 3824.521934758155, 3825.4261860721112, 3832.405977073558, 7266.600336981517, 7530.736424225126, 7538.434617403607, 7548.433867459962, 7554.43341749371, 7345.522541034816, 7394.149672787698, 7404.37062849653, 7409.036825212688, 7441.1070671519765, 7427.257274272638, 7526.661300241502, 7543.245675432523, 7553.131389890233, 7561.281678240668, 6928.099347084847, 7175.354218120394, 7190.1731300901065, 7191.460640452092, 7200.099987501562, 5757.510611598061, 7081.902305142711, 7086.822829429306, 7125.608091554807, 7135.964320178366, 7490.02629658141, 7549.849003019799, 7560.508566943131, 7562.7353042645445, 7570.129435115033, 4828.0, 4830.734309612864, 4836.782344794422, 4842.7336496493035, 4843.975780121077, 5904.3210030845285, 7196.460265480006, 7198.388137008413, 7207.0, 7211.098612673416, 6614.603123812587, 6694.564853284521, 7157.856842863218, 7165.426765858614, 7167.677454514664, 6308.621482711052, 6557.0, 7069.293070692889, 7125.0, 7141.464390170654, 6973.546719463218, 6999.965000175171, 7001.264867188872, 7011.404030657247, 7018.508704390643, 6924.272951340238, 7118.60847653384, 7118.683043636944, 7126.394256488256, 7143.178534468395, 5742.253507044057, 6904.102466679299, 6993.475489338218, 6997.335253150943, 7013.473989450709], "value": 5152.637789353789, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.8133685241837, 729.7081167532988, 768.1703759939267, 778.926002029807, 808.6926967752249, 14081.577552673423, 14246.643833904158, 14298.356573954185, 14299.28503574821, 14317.355718992645, 14263.572092837205, 14419.63950901228, 14422.783658245135, 14439.061461005054, 14466.0, 767.251929368865, 790.9129995700468, 912.7991841794794, 967.4533888353093, 968.7965527239253, 840.9117042710488, 959.5106495687215, 960.7454024683465, 963.5278713430404, 964.1804466203741, 1024.6157690865925, 1026.5944951744057, 1026.794641071785, 1028.0387837372043, 1029.5933106422997, 838.4256784102909, 852.995735021324, 854.5556310718454, 855.0295414704324, 1007.3905287301151, 769.0195001373238, 771.8456308738218, 775.5036776463069, 775.8370742144157, 776.7475570439573, 12954.222746635232, 15089.54731358061, 15305.08169509833, 15378.461753838674, 15419.460318888785, 12692.428840702098, 12778.616641500677, 12945.093843430963, 12987.76616221467, 13102.0, 10115.443650599214, 10300.175985921109, 10310.587576496931, 10448.634297799617, 10733.570657173703, 3490.2147016921244, 3584.6415358463946, 3586.4799604057266, 3592.7844329340323, 3663.8717644882568, 84274.73587896186, 86309.0, 86373.56813215956, 86540.56729716311, 86577.70133448004, 9435.386699864486, 9748.805023899482, 9968.950155249177, 10163.847542286872, 10414.791704165875, 21890.45273868166, 22048.779512204994, 22132.66800997986, 22174.334769956928, 22254.666180007313, 7696.037995250594, 7801.258880406353, 7835.843283134305, 8043.919560804434, 8067.3142782864115, 4174.039970806732, 4241.448611680462, 4244.8514301999285, 4275.29457639486, 4319.805608747614, 3809.7523660961947, 3876.302265592164, 3877.0307423144213, 3877.8061096945603, 3880.5149356330458, 701.2216439751871, 708.9153594999659, 709.7622296530617, 714.7812978871012, 733.2008111158863, 605.5942518512608, 607.4472230270433, 610.6305685060563, 615.6983078291695, 621.1025068775576, 7939.404544659058, 8005.839883202303, 8195.95902020486, 8314.875276870851, 8394.79013024667, 609.4758507683389, 615.6952308607179, 633.8383712153371, 634.514596333805, 637.4263163153199, 3817.7136714746507, 3853.499045124172, 3878.2631300053463, 3960.405939109157, 4022.5374081980362, 94296.52851735834, 94800.52599736956, 96993.51503242439, 97053.0, 97744.51127744457, 68445.3155468449, 74142.0, 80060.0, 80924.59537702274, 81787.18212817915, 71045.28954710386, 71311.2868871315, 72057.0, 72322.63838680668, 72435.0, 8282.958585207036, 8347.12355202695, 8378.455400398954, 8638.352123590881, 8765.167309105625, 36391.818040909624, 48528.92233564259, 48752.537423877344, 49458.505414945386, 49794.0, 61994.0, 66421.33578664345, 66897.66551167212, 68855.65572172106, 68916.62166756736, 11305.938251724736, 11431.771364572496, 11579.768404632028, 11658.358790266617, 11769.35268560203, 12006.519739210335, 12272.81590776157, 12284.877151228373, 12430.937845310715, 12559.058070644922, 11839.881601183877, 11893.989010933821, 11903.345316007702, 11923.76152476963, 11926.105542084551, 11576.47905844256, 11833.467493962964, 11946.820797688215, 12285.631431057083, 12551.995840332935, 11342.319460832046, 11386.658400248005, 11566.42167891619, 11667.066634669036, 12394.81407778902, 9742.9025709742, 9923.950380248052, 10092.949535252277, 10104.84842727345, 10202.438865862448, 9766.706998790047, 10021.148202402586, 10080.69757907264, 10083.495825208563, 10114.039166279192], "value": 7109.654901423769, "unit": "score"}], "name": "dromaeo_css", "value": 7651.706863430275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 126.0, 167.0, 154.0, 112.0, 112.0, 110.0, 107.0, 134.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 149.0, 184.0, 162.0, 120.0, 147.0, 168.0, 143.0, 162.0, 115.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 185.0, 182.0, 188.0, 185.0, 183.0, 186.0, 185.0, 184.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 74.0, 155.0, 56.0, 56.0, 57.0, 65.0, 130.0, 56.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 140.0, 80.0, 92.0, 88.0, 125.0, 80.0, 77.0, 128.0], "value": 99.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 89.0, 86.0, 89.0, 86.0, 89.0, 85.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 87.0, 84.0, 84.0, 85.0, 84.0, 86.0, 87.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 63.0, 63.0, 80.0, 59.0, 56.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 69.0, 67.0, 70.0, 73.0, 70.0, 67.0, 67.0, 68.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 102.0, 101.0, 102.0, 83.0, 79.0, 80.0, 79.0, 78.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 146.0, 139.0, 119.0, 132.0, 136.0, 143.0, 131.0, 134.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 164.0, 169.0, 164.0, 168.0, 192.0, 165.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 68.0, 69.0, 68.0, 65.0, 68.0, 66.0, 69.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1494.7, "alertThreshold": 2.0}]} 10:17:11 INFO - Return code: 0 10:17:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:17:11 ERROR - # TBPL SUCCESS # 10:17:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:17:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:17:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:17:11 INFO - 2016-07-05 10:17:11.310 screenresolution[2012:12581] starting screenresolution argv=screenresolution get 10:17:11 INFO - 2016-07-05 10:17:11.312 screenresolution[2012:12581] Display 0: 1600x1200x32@60 10:17:11 INFO - 2016-07-05 10:17:11.318 screenresolution[2013:12584] starting screenresolution argv=screenresolution list 10:17:11 INFO - Available Modes on Display 0 10:17:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:17:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:17:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:17:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:17:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:17:11 INFO - Intel Iris: 10:17:11 INFO - Chipset Model: Intel Iris 10:17:11 INFO - Type: GPU 10:17:11 INFO - Bus: Built-In 10:17:11 INFO - VRAM (Dynamic, Max): 1536 MB 10:17:11 INFO - Vendor: Intel (0x8086) 10:17:11 INFO - Device ID: 0x0a2e 10:17:11 INFO - Revision ID: 0x0009 10:17:11 INFO - Displays: 10:17:11 INFO - Display: 10:17:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:17:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:17:11 INFO - Display Serial Number: 1600x1200 60 10:17:11 INFO - Main Display: Yes 10:17:11 INFO - Mirror: Off 10:17:11 INFO - Online: Yes 10:17:11 INFO - Rotation: Supported 10:17:11 INFO - Return code: 0 10:17:11 INFO - Running post-action listener: _resource_record_post_action 10:17:11 INFO - Running post-run listener: _resource_record_post_run 10:17:12 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 426496; Write bytes: 493063168; Read time: 9; Write time: 1656 10:17:12 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194564608; Write bytes: 193910784; Read time: 17680; Write time: 432 10:17:12 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 401920; Write bytes: 295654400; Read time: 8; Write time: 1211 10:17:12 INFO - Running post-run listener: _upload_blobber_files 10:17:12 INFO - Blob upload gear active. 10:17:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:17:12 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 10:17:12 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:17:12 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:17:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:14 INFO - (blobuploader) - INFO - Done attempting. 10:17:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:17:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:17:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:17:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:17:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:17:15 INFO - (blobuploader) - INFO - Done attempting. 10:17:15 INFO - (blobuploader) - INFO - Iteration through files over. 10:17:15 INFO - Return code: 0 10:17:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:17:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:17:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/52cbedca163aecdce0c7502c9ed4b6d3860e93727ee9cc8a669f2f98852d7a0b78717fc79f1dd951dbdaa4cb39a85048f8d7de6021025825e1b91b335e129448", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/649fee0dfd350493c2facab2f76c48c9c47d63bdf058e0f00fff1c94b8014114b78db2c81824b9f201c19ddbd4e64af471a9c58fcf1285019611b0a40cec2a01"} 10:17:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:17:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:17:15 INFO - Contents: 10:17:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/52cbedca163aecdce0c7502c9ed4b6d3860e93727ee9cc8a669f2f98852d7a0b78717fc79f1dd951dbdaa4cb39a85048f8d7de6021025825e1b91b335e129448", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/649fee0dfd350493c2facab2f76c48c9c47d63bdf058e0f00fff1c94b8014114b78db2c81824b9f201c19ddbd4e64af471a9c58fcf1285019611b0a40cec2a01"} 10:17:15 INFO - Running post-run listener: copy_logs_to_upload_dir 10:17:15 INFO - Copying logs to upload dir... 10:17:15 INFO - mkdir: /builds/slave/test/build/upload/logs 10:17:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.821410 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-05 10:17:15.220849) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:15.224123) ========= 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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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/Mozilla-Beta/sha512/52cbedca163aecdce0c7502c9ed4b6d3860e93727ee9cc8a669f2f98852d7a0b78717fc79f1dd951dbdaa4cb39a85048f8d7de6021025825e1b91b335e129448", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/649fee0dfd350493c2facab2f76c48c9c47d63bdf058e0f00fff1c94b8014114b78db2c81824b9f201c19ddbd4e64af471a9c58fcf1285019611b0a40cec2a01"} build_url:https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/I6PhN9jBTUSuuVz66XXfqA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/52cbedca163aecdce0c7502c9ed4b6d3860e93727ee9cc8a669f2f98852d7a0b78717fc79f1dd951dbdaa4cb39a85048f8d7de6021025825e1b91b335e129448", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/649fee0dfd350493c2facab2f76c48c9c47d63bdf058e0f00fff1c94b8014114b78db2c81824b9f201c19ddbd4e64af471a9c58fcf1285019611b0a40cec2a01"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:15.257502) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:15.257893) ========= 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.JYQxcDIlnk/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.2i6Od9YMdu/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005148 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:17:15.306562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:17:15.306887) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 10:17:15.307208) ========= ========= Total master_lag: 0.18 =========