builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1464011653.49 results: success (0) buildid: 20160523045840 builduid: 5d17ee22c9514600b3088f7d0899801d revision: ad804098d30c0b227c73e344c9addd9e5a7c3e09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.485909) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.486522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.486998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.724994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.725672) ========= 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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-05-23 06:54:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 71.0M=0s 2016-05-23 06:54:13 (71.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135158 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.919627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.920079) ========= 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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.026851 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.983889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:13.984356) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ad804098d30c0b227c73e344c9addd9e5a7c3e09 --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-aurora --rev ad804098d30c0b227c73e344c9addd9e5a7c3e09 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IM3HVptpLc/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.DYJ06Lj5sT/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-05-23 06:54:14,071 truncating revision to first 12 chars 2016-05-23 06:54:14,071 Setting DEBUG logging. 2016-05-23 06:54:14,071 attempt 1/10 2016-05-23 06:54:14,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ad804098d30c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 06:54:14,370 unpacking tar archive at: mozilla-aurora-ad804098d30c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549593 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:14.564540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:14.564855) ========= script_repo_revision: ad804098d30c0b227c73e344c9addd9e5a7c3e09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:14.565237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:14.565496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 06:54:14.580162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-05-23 06:54:14.580444) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IM3HVptpLc/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.DYJ06Lj5sT/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:54:14 INFO - MultiFileLogger online at 20160523 06:54:14 in /builds/slave/test 06:54:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:54:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:14 INFO - {'append_to_log': False, 06:54:14 INFO - 'base_work_dir': '/builds/slave/test', 06:54:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:54:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:14 INFO - 'branch': 'Mozilla-Aurora', 06:54:14 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:14 INFO - 'config_files': ('talos/mac_config.py',), 06:54:14 INFO - 'default_actions': ('clobber', 06:54:14 INFO - 'read-buildbot-config', 06:54:14 INFO - 'download-and-extract', 06:54:14 INFO - 'populate-webroot', 06:54:14 INFO - 'create-virtualenv', 06:54:14 INFO - 'install', 06:54:14 INFO - 'run-tests'), 06:54:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:14 INFO - 'download_minidump_stackwalk': True, 06:54:14 INFO - 'download_symbols': 'ondemand', 06:54:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:14 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:14 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:14 INFO - 'installer_path': 'installer.exe', 06:54:14 INFO - 'log_level': 'info', 06:54:14 INFO - 'log_name': 'talos', 06:54:14 INFO - 'log_to_console': True, 06:54:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:54:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:54:14 INFO - 'opt_config_files': (), 06:54:14 INFO - 'pip_index': False, 06:54:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:14 INFO - 'cmd': ('bash', 06:54:14 INFO - '-c', 06:54:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:14 INFO - 'enabled': True, 06:54:14 INFO - 'halt_on_failure': False, 06:54:14 INFO - 'name': 'check_screen_resolution'},), 06:54:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:14 INFO - 'cmd': ('bash', 06:54:14 INFO - '-c', 06:54:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:14 INFO - 'enabled': True, 06:54:14 INFO - 'halt_on_failure': False, 06:54:14 INFO - 'name': 'check_screen_resolution'},), 06:54:14 INFO - 'run_cmd_checks_enabled': True, 06:54:14 INFO - 'sps_profile': False, 06:54:14 INFO - 'sps_profile_interval': 0, 06:54:14 INFO - 'suite': 'dromaeojs', 06:54:14 INFO - 'system_bits': '32', 06:54:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:14 INFO - 'title': 't-yosemite-r7-0023', 06:54:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:14 INFO - 'use_talos_json': True, 06:54:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:14 INFO - 'work_dir': 'build'} 06:54:14 INFO - ##### 06:54:14 INFO - ##### Running clobber step. 06:54:14 INFO - ##### 06:54:14 INFO - Running pre-action listener: _resource_record_pre_action 06:54:14 INFO - Running main action method: clobber 06:54:14 INFO - rmtree: /builds/slave/test/build 06:54:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:16 INFO - Running post-action listener: _resource_record_post_action 06:54:16 INFO - ##### 06:54:16 INFO - ##### Running read-buildbot-config step. 06:54:16 INFO - ##### 06:54:16 INFO - Running pre-action listener: _resource_record_pre_action 06:54:16 INFO - Running main action method: read_buildbot_config 06:54:16 INFO - Using buildbot properties: 06:54:16 INFO - { 06:54:16 INFO - "project": "", 06:54:16 INFO - "product": "firefox", 06:54:16 INFO - "script_repo_revision": "production", 06:54:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:54:16 INFO - "repository": "", 06:54:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:54:16 INFO - "buildid": "20160523045840", 06:54:16 INFO - "pgo_build": "False", 06:54:16 INFO - "basedir": "/builds/slave/test", 06:54:16 INFO - "buildnumber": 353, 06:54:16 INFO - "slavename": "t-yosemite-r7-0023", 06:54:16 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:54:16 INFO - "platform": "yosemite_r7", 06:54:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:54:16 INFO - "branch": "mozilla-aurora", 06:54:16 INFO - "repo_path": "releases/mozilla-aurora", 06:54:16 INFO - "revision": "ad804098d30c0b227c73e344c9addd9e5a7c3e09", 06:54:16 INFO - "stage_platform": "macosx64", 06:54:16 INFO - "builduid": "5d17ee22c9514600b3088f7d0899801d", 06:54:16 INFO - "slavebuilddir": "test" 06:54:16 INFO - } 06:54:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 06:54:16 INFO - Running post-action listener: _resource_record_post_action 06:54:16 INFO - ##### 06:54:16 INFO - ##### Running download-and-extract step. 06:54:16 INFO - ##### 06:54:16 INFO - Running pre-action listener: _resource_record_pre_action 06:54:16 INFO - Running main action method: download_and_extract 06:54:16 INFO - mkdir: /builds/slave/test/build/tests 06:54:16 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')]} 06:54:16 INFO - https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:54:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:54:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 06:54:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 06:54:34 INFO - Downloaded 1199 bytes. 06:54:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 06:54:34 INFO - Using the following test package requirements: 06:54:34 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:54:34 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:54:34 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 06:54:34 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:54:34 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 06:54:34 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:54:34 INFO - u'jsshell-mac.zip'], 06:54:34 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:54:34 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 06:54:34 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 06:54:34 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:54:34 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 06:54:34 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:54:34 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 06:54:34 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:54:35 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 06:54:35 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 06:54:35 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 06:54:35 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:54:35 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')]} 06:54:35 INFO - https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:54:36 INFO - Downloaded 18102466 bytes. 06:54:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:54:39 INFO - Return code: 0 06:54:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:54:39 INFO - https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 06:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:54:52 INFO - Downloaded 18102466 bytes. 06:54:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:54:55 INFO - Return code: 0 06:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:54:55 INFO - https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:54:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:54:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:54:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 06:54:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:54:56 INFO - Downloaded 10840145 bytes. 06:54:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:54:56 INFO - Return code: 0 06:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:54:56 INFO - https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 06:54:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:54:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:54:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 06:54:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 06:55:01 INFO - Downloaded 114134393 bytes. 06:55:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:55:01 INFO - mkdir: /builds/slave/test/properties 06:55:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:55:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:55:01 INFO - Contents: 06:55:01 INFO - build_url:https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 06:55:04 INFO - Running post-action listener: _resource_record_post_action 06:55:04 INFO - Running post-action listener: set_extra_try_arguments 06:55:04 INFO - ##### 06:55:04 INFO - ##### Running populate-webroot step. 06:55:04 INFO - ##### 06:55:04 INFO - Running pre-action listener: _resource_record_pre_action 06:55:04 INFO - Running main action method: populate_webroot 06:55:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:04 INFO - '--tppagecycles', 06:55:04 INFO - '7'], 06:55:04 INFO - 'tests': ['tsvgm']}}, 06:55:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:55:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:55:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:55:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:04 INFO - 'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:04 INFO - 'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['damp', 'tps']}, 06:55:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:04 INFO - 'tests': ['damp', 'tps']}, 06:55:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['dromaeo_dom']}, 06:55:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['a11yr', 06:55:04 INFO - 'ts_paint', 06:55:04 INFO - 'tpaint', 06:55:04 INFO - 'sessionrestore', 06:55:04 INFO - 'sessionrestore_no_auto_restore', 06:55:04 INFO - 'tabpaint']}, 06:55:04 INFO - 'other-e10s': {'tests': ['a11yr', 06:55:04 INFO - 'ts_paint', 06:55:04 INFO - 'tpaint', 06:55:04 INFO - 'sessionrestore', 06:55:04 INFO - 'sessionrestore_no_auto_restore', 06:55:04 INFO - 'tabpaint']}, 06:55:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:55:04 INFO - 'ts_paint', 06:55:04 INFO - 'tpaint', 06:55:04 INFO - 'sessionrestore', 06:55:04 INFO - 'sessionrestore_no_auto_restore', 06:55:04 INFO - 'tabpaint']}, 06:55:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:55:04 INFO - 'ts_paint', 06:55:04 INFO - 'tpaint', 06:55:04 INFO - 'sessionrestore', 06:55:04 INFO - 'sessionrestore_no_auto_restore', 06:55:04 INFO - 'tabpaint']}, 06:55:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['a11yr', 06:55:04 INFO - 'ts_paint', 06:55:04 INFO - 'tpaint', 06:55:04 INFO - 'sessionrestore', 06:55:04 INFO - 'sessionrestore_no_auto_restore', 06:55:04 INFO - 'tabpaint']}, 06:55:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['a11yr', 06:55:04 INFO - 'ts_paint', 06:55:04 INFO - 'tpaint', 06:55:04 INFO - 'sessionrestore', 06:55:04 INFO - 'sessionrestore_no_auto_restore', 06:55:04 INFO - 'tabpaint']}, 06:55:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['tsvgx', 06:55:04 INFO - 'tsvgr_opacity', 06:55:04 INFO - 'tart', 06:55:04 INFO - 'tscrollx', 06:55:04 INFO - 'cart']}, 06:55:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:55:04 INFO - 'tsvgr_opacity', 06:55:04 INFO - 'tart', 06:55:04 INFO - 'tscrollx', 06:55:04 INFO - 'cart']}, 06:55:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:04 INFO - 'talos_options': ['--disable-e10s'], 06:55:04 INFO - 'tests': ['tp5o']}, 06:55:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:04 INFO - 'tests': ['tp5o']}, 06:55:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:04 INFO - 'talos_options': ['--disable-e10s', 06:55:04 INFO - '--xperf_path', 06:55:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:04 INFO - 'tests': ['tp5n']}, 06:55:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:04 INFO - 'talos_options': ['--xperf_path', 06:55:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:04 INFO - 'tests': ['tp5n']}}, 06:55:04 INFO - 'talos.zip': {'path': '', 06:55:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:04 INFO - Running post-action listener: _resource_record_post_action 06:55:04 INFO - ##### 06:55:04 INFO - ##### Running create-virtualenv step. 06:55:04 INFO - ##### 06:55:04 INFO - Running pre-action listener: _resource_record_pre_action 06:55:04 INFO - Running main action method: create_virtualenv 06:55:04 INFO - Creating virtualenv /builds/slave/test/build/venv 06:55:04 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 06:55:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:55:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:04 INFO - Using real prefix '/tools/python27' 06:55:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:55:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:08 INFO - Installing pip.................done. 06:55:08 INFO - Return code: 0 06:55:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55: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', 'pip>=1.5'] in /builds/slave/test/build 06:55: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 pip>=1.5 06:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:08 INFO - 'HOME': '/Users/cltbld', 06:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:08 INFO - 'LOGNAME': 'cltbld', 06:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:08 INFO - 'MOZ_NO_REMOTE': '1', 06:55:08 INFO - 'NO_EM_RESTART': '1', 06:55:08 INFO - 'PAGER': '/bin/cat', 06:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:08 INFO - 'PWD': '/builds/slave/test', 06:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:08 INFO - 'SHELL': '/bin/bash', 06:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:08 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:08 INFO - 'USER': 'cltbld', 06:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:08 INFO - 'XPC_FLAGS': '0x0', 06:55:08 INFO - 'XPC_SERVICE_NAME': '0', 06:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:08 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 06:55:08 INFO - Cleaning up... 06:55:08 INFO - Return code: 0 06:55:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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', '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 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:55: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 psutil>=0.7.1 06:55:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:08 INFO - 'HOME': '/Users/cltbld', 06:55:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:08 INFO - 'LOGNAME': 'cltbld', 06:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:08 INFO - 'MOZ_NO_REMOTE': '1', 06:55:08 INFO - 'NO_EM_RESTART': '1', 06:55:08 INFO - 'PAGER': '/bin/cat', 06:55:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:08 INFO - 'PWD': '/builds/slave/test', 06:55:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:08 INFO - 'SHELL': '/bin/bash', 06:55:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:08 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:08 INFO - 'USER': 'cltbld', 06:55:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:08 INFO - 'XPC_FLAGS': '0x0', 06:55:08 INFO - 'XPC_SERVICE_NAME': '0', 06:55:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:08 INFO - Downloading/unpacking psutil>=0.7.1 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:11 INFO - Installing collected packages: psutil 06:55:11 INFO - Running setup.py install for psutil 06:55:11 INFO - building 'psutil._psutil_osx' extension 06:55:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:55:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:55:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:55:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:55:12 INFO - building 'psutil._psutil_posix' extension 06:55:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:55:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:55:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:55:12 INFO - ^ 06:55:12 INFO - 1 warning generated. 06:55:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:55:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:12 INFO - Successfully installed psutil 06:55:12 INFO - Cleaning up... 06:55:12 INFO - Return code: 0 06:55:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:55:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:12 INFO - 'HOME': '/Users/cltbld', 06:55:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:12 INFO - 'LOGNAME': 'cltbld', 06:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:12 INFO - 'MOZ_NO_REMOTE': '1', 06:55:12 INFO - 'NO_EM_RESTART': '1', 06:55:12 INFO - 'PAGER': '/bin/cat', 06:55:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:12 INFO - 'PWD': '/builds/slave/test', 06:55:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:12 INFO - 'SHELL': '/bin/bash', 06:55:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:12 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:12 INFO - 'USER': 'cltbld', 06:55:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:12 INFO - 'XPC_FLAGS': '0x0', 06:55:12 INFO - 'XPC_SERVICE_NAME': '0', 06:55:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:55:15 INFO - Installing collected packages: mozsystemmonitor 06:55:15 INFO - Running setup.py install for mozsystemmonitor 06:55:15 INFO - Successfully installed mozsystemmonitor 06:55:15 INFO - Cleaning up... 06:55:15 INFO - Return code: 0 06:55:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:15 INFO - 'HOME': '/Users/cltbld', 06:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:15 INFO - 'LOGNAME': 'cltbld', 06:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:15 INFO - 'MOZ_NO_REMOTE': '1', 06:55:15 INFO - 'NO_EM_RESTART': '1', 06:55:15 INFO - 'PAGER': '/bin/cat', 06:55:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:15 INFO - 'PWD': '/builds/slave/test', 06:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:15 INFO - 'SHELL': '/bin/bash', 06:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:15 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:15 INFO - 'USER': 'cltbld', 06:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:15 INFO - 'XPC_FLAGS': '0x0', 06:55:15 INFO - 'XPC_SERVICE_NAME': '0', 06:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:15 INFO - Downloading/unpacking blobuploader==1.2.4 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55:18 INFO - Downloading blobuploader-1.2.4.tar.gz 06:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:55:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:55:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:19 INFO - Downloading docopt-0.6.1.tar.gz 06:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:19 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:19 INFO - Running setup.py install for blobuploader 06:55:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:55:19 INFO - Running setup.py install for requests 06:55:20 INFO - Running setup.py install for docopt 06:55:20 INFO - Successfully installed blobuploader requests docopt 06:55:20 INFO - Cleaning up... 06:55:20 INFO - Return code: 0 06:55:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:20 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')]} 06:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:20 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')]} 06:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:20 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 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55:20 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 06:55:20 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 06:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:20 INFO - 'HOME': '/Users/cltbld', 06:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:20 INFO - 'LOGNAME': 'cltbld', 06:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:20 INFO - 'MOZ_NO_REMOTE': '1', 06:55:20 INFO - 'NO_EM_RESTART': '1', 06:55:20 INFO - 'PAGER': '/bin/cat', 06:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:20 INFO - 'PWD': '/builds/slave/test', 06:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:20 INFO - 'SHELL': '/bin/bash', 06:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:20 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:20 INFO - 'USER': 'cltbld', 06:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:20 INFO - 'XPC_FLAGS': '0x0', 06:55:20 INFO - 'XPC_SERVICE_NAME': '0', 06:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ZzqSRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ks1w0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-tj8YY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-z5LRz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Nlm9WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rXajxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1wYpeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-hSGzfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-i34gS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-dP8D4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fqdXJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-l8jGFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-5R5Ovc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-eSz85C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-mjmfJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-cAcCjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-g6ttkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:22 INFO - Running setup.py install for manifestparser 06:55:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:23 INFO - Running setup.py install for mozcrash 06:55:23 INFO - Running setup.py install for mozdebug 06:55:23 INFO - Running setup.py install for mozdevice 06:55:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:55:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:23 INFO - Running setup.py install for mozfile 06:55:23 INFO - Running setup.py install for mozhttpd 06:55:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:23 INFO - Running setup.py install for mozinfo 06:55:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Running setup.py install for mozInstall 06:55:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Running setup.py install for mozleak 06:55:24 INFO - Running setup.py install for mozlog 06:55:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Running setup.py install for moznetwork 06:55:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Running setup.py install for mozprocess 06:55:24 INFO - Running setup.py install for mozprofile 06:55:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:24 INFO - Running setup.py install for mozrunner 06:55:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:25 INFO - Running setup.py install for mozscreenshot 06:55:25 INFO - Running setup.py install for moztest 06:55:25 INFO - Running setup.py install for mozversion 06:55:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:25 INFO - Cleaning up... 06:55:25 INFO - Return code: 0 06:55:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:25 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')]} 06:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:25 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')]} 06:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:25 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 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55:25 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 06:55:25 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 06:55:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:25 INFO - 'HOME': '/Users/cltbld', 06:55:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:25 INFO - 'LOGNAME': 'cltbld', 06:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:25 INFO - 'MOZ_NO_REMOTE': '1', 06:55:25 INFO - 'NO_EM_RESTART': '1', 06:55:25 INFO - 'PAGER': '/bin/cat', 06:55:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:25 INFO - 'PWD': '/builds/slave/test', 06:55:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:25 INFO - 'SHELL': '/bin/bash', 06:55:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:25 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:25 INFO - 'USER': 'cltbld', 06:55:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:25 INFO - 'XPC_FLAGS': '0x0', 06:55:25 INFO - 'XPC_SERVICE_NAME': '0', 06:55:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-TnDo84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:25 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)) 06:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:25 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MEaHYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-hi1OT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-rsLPfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-shXOPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-VlJrwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-QFCN0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-DWEfTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-RSteAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-HRf1Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ecGLiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:26 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)) 06:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:26 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ERd2k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:27 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)) 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:27 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-RZNMdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:27 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)) 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:27 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-xopeyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:27 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)) 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:27 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-KFx_cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:27 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)) 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:27 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-QxliD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:27 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)) 06:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:27 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AhxOs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:27 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)) 06:55:27 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)) 06:55:27 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)) 06:55:27 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)) 06:55:27 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)) 06:55:27 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)) 06:55:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:27 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 06:55:27 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 06:55:27 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 06:55:27 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 06:55:27 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 06:55:27 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 06:55:29 INFO - Downloading blessings-1.6.tar.gz 06:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:30 INFO - Installing collected packages: blessings 06:55:30 INFO - Running setup.py install for blessings 06:55:30 INFO - Successfully installed blessings 06:55:30 INFO - Cleaning up... 06:55:30 INFO - Return code: 0 06:55:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:30 INFO - Reading from file tmpfile_stdout 06:55:30 INFO - Current package versions: 06:55:30 INFO - blessings == 1.6 06:55:30 INFO - blobuploader == 1.2.4 06:55:30 INFO - docopt == 0.6.1 06:55:30 INFO - manifestparser == 1.1 06:55:30 INFO - mozInstall == 1.12 06:55:30 INFO - mozcrash == 0.17 06:55:30 INFO - mozdebug == 0.1 06:55:30 INFO - mozdevice == 0.48 06:55:30 INFO - mozfile == 1.2 06:55:30 INFO - mozhttpd == 0.7 06:55:30 INFO - mozinfo == 0.9 06:55:30 INFO - mozleak == 0.1 06:55:30 INFO - mozlog == 3.1 06:55:30 INFO - moznetwork == 0.27 06:55:30 INFO - mozprocess == 0.22 06:55:30 INFO - mozprofile == 0.28 06:55:30 INFO - mozrunner == 6.11 06:55:30 INFO - mozscreenshot == 0.1 06:55:30 INFO - mozsystemmonitor == 0.0 06:55:30 INFO - moztest == 0.7 06:55:30 INFO - mozversion == 1.4 06:55:30 INFO - psutil == 3.1.1 06:55:30 INFO - requests == 1.2.3 06:55:30 INFO - wsgiref == 0.1.2 06:55:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:30 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')]} 06:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:30 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')]} 06:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:30 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 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55:30 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 06:55:30 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 06:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:30 INFO - 'HOME': '/Users/cltbld', 06:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:30 INFO - 'LOGNAME': 'cltbld', 06:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:30 INFO - 'MOZ_NO_REMOTE': '1', 06:55:30 INFO - 'NO_EM_RESTART': '1', 06:55:30 INFO - 'PAGER': '/bin/cat', 06:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:30 INFO - 'PWD': '/builds/slave/test', 06:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:30 INFO - 'SHELL': '/bin/bash', 06:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:30 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:30 INFO - 'USER': 'cltbld', 06:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:30 INFO - 'XPC_FLAGS': '0x0', 06:55:30 INFO - 'XPC_SERVICE_NAME': '0', 06:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 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)) 06:55:30 INFO - Cleaning up... 06:55:30 INFO - Return code: 0 06:55:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:30 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')]} 06:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:30 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')]} 06:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:30 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 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55:30 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 06:55:30 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 06:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:30 INFO - 'HOME': '/Users/cltbld', 06:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:30 INFO - 'LOGNAME': 'cltbld', 06:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:30 INFO - 'MOZ_NO_REMOTE': '1', 06:55:30 INFO - 'NO_EM_RESTART': '1', 06:55:30 INFO - 'PAGER': '/bin/cat', 06:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:30 INFO - 'PWD': '/builds/slave/test', 06:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:30 INFO - 'SHELL': '/bin/bash', 06:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:30 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:30 INFO - 'USER': 'cltbld', 06:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:30 INFO - 'XPC_FLAGS': '0x0', 06:55:30 INFO - 'XPC_SERVICE_NAME': '0', 06:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:31 INFO - Downloading/unpacking jsonschema 06:55:31 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 06:55:31 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 06:55:31 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 06:55:31 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 06:55:31 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 06:55:31 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 06:55:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:55:33 INFO - Downloading/unpacking functools32 (from jsonschema) 06:55:33 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 06:55:33 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 06:55:33 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 06:55:33 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 06:55:33 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 06:55:33 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 06:55:33 INFO - Downloading functools32-3.2.3-2.tar.gz 06:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:55:34 INFO - warning: no files found matching '*.txt' 06:55:34 INFO - no previously-included directories found matching 'build' 06:55:34 INFO - no previously-included directories found matching 'dist' 06:55:34 INFO - no previously-included directories found matching '.git*' 06:55:34 INFO - Installing collected packages: jsonschema, functools32 06:55:34 INFO - Running setup.py install for functools32 06:55:34 INFO - warning: no files found matching '*.txt' 06:55:34 INFO - no previously-included directories found matching 'build' 06:55:34 INFO - no previously-included directories found matching 'dist' 06:55:34 INFO - no previously-included directories found matching '.git*' 06:55:34 INFO - Successfully installed jsonschema functools32 06:55:34 INFO - Cleaning up... 06:55:34 INFO - Return code: 0 06:55:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10086fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10087f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdacadba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, '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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 06:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:34 INFO - 'HOME': '/Users/cltbld', 06:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:34 INFO - 'LOGNAME': 'cltbld', 06:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:34 INFO - 'MOZ_NO_REMOTE': '1', 06:55:34 INFO - 'NO_EM_RESTART': '1', 06:55:34 INFO - 'PAGER': '/bin/cat', 06:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:34 INFO - 'PWD': '/builds/slave/test', 06:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:34 INFO - 'SHELL': '/bin/bash', 06:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:55:34 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:34 INFO - 'USER': 'cltbld', 06:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:34 INFO - 'XPC_FLAGS': '0x0', 06:55:34 INFO - 'XPC_SERVICE_NAME': '0', 06:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:34 INFO - Downloading/unpacking flake8 06:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:55:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:55:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:55:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:55:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:55:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:55:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:55:38 INFO - no previously-included directories found matching 'docs/_build' 06:55:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:55:38 INFO - Running setup.py install for pep8 06:55:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:55:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:55:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:55:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:55:38 INFO - no previously-included directories found matching 'docs/_build' 06:55:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:55:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:55:38 INFO - Cleaning up... 06:55:38 INFO - Return code: 0 06:55:38 INFO - Running post-action listener: _resource_record_post_action 06:55:38 INFO - Running post-action listener: _start_resource_monitoring 06:55:38 INFO - Starting resource monitoring. 06:55:38 INFO - ##### 06:55:38 INFO - ##### Running install step. 06:55:38 INFO - ##### 06:55:38 INFO - Running pre-action listener: _resource_record_pre_action 06:55:38 INFO - Running main action method: install 06:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:39 INFO - Reading from file tmpfile_stdout 06:55:39 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:39 INFO - Reading from file tmpfile_stdout 06:55:39 INFO - Output received: 06:55:39 INFO - Usage: mozinstall [options] installer 06:55:39 INFO - Options: 06:55:39 INFO - -h, --help show this help message and exit 06:55:39 INFO - -d DEST, --destination=DEST 06:55:39 INFO - Directory to install application into. [default: 06:55:39 INFO - "/builds/slave/test"] 06:55:39 INFO - --app=APP Application being installed. [default: firefox] 06:55:39 INFO - mkdir: /builds/slave/test/build/application 06:55:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:56:10 INFO - Reading from file tmpfile_stdout 06:56:10 INFO - Output received: 06:56:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:56:10 INFO - Running post-action listener: _resource_record_post_action 06:56:10 INFO - ##### 06:56:10 INFO - ##### Running run-tests step. 06:56:10 INFO - ##### 06:56:10 INFO - Running pre-action listener: _resource_record_pre_action 06:56:10 INFO - Running main action method: run_tests 06:56:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:10 INFO - 2016-05-23 06:56:10.824 screenresolution[1645:8220] starting screenresolution argv=screenresolution get 06:56:10 INFO - 2016-05-23 06:56:10.827 screenresolution[1645:8220] Display 0: 1600x1200x32@60 06:56:10 INFO - 2016-05-23 06:56:10.833 screenresolution[1646:8223] starting screenresolution argv=screenresolution list 06:56:10 INFO - Available Modes on Display 0 06:56:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:11 INFO - Intel Iris: 06:56:11 INFO - Chipset Model: Intel Iris 06:56:11 INFO - Type: GPU 06:56:11 INFO - Bus: Built-In 06:56:11 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:11 INFO - Vendor: Intel (0x8086) 06:56:11 INFO - Device ID: 0x0a2e 06:56:11 INFO - Revision ID: 0x0009 06:56:11 INFO - Displays: 06:56:11 INFO - Display: 06:56:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:11 INFO - Display Serial Number: 1600x1200 60 06:56:11 INFO - Main Display: Yes 06:56:11 INFO - Mirror: Off 06:56:11 INFO - Online: Yes 06:56:11 INFO - Rotation: Supported 06:56:11 INFO - Return code: 0 06:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:56:11 INFO - Python 2.7.3 06:56:11 INFO - Return code: 0 06:56:11 INFO - grabbing minidump binary from tooltool 06:56: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')]} 06:56:11 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 0x10070ee00>, '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 0x100577db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100709b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:56:11 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 06:56:11 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 06:56:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:11 INFO - Return code: 0 06:56:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:56:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:56:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:56:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:56:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:56:12 INFO - Return code: 0 06:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 06:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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 06:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IM3HVptpLc/Render', 06:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:12 INFO - 'HOME': '/Users/cltbld', 06:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:12 INFO - 'LOGNAME': 'cltbld', 06:56:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:56:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:12 INFO - 'MOZ_NO_REMOTE': '1', 06:56:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:56:12 INFO - 'NO_EM_RESTART': '1', 06:56:12 INFO - 'PAGER': '/bin/cat', 06:56:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:12 INFO - 'PWD': '/builds/slave/test', 06:56:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:12 INFO - 'SHELL': '/bin/bash', 06:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DYJ06Lj5sT/Listeners', 06:56:12 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 06:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:12 INFO - 'USER': 'cltbld', 06:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:12 INFO - 'XPC_FLAGS': '0x0', 06:56:12 INFO - 'XPC_SERVICE_NAME': '0', 06:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 06:56:12 INFO - mozversion application_buildid: 20160523045840 06:56:12 INFO - mozversion application_changeset: ad804098d30c0b227c73e344c9addd9e5a7c3e09 06:56:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:56:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:12 INFO - mozversion application_name: Firefox 06:56:12 INFO - mozversion application_remotingname: firefox-dev 06:56:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:56:12 INFO - mozversion application_vendor: Mozilla 06:56:12 INFO - mozversion application_version: 48.0a2 06:56:12 INFO - mozversion platform_buildid: 20160523045840 06:56:12 INFO - mozversion platform_changeset: ad804098d30c0b227c73e344c9addd9e5a7c3e09 06:56:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:56:12 INFO - mozversion platform_version: 48.0a2 06:56:12 INFO - using testdate: 1464011772 06:56:12 INFO - actual date: 1464011772 06:56:12 INFO - starting webserver on 'localhost:49270' 06:56:12 INFO - SUITE-START | Running 2 tests 06:56:12 INFO - TEST-START | dromaeo_css 06:56:12 INFO - operating with platform_type : mac_ 06:56:12 INFO - Initialising browser for dromaeo_css test... 06:56:12 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpm3DqQx/profile http://localhost:49270/getInfo.html) 06:56:14 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 06:56:14 INFO - PROCESS | 1664 | colorDepth:24 06:56:14 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 06:56:14 INFO - PROCESS | 1664 | __metrics 06:56:14 INFO - PROCESS | 1664 | 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" 06:56:14 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:56:15 INFO - TEST-INFO | 1664: exit 0 06:56:15 INFO - Browser initialized. 06:56:15 INFO - Running cycle 1/1 for dromaeo_css test... 06:56:15 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpm3DqQx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:27 INFO - PROCESS | 1667 | RSS: Main: 211095552 06:56:27 INFO - PROCESS | 1667 | 06:57:18 INFO - PROCESS | 1667 | 1464011838735 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] 06:59:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 06:59:30 INFO - PROCESS | 1667 | RSS: Main: 348622848 06:59:30 INFO - PROCESS | 1667 | 07:02:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 07:02:34 INFO - PROCESS | 1667 | RSS: Main: 356696064 07:02:34 INFO - PROCESS | 1667 | 07:05:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 07:05:37 INFO - PROCESS | 1667 | RSS: Main: 359444480 07:05:37 INFO - PROCESS | 1667 | 07:08:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 07:08:39 INFO - PROCESS | 1667 | RSS: Main: 357171200 07:08:39 INFO - PROCESS | 1667 | 07:11:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 07:11:43 INFO - PROCESS | 1667 | RSS: Main: 320909312 07:11:43 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 07:14:46 INFO - PROCESS | 1667 | RSS: Main: 368328704 07:14:46 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | __start_tp_report 07:14:46 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 07:14:46 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 07:14:46 INFO - PROCESS | 1667 | |i|pagename|runs| 07:14:46 INFO - PROCESS | 1667 | |0;dojo.html;2495.6506089147515;3458.2391873787756;3471.6181220065796;3499.7025252853505;3538.8761393351238;5669.262995810544;5683.715814209294;5689.345725241598;5700.629459085162;5719.027765279902;5681.886362272752;5734.770609175638;5741.741621627027;5742.655440673562;5746.48281654651;5097;5137.332146820908;5196.688198708071;5240.764165612557;5246.5278124968745;5208.895822083556;5213.869653258661;5216.321878155834;5234.26720259164;5236.581073514129;5116.411612664536;5158.974205128988;5172.612054095939;5173.224016397533;5211.895762084756;5191.63658543904;5277.102892508283;5278.683279003272;5283.260343551906;5336.439673834269;5067.290579318861;5101.846944591668;5127.102757017507;5165.870853228662;5196.168613021936;4832.73419961902;5537.197106419587;5592.5246354059955;5631.943680563224;5690.089585666315;6202.3797620238065;6203.2866220384785;6209.658468784215;6214.5960512566535;6217.222847144107;5272.6836389816735;6138.664296166084;6233.501319894398;6291.6854157291955;6323.019931910561;5759.596828222068;5805.970970145122;5813.128030795415;5819.912701309526;5840.094785308284;6010.429009244115;6367.395097465734;6378.74485020594;6379.936200638027;6382.6170429774365;6033.576344075336;6049.455549000611;6059.697015149225;6091.329953705089;6137.754489820357;6172.722227499773;6181.690915454209;6222.066689996536;6245.594036387621;6253.46845518127;6247.812565623039;6260.154879091356;6276.215473065867;6293.056041593706;6299.716512756937;5248.396434410015;6227.657478838617;6278.623282603058;6282.748690052346;6292.46514046302;4857.198562237191;4906.092372910952;4928.28539861718;4967.5032496750755;4986.601071914238;4452.487963884195;4457.2199865023495;4472.865814025585;4488.663350248745;4496.100779844044;5747.798827041033;5749.85625359361;5750.482456578928;5773.422657734193;5777.971110144423;6161.137440758297;6221.2845522765465;6302.338254483305;6302.527310451735;6304.05439184126;5723.627964182315;5728.856778580569;5735.082386818172;5735.569832262597;5742.425757424224;5377.220303056113;5381.892362152813;5387.595930305243;5396.865078372994;5410.323709536308;6279.497640188774;6300.960341543594;6368.235811702625;6370.713317900613;6375.4262116409745;6292.2134733158355;6304;6305;6328.778492752732;6337.588056776295;6348.682565871781;6353.936460635335;6379.712912918837;6381.968090159519;6385.521085918482;6071.574989750852;6139.798803208881;6227;6242.375762423721;6255.812325630239;6262.2172228471445;6274.403931626488;6275.215598050244;6289.213848268966;6290.433860952537;5902.203202567598;5946.643201407929;6135.601185922901;6139.877202456015;6149.0776383542825;6050.606710563799;6122.4896795164905;6132.477886260695;6146.0473626587955;6150.600210986271;5955.612885162451;5956.910646340221;5965.880682386415;5972.372900845348;5977.581569290108;5958.523318134452;6114.7248373822395;6127.479164271087;6140.355262697352;6150.415710507674;5810;5908.172855800278;5943.108533719977;6010.459058684739;6017.969910150421 07:14:46 INFO - PROCESS | 1667 | |1;ext.html;513.946035666255;516.8268630008947;565.8528782516545;604.0214851939858;624.7629693207449;26235.606465903;31349.059528214133;38536.80731596345;39712.41150353982;39754.60245397545;41965.58034419655;42394.940126496855;42441.78779106108;42471.57528424715;42699.57300426995;9450.905490945072;9668.274879384038;9675.27435442341;9681.806363872754;9684.322097453181;8667.566621668922;8712.172343627346;8717.520536370497;8724.8691269631;8731.34514911381;11618.954294113528;11833.994110500618;11852.822207666892;11854.585089521868;11884.465199066062;11512.539498420054;11529.077673786078;11535.653930382103;11557.133215008824;11559.537618495335;8631.913680863174;11417.143714221467;11525.596604118899;11547.595834145848;11765.58820441289;39104.60895391038;39348;39351;39408.81773546798;39537.61618343344;3172.7144556989983;3175.841207939594;3223.1458663454205;3318.303156337172;3359.5968483781858;26999.190024299303;27793.583096253573;28191.718082819116;28499.715002849913;28529.714702852914;2746.436980419009;2770.501309764242;2789.191134570972;2802.9159125226074;2819.84490853003;447617;449535;450328;451162.744186277;451275;64245.35754642394;64800.67599661971;64805.02792458117;64828.67585662136;64881;67852.32147678558;67987;68016.319836801;68124;68176.31823681798;17377.304907803547;17947.371841985467;17951.281948722168;17951.461456156074;18004.36984705529;13755.79366309506;13868.791968120486;13874.93062534681;13877.722445551235;13879.791803122962;15340.846591534166;17582.824171758373;17714.5571360717;17997;18144.909275453538;6782.084418603426;6871.793846184622;6911.308869113049;6949.270326615733;7012.123484564429;930.06993006993;971.1308379000754;1027.7995790820867;1034.7723500829804;1101.1631160318057;28912.710872891003;29138.8344466219;29468.557971630442;29537.704622953926;29695.406091878474;1127.301073334538;1191.523390643732;1200.7778560966249;1202.5310129049678;1231.07054174098;15340.232988350537;15406.152661603719;15469;15654.9217253913;15707;598450;607732;609110;609879;611441;60088.399116009154;61675.691621541606;61718.69140654268;61842.38157618366;61973.07040394397;1361.1832900259765;1436.7485690004207;1511.5692027772252;1528.8853335999622;1589.4436947068664;28492.287692807844;29048;29175.562366564092;29816.552751709176;29978;48842;48972.265416018075;49332.75333623309;49430;49486;364479;367501.16249418585;367773;368348;614122;40401;41089;41490.792546037075;41633;42391.36412953746;42891;43119.78440107779;44414;44646.55353446424;44740.10519789521;33666.66333336733;37890;38064.23871522609;39296.214075717755;40168.995775105854;36116.91649250527;36174;36335.90961078638;37440.812795935846;38231;37169.628303716614;37303.067423314635;37338.8789898703;37578;38096.61903380931;32158.356832862744;33251.33497330088;33396.66603334033;33405.16487087842;33484.49773253452;21182.788172118697;24665;24936.25191244193;25233.934498340495;25537.616935745606 07:14:46 INFO - PROCESS | 1667 | |2;jquery.html;378.64974898219174;399.1458279282335;399.3271337795815;404.66412877311836;412.9896752581185;15137.470188543402;17036.744448833277;18116.36592719255;20636.071376788044;20686;14394.49619263326;16439.753403698924;19744.901275493638;20260.986950652445;20277.594448111027;5619;5770.672745268591;5955.52355811534;5961.433663801932;5964.79123230687;4177;5899.0266606009955;5977.85055373617;5998.790042348497;6006.369331220225;6212.9068063979075;6512.185976752906;6518.739250429977;6523.249826269992;6524.0540121682325;5821.2141360916585;6191.473724733403;6475.740970361227;6492.188476440445;6497.707603157845;5941.257342832146;5970.641761494324;5978.940210597882;5981.491573216282;5999.610025348338;13247.801282980763;16143.354265829354;22780.886095569414;25064.49871002588;25991.870040649865;2111.546017606222;2184.388371256051;2349.424391024193;2454.9263522094366;2484.6521486991837;9699.981501942266;9975.700728978143;10003.399796012263;10279.588816447333;13450.663733406645;1501.8573235542606;1730.0917018565353;1789.9463016109537;1802.152988095593;1835.6604028254815;106911.46544267228;118221;119121.99999999913;121432;121697.39151304275;11582.305061696325;11602.70993225176;11657.067434605211;11692.47383867728;11879.109066820023;14971.475998340005;15105.622359440882;15145;15177.165255911032;15186.392544298325;7953.5227886327;8282;8567.785805354915;8804.163604457566;8926.419782714103;8278.213569710868;8831.293496520262;8834.646614135363;8874.556272186364;8943.105689431004;4090.52741013235;4227.6406505447385;4229.513605935295;4601.67788254819;4657.510961349078;1665.9416920407728;1741.6957422063188;1754.929802807899;1859.1912518054419;1866.6546688862604;812.9390295727726;953.2326477185793;993.5926270229171;1016.537475448669;1053.7154968158707;17932.462026139237;18975.90512047431;19213.615727685647;19371.031448427522;19487.530639991302;954.2890546542732;977.4575110813424;980.3186785184371;1016.6630880392261;1060.660588611637;10456.63401780934;10533.999270069331;10601.522931468102;10620.150387968944;10652.520636571373;612412;615024;632318;635823.8208809019;638030;106661;113198.43400782943;124789;127842.36078819547;138321;1021.1779517488493;1048.580567772897;1060.3584831177182;1061.9415932123652;1064.4411683866188;17958.640827183644;18107.004114773816;18115.456536303933;18420.35528756487;18756.906215468836;55623.72188139033;55808.72095639658;56215;57058.7147064262;57959;74833;76105.61947190229;81861.18138818536;83781.58109209414;84325.5783721102;7961.800954976172;8008.83982320362;8225.341972642294;8229.094799572162;8558.82882342362;9432.622695092394;12379.814302785286;12439.751204976032;12771.36143192818;12853.678658033625;10815.621453249098;10896.182786291218;11058.391788451712;11171.441427928734;11361.977422032056;10529.894701052892;10621.522031508446;10871.635332066886;10983.560657573607;10987.945060274647;11143.83284250753;11399.316041037564;11417.885821142014;11481.94259028733;11555.4800033997;8216.917830821616;8314;8319.667213311643;8487.8726819099;8641.351898607503;9633.662821801203;10837.945810270898;11206;11372.601958931398;11545.480453379787 07:14:46 INFO - PROCESS | 1667 | |3;mootools.html;1295.2811189789668;1444.5449683349736;1587.515807678658;1776.8578513718903;1955.3254127326077;7777.766666999985;8337.2079652433;8471.872921906177;8478.194571515696;8487.193716596928;8361.83276334473;8592.312614990802;8592.8711069334;8685.91314086859;8831.425957312771;2410.3733029412347;2441.0357908626083;2441.951160976779;2447.0334217983973;2448.2288079254977;2394.976050239493;2424.1151979527435;2445.8043356531434;2447.21689059501;2448.2655203438985;2395.281415575329;2429.380507970474;2439.902403903842;2442.218490083174;2448.20433359159;2391.8325717199805;2412.5054363855456;2431.185552839801;2431.258466167818;2431.914882979096;2312.5259321838985;2409.975900240993;2410;2412.481316516957;2416.1060407649106;7602.467827252094;7811.648475818602;8562;8601.354898382584;8608.52653104079;5105.591552675777;5237.607179461517;5244.8688782780355;5246.632735708502;5280.1815718563685;3463.8441270142903;3489.4068008438626;3560.2701446203464;3573.6247693992277;3587.4260118381194;886.2112719679491;1029.9494515594051;1047.7328281288299;1057.5082586597268;1057.8677665291839;11314.943425282821;11487.770244595062;11518.251313664585;11730.882691173065;11766.411679415995;4727.2436410174205;4786.1863483207935;4792.9281060784115;4811.9518804812205;4832.4684284728655;10032.046955539357;10133.08802207805;10149.98500149994;10161.237907156992;10349.63776267827;5379.704116273642;5381;5423.891522169534;5428.647137936022;5438.211459338374;4762.190427627243;4859.975700121548;4867.440244371872;4879.804807807719;4933.0380575788095;3837.4435706822355;3942.0342016206214;3948.230095131479;3991.1219531702977;4014.437978682987;1272.3511009385095;1293.230527835936;1295.902807289457;1308.5289295853486;1312.6127792301295;775.4106878772174;879.4898958603994;909.9226565741986;917.6971599372191;924.2744445610164;4966.503349665005;4994.950050499521;5590.021746194481;5650.308674270165;5959.314678811906;978.1490103609905;988.2884323287221;999;1007.561710655867;1008.8789345278614;3741.6258374162367;3815.9618403815607;3860.6332398422664;3876.089119057019;3907.78507182102;10222.693319200436;10426.635067772591;10558.102561282223;10655.73360665974;10675.946620266848;10187;10420.801607815047;10423.947880260703;10526.368417894952;10542.209334299958;8116.553589552631;8276.048254450694;8333.8333233335;8359.749207523784;8400.033996090528;5382.4886635769535;5448.754806033818;5509.311336082989;5629.662220266797;5654.46282603152;7639.465237433326;9075.863862041942;9549.665761698307;9561.569729362056;9587.041295870637;9301.116393942564;9671.951640242036;9880.35777674449;9903.55434005486;9917.355371900803;5892.882142357043;7303.890441643486;7309.720798860072;7315.890261645973;7317.743878964211;7968.482048666818;8101.432899696964;8117.472364296302;8124.22819832115;8148.592570371339;7128.964355178191;7173.390261827803;7332.560046397233;7344.155422126524;7351.558906465629;6122.938770612237;7144.64276786169;7230.879213721882;7234.529755565872;7317.5609463432365;6713.865722685421;6714.597124172566;6759.5606285591275;6771.559848609824;6779.559328643622;3941.566427693009;4459.3979812724865;4715.858524244278;4718.858434246841;4863.294822250825;4646.605038571624;4778.952210477851;4829.66192366531;4895.241237608177;5036.899262014813 07:14:46 INFO - PROCESS | 1667 | |4;prototype.html;302.83949506761394;319.7617774757805;327.75254682714547;332.1563229397328;334.54167790127514;6699.531032827704;6707.631080290582;6709.698063587138;6763.830904227397;6777.864442711143;6489.1888513935755;6695.866082678343;6749.662516874149;6801.183857937042;6805.761798337059;4029.597040295976;4980.701157930518;5022.146235140035;5025.296458495814;5025.623078269126;5013.573846223076;5033.823816166435;5035.093683137034;5045.142325804622;5056.544910958013;4973.502649735034;4978;4985.900281994358;5012.373453318335;5032.11937910866;5027.014329339909;5027.773750181214;5035.370578677665;5049.873753156164;5060.367454068241;3811.33301672209;3865.207632435372;4300.35494675798;4343.956560434419;4361.084172323815;6448.64532450715;6469.93530064698;6480.384363485461;6481;6504.15445992018;5955;5984.73068711909;6000.399960004008;6002.639841609517;6011.549133814938;5811.331696854873;7227.710891564331;7233.638318084075;7234.855302893965;7236.276372362774;4830.637702172351;4836.951630483685;4843.66094373394;4850.878728031792;4855.32025516428;7202.819929501804;7282.235365286621;7453.180150183475;7507.286807753255;7557.319841214262;4820.662553621213;4835.1296766581645;4881.023795240966;4883.609311255091;4886.2426323919135;4974.37820272466;4975.427825800007;4977;4992.301077849104;5002.799888004512;5611.663300201919;5787.363390027093;5901.409859014064;5930.970345148246;5957.731902064417;6278.0269058296035;6568.967155164193;7242.782716518513;7267.672954717051;7283.417326613858;1721.7245240761667;1743.171993303171;1744.345870298638;1750.7373893916015;1758.9648207035787;1095.2606990281529;1115.0800589513522;1128.1820680006929;1128.802459569572;1141.8801025892328;6740.191177058687;6769.356911093439;6788.558743681645;6799.354061364163;6804.761833335909;6083.756649733961;7533.171351151369;7533.849323013509;7538.946726575746;7550.282723141293;6754.324567543206;6772.153480814898;6784.864302714017;6785.287544807823;6793.898091528631;3833.9041523962123;3945.5659877413464;3982.2234664240773;3986.1828325193264;3988.3020471417385;6253.781117660951;7811.570363630055;7831.373490120776;7838.921610783933;7841.039740064984;7676.963609912702;7747.18654541265;7751.844963100706;7758.961205194051;7759.650815713307;7786.7663970080985;7799.220077992155;7802.492837965514;7808.102068262109;7823.061232652118;6049.425304596057;7225.530340527849;7472.140703818913;7514.549127052394;7516.661750221362;5766.654000759968;7081.398081163159;7342.48602597813;7349.118105827121;7359.595222262827;6484.5460817742305;7356.455144419518;7881.13307536182;7902.328302094386;7935.246151615587;4552.317152427162;4927.901441971212;4933.876653083702;4951.084049450863;4951.158303088411;6474.4820414365795;7174.708552460607;7549.811254718676;7560.735374261874;7572.053493313336;7081.752138675121;7282;7300.817479563053;7305.196428392979;7310.086239220098;7193.892091618525;7262.854742905218;7267.890981635174;7274.599897005503;7279.017332660235;7082.114735658043;7110.288971103055;7111.253318401494;7112.110986126734;7112.822179445348;7305.707771689073;7306.123265208209;7307.794213954638;7327.340539351484;7347;6774.86450270982;6985.057017302803;6994.720211191496;6997.545159564612;7142.5000249982 07:14:46 INFO - PROCESS | 1667 | |5;yui.html;679.9796006119817;750.3734381791204;751.5528260684893;753.5026882257707;765.4450523370557;14920.925395373008;14958.252087395627;15116.244187790622;15217.923910380447;15660.295286712097;14224.786628200585;14258.786118208236;14281.143131412122;14289.92855035726;14297.213653249068;746.0934964018716;758.3857075768617;899.9820003599924;915.7756349694334;934.9859752103724;913.2785099771173;941.8210539997378;943.2218419803655;947.469417126408;947.7062110745657;956.9043095690411;990.484947827133;991.1228562722007;992.2607657295289;993.3394292795282;780.6057940739919;955.8614000969856;961.8941916389192;964.8118616869713;967.796762679838;714.2036629158503;718.0736849464184;719.3669570777682;722.443718336883;730.550711312539;14755.114693118447;14777.7783333249;14789.704205915928;14799.926000370036;14800.703985920329;12601.18092323996;12710.491580336775;12743.132795121117;12865.871341286562;13150.473981040746;8474.491530508127;10079.596816127347;10167.59329626814;10284.97150284973;10299.330543514647;3356.077078803324;3444.2594842109065;3464.20323325634;3464.9480257796154;3546.042568506489;79787.00532486734;80128;80198.59900700518;83012;84094.57952710259;9359.344845860724;9486.33595648298;9508.90491095094;9950.303478756417;10074.798504029879;22106.22628208005;22120.778792211873;22141.557168856532;22141.778582214294;22163;7285.7814265572115;7341.045664063638;7630.656620452093;7650.41519690629;7730.342920851678;3801.9429708554394;3873.5158105236846;3887.6501114899793;3946.131850992777;4113.794310284534;3460.9480857787153;3494.143934736006;3514.964850351515;3520.436730123168;3528.68241858234;568.9857753556195;601.425638515217;613.7268915332724;621.3351713666334;623.8284471770208;517.7747679759317;524.8110680155141;544.5779520871356;563.4534501533506;611.1047315682457;7768.821900032463;7944.443888927835;8039.196080391914;8149.918500815034;8169.918300817035;589.5431040943304;593.1991811055127;610.188449362347;611.2939554814196;634.5177664974652;3212.6305474870687;3599.1002249437643;3711.981440092782;3863.2466668999837;3880.5925377835483;92244.53877730569;92418.53790731003;92915;93684.53157734168;93863;78701.60649196718;79169.45813792979;79655;81359.3728125446;82030.17969820344;69874.65062674654;70490.64754676193;70946;72093.63953180306;72908;7584.852286301123;7700.691972321044;7721.53670779755;7808.960955195188;7885.684572617031;40731;48726.756366217945;49137.26294105663;49857.75071124621;49909.25136122888;61375.69312153411;62725.74548508913;63817.361826381144;65612.67193664193;69893.60212795614;10986.890131098906;11069.5018724156;11218.66344009681;11361.488733006869;11366.715832103933;11888.643340699793;12055.51777928873;12124.211926224767;12272;12445.942094922033;11318.377489238172;11463.942680286546;11518.424078795859;11642.417879105842;11984.40077996114;11205.66383008511;11314.434278285888;11573.421328933688;12026.977706895012;12489;10911.399873007062;11171.66485005451;11210.327380357205;11315.038221751243;11490.712732181428;9310.162085412074;9342.719718408458;9540.236781057638;9588.316857362304;10044.88693385794;7661.770146895379;9204.677836275698;9310.348275620641;9457.647654705948;9569.760755981157 07:14:46 INFO - PROCESS | 1667 | __end_tp_report 07:14:46 INFO - PROCESS | 1667 | __start_cc_report 07:14:46 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1305 07:14:46 INFO - PROCESS | 1667 | __end_cc_report 07:14:46 INFO - PROCESS | 1667 | __startTimestamp1464012886651__endTimestamp 07:14:46 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | ------- Summary: start ------- 07:14:46 INFO - PROCESS | 1667 | Number of tests: 6 07:14:46 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5738.26 Median:5955.61 stddev:659.82 (11.1%) stddev-sans-first:610.85 07:14:46 INFO - PROCESS | 1667 | Values: 2495.7 3458.2 3471.6 3499.7 3538.9 5669.3 5683.7 5689.3 5700.6 5719.0 5681.9 5734.8 5741.7 5742.7 5746.5 5097.0 5137.3 5196.7 5240.8 5246.5 5208.9 5213.9 5216.3 5234.3 5236.6 5116.4 5159.0 5172.6 5173.2 5211.9 5191.6 5277.1 5278.7 5283.3 5336.4 5067.3 5101.8 5127.1 5165.9 5196.2 4832.7 5537.2 5592.5 5631.9 5690.1 6202.4 6203.3 6209.7 6214.6 6217.2 5272.7 6138.7 6233.5 6291.7 6323.0 5759.6 5806.0 5813.1 5819.9 5840.1 6010.4 6367.4 6378.7 6379.9 6382.6 6033.6 6049.5 6059.7 6091.3 6137.8 6172.7 6181.7 6222.1 6245.6 6253.5 6247.8 6260.2 6276.2 6293.1 6299.7 5248.4 6227.7 6278.6 6282.7 6292.5 4857.2 4906.1 4928.3 4967.5 4986.6 4452.5 4457.2 4472.9 4488.7 4496.1 5747.8 5749.9 5750.5 5773.4 5778.0 6161.1 6221.3 6302.3 6302.5 6304.1 5723.6 5728.9 5735.1 5735.6 5742.4 5377.2 5381.9 5387.6 5396.9 5410.3 6279.5 6301.0 6368.2 6370.7 6375.4 6292.2 6304.0 6305.0 6328.8 6337.6 6348.7 6353.9 6379.7 6382.0 6385.5 6071.6 6139.8 6227.0 6242.4 6255.8 6262.2 6274.4 6275.2 6289.2 6290.4 5902.2 5946.6 6135.6 6139.9 6149.1 6050.6 6122.5 6132.5 6146.0 6150.6 5955.6 5956.9 5965.9 5972.4 5977.6 5958.5 6114.7 6127.5 6140.4 6150.4 5810.0 5908.2 5943.1 6010.5 6018.0 07:14:46 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:64169.57 Median:368060.50 stddev:133670.19 (36.3%) stddev-sans-first:133959.73 07:14:46 INFO - PROCESS | 1667 | Values: 513.9 516.8 565.9 604.0 624.8 26235.6 31349.1 38536.8 39712.4 39754.6 41965.6 42394.9 42441.8 42471.6 42699.6 9450.9 9668.3 9675.3 9681.8 9684.3 8667.6 8712.2 8717.5 8724.9 8731.3 11619.0 11834.0 11852.8 11854.6 11884.5 11512.5 11529.1 11535.7 11557.1 11559.5 8631.9 11417.1 11525.6 11547.6 11765.6 39104.6 39348.0 39351.0 39408.8 39537.6 3172.7 3175.8 3223.1 3318.3 3359.6 26999.2 27793.6 28191.7 28499.7 28529.7 2746.4 2770.5 2789.2 2802.9 2819.8 447617.0 449535.0 450328.0 451162.7 451275.0 64245.4 64800.7 64805.0 64828.7 64881.0 67852.3 67987.0 68016.3 68124.0 68176.3 17377.3 17947.4 17951.3 17951.5 18004.4 13755.8 13868.8 13874.9 13877.7 13879.8 15340.8 17582.8 17714.6 17997.0 18144.9 6782.1 6871.8 6911.3 6949.3 7012.1 930.1 971.1 1027.8 1034.8 1101.2 28912.7 29138.8 29468.6 29537.7 29695.4 1127.3 1191.5 1200.8 1202.5 1231.1 15340.2 15406.2 15469.0 15654.9 15707.0 598450.0 607732.0 609110.0 609879.0 611441.0 60088.4 61675.7 61718.7 61842.4 61973.1 1361.2 1436.7 1511.6 1528.9 1589.4 28492.3 29048.0 29175.6 29816.6 29978.0 48842.0 48972.3 49332.8 49430.0 49486.0 364479.0 367501.2 367773.0 368348.0 614122.0 40401.0 41089.0 41490.8 41633.0 42391.4 42891.0 43119.8 44414.0 44646.6 44740.1 33666.7 37890.0 38064.2 39296.2 40169.0 36116.9 36174.0 36335.9 37440.8 38231.0 37169.6 37303.1 37338.9 37578.0 38096.6 32158.4 33251.3 33396.7 33405.2 33484.5 21182.8 24665.0 24936.3 25233.9 25537.6 07:14:46 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:35538.66 Median:20661.04 stddev:104307.27 (504.9%) stddev-sans-first:104566.47 07:14:46 INFO - PROCESS | 1667 | Values: 378.6 399.1 399.3 404.7 413.0 15137.5 17036.7 18116.4 20636.1 20686.0 14394.5 16439.8 19744.9 20261.0 20277.6 5619.0 5770.7 5955.5 5961.4 5964.8 4177.0 5899.0 5977.9 5998.8 6006.4 6212.9 6512.2 6518.7 6523.2 6524.1 5821.2 6191.5 6475.7 6492.2 6497.7 5941.3 5970.6 5978.9 5981.5 5999.6 13247.8 16143.4 22780.9 25064.5 25991.9 2111.5 2184.4 2349.4 2454.9 2484.7 9700.0 9975.7 10003.4 10279.6 13450.7 1501.9 1730.1 1789.9 1802.2 1835.7 106911.5 118221.0 119122.0 121432.0 121697.4 11582.3 11602.7 11657.1 11692.5 11879.1 14971.5 15105.6 15145.0 15177.2 15186.4 7953.5 8282.0 8567.8 8804.2 8926.4 8278.2 8831.3 8834.6 8874.6 8943.1 4090.5 4227.6 4229.5 4601.7 4657.5 1665.9 1741.7 1754.9 1859.2 1866.7 812.9 953.2 993.6 1016.5 1053.7 17932.5 18975.9 19213.6 19371.0 19487.5 954.3 977.5 980.3 1016.7 1060.7 10456.6 10534.0 10601.5 10620.2 10652.5 612412.0 615024.0 632318.0 635823.8 638030.0 106661.0 113198.4 124789.0 127842.4 138321.0 1021.2 1048.6 1060.4 1061.9 1064.4 17958.6 18107.0 18115.5 18420.4 18756.9 55623.7 55808.7 56215.0 57058.7 57959.0 74833.0 76105.6 81861.2 83781.6 84325.6 7961.8 8008.8 8225.3 8229.1 8558.8 9432.6 12379.8 12439.8 12771.4 12853.7 10815.6 10896.2 11058.4 11171.4 11362.0 10529.9 10621.5 10871.6 10983.6 10987.9 11143.8 11399.3 11417.9 11481.9 11555.5 8216.9 8314.0 8319.7 8487.9 8641.4 9633.7 10837.9 11206.0 11372.6 11545.5 07:14:46 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5581.43 Median:4865.37 stddev:3092.69 (63.6%) stddev-sans-first:3084.59 07:14:46 INFO - PROCESS | 1667 | Values: 1295.3 1444.5 1587.5 1776.9 1955.3 7777.8 8337.2 8471.9 8478.2 8487.2 8361.8 8592.3 8592.9 8685.9 8831.4 2410.4 2441.0 2442.0 2447.0 2448.2 2395.0 2424.1 2445.8 2447.2 2448.3 2395.3 2429.4 2439.9 2442.2 2448.2 2391.8 2412.5 2431.2 2431.3 2431.9 2312.5 2410.0 2410.0 2412.5 2416.1 7602.5 7811.6 8562.0 8601.4 8608.5 5105.6 5237.6 5244.9 5246.6 5280.2 3463.8 3489.4 3560.3 3573.6 3587.4 886.2 1029.9 1047.7 1057.5 1057.9 11314.9 11487.8 11518.3 11730.9 11766.4 4727.2 4786.2 4792.9 4812.0 4832.5 10032.0 10133.1 10150.0 10161.2 10349.6 5379.7 5381.0 5423.9 5428.6 5438.2 4762.2 4860.0 4867.4 4879.8 4933.0 3837.4 3942.0 3948.2 3991.1 4014.4 1272.4 1293.2 1295.9 1308.5 1312.6 775.4 879.5 909.9 917.7 924.3 4966.5 4995.0 5590.0 5650.3 5959.3 978.1 988.3 999.0 1007.6 1008.9 3741.6 3816.0 3860.6 3876.1 3907.8 10222.7 10426.6 10558.1 10655.7 10675.9 10187.0 10420.8 10423.9 10526.4 10542.2 8116.6 8276.0 8333.8 8359.7 8400.0 5382.5 5448.8 5509.3 5629.7 5654.5 7639.5 9075.9 9549.7 9561.6 9587.0 9301.1 9672.0 9880.4 9903.6 9917.4 5892.9 7303.9 7309.7 7315.9 7317.7 7968.5 8101.4 8117.5 8124.2 8148.6 7129.0 7173.4 7332.6 7344.2 7351.6 6122.9 7144.6 7230.9 7234.5 7317.6 6713.9 6714.6 6759.6 6771.6 6779.6 3941.6 4459.4 4715.9 4718.9 4863.3 4646.6 4779.0 4829.7 4895.2 5036.9 07:14:46 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5900.88 Median:6697.70 stddev:1853.93 (27.7%) stddev-sans-first:1810.89 07:14:46 INFO - PROCESS | 1667 | Values: 302.8 319.8 327.8 332.2 334.5 6699.5 6707.6 6709.7 6763.8 6777.9 6489.2 6695.9 6749.7 6801.2 6805.8 4029.6 4980.7 5022.1 5025.3 5025.6 5013.6 5033.8 5035.1 5045.1 5056.5 4973.5 4978.0 4985.9 5012.4 5032.1 5027.0 5027.8 5035.4 5049.9 5060.4 3811.3 3865.2 4300.4 4344.0 4361.1 6448.6 6469.9 6480.4 6481.0 6504.2 5955.0 5984.7 6000.4 6002.6 6011.5 5811.3 7227.7 7233.6 7234.9 7236.3 4830.6 4837.0 4843.7 4850.9 4855.3 7202.8 7282.2 7453.2 7507.3 7557.3 4820.7 4835.1 4881.0 4883.6 4886.2 4974.4 4975.4 4977.0 4992.3 5002.8 5611.7 5787.4 5901.4 5931.0 5957.7 6278.0 6569.0 7242.8 7267.7 7283.4 1721.7 1743.2 1744.3 1750.7 1759.0 1095.3 1115.1 1128.2 1128.8 1141.9 6740.2 6769.4 6788.6 6799.4 6804.8 6083.8 7533.2 7533.8 7538.9 7550.3 6754.3 6772.2 6784.9 6785.3 6793.9 3833.9 3945.6 3982.2 3986.2 3988.3 6253.8 7811.6 7831.4 7838.9 7841.0 7677.0 7747.2 7751.8 7759.0 7759.7 7786.8 7799.2 7802.5 7808.1 7823.1 6049.4 7225.5 7472.1 7514.5 7516.7 5766.7 7081.4 7342.5 7349.1 7359.6 6484.5 7356.5 7881.1 7902.3 7935.2 4552.3 4927.9 4933.9 4951.1 4951.2 6474.5 7174.7 7549.8 7560.7 7572.1 7081.8 7282.0 7300.8 7305.2 7310.1 7193.9 7262.9 7267.9 7274.6 7279.0 7082.1 7110.3 7111.3 7112.1 7112.8 7305.7 7306.1 7307.8 7327.3 7347.0 6774.9 6985.1 6994.7 6997.5 7142.5 07:14:46 INFO - PROCESS | 1667 | 07:14:46 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18284.07 Median:611.20 stddev:25797.98 (4220.9%) stddev-sans-first:25836.48 07:14:46 INFO - PROCESS | 1667 | Values: 680.0 750.4 751.6 753.5 765.4 14920.9 14958.3 15116.2 15217.9 15660.3 14224.8 14258.8 14281.1 14289.9 14297.2 746.1 758.4 900.0 915.8 935.0 913.3 941.8 943.2 947.5 947.7 956.9 990.5 991.1 992.3 993.3 780.6 955.9 961.9 964.8 967.8 714.2 718.1 719.4 722.4 730.6 14755.1 14777.8 14789.7 14799.9 14800.7 12601.2 12710.5 12743.1 12865.9 13150.5 8474.5 10079.6 10167.6 10285.0 10299.3 3356.1 3444.3 3464.2 3464.9 3546.0 79787.0 80128.0 80198.6 83012.0 84094.6 9359.3 9486.3 9508.9 9950.3 10074.8 22106.2 22120.8 22141.6 22141.8 22163.0 7285.8 7341.0 7630.7 7650.4 7730.3 3801.9 3873.5 3887.7 3946.1 4113.8 3460.9 3494.1 3515.0 3520.4 3528.7 569.0 601.4 613.7 621.3 623.8 517.8 524.8 544.6 563.5 611.1 7768.8 7944.4 8039.2 8149.9 8169.9 589.5 593.2 610.2 611.3 634.5 3212.6 3599.1 3712.0 3863.2 3880.6 92244.5 92418.5 92915.0 93684.5 93863.0 78701.6 79169.5 79655.0 81359.4 82030.2 69874.7 70490.6 70946.0 72093.6 72908.0 7584.9 7700.7 7721.5 7809.0 7885.7 40731.0 48726.8 49137.3 49857.8 49909.3 61375.7 62725.7 63817.4 65612.7 69893.6 10986.9 11069.5 11218.7 11361.5 11366.7 11888.6 12055.5 12124.2 12272.0 12445.9 11318.4 11463.9 11518.4 11642.4 11984.4 11205.7 11314.4 11573.4 12027.0 12489.0 10911.4 11171.7 11210.3 11315.0 11490.7 9310.2 9342.7 9540.2 9588.3 10044.9 7661.8 9204.7 9310.3 9457.6 9569.8 07:14:46 INFO - PROCESS | 1667 | -------- Summary: end -------- 07:14:46 INFO - PROCESS | 1667 | 07:14:47 INFO - TEST-INFO | 1667: exit 0 07:14:47 INFO - TEST-OK | dromaeo_css | took 1114667ms 07:14:47 INFO - TEST-START | kraken 07:14:47 INFO - operating with platform_type : mac_ 07:14:47 INFO - Initialising browser for kraken test... 07:14:47 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpe7PRsM/profile http://localhost:49270/getInfo.html) 07:14:49 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 07:14:49 INFO - PROCESS | 1675 | colorDepth:24 07:14:49 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 07:14:49 INFO - PROCESS | 1675 | __metrics 07:14:49 INFO - PROCESS | 1675 | 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" 07:14:49 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:14:49 INFO - TEST-INFO | 1675: exit 0 07:14:49 INFO - Browser initialized. 07:14:49 INFO - Running cycle 1/1 for kraken test... 07:14:49 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpe7PRsM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:01 INFO - PROCESS | 1677 | RSS: Main: 210853888 07:15:01 INFO - PROCESS | 1677 | 07:15:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:05 INFO - PROCESS | 1677 | RSS: Main: 272371712 07:15:05 INFO - PROCESS | 1677 | 07:15:08 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 07:15:08 INFO - PROCESS | 1677 | RSS: Main: 285782016 07:15:08 INFO - PROCESS | 1677 | 07:15:11 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 07:15:12 INFO - PROCESS | 1677 | RSS: Main: 372080640 07:15:12 INFO - PROCESS | 1677 | 07:15:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 07:15:15 INFO - PROCESS | 1677 | RSS: Main: 278716416 07:15:15 INFO - PROCESS | 1677 | 07:15:17 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:17 INFO - PROCESS | 1677 | RSS: Main: 279658496 07:15:17 INFO - PROCESS | 1677 | 07:15:20 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:21 INFO - PROCESS | 1677 | RSS: Main: 320081920 07:15:21 INFO - PROCESS | 1677 | 07:15:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:24 INFO - PROCESS | 1677 | RSS: Main: 318988288 07:15:24 INFO - PROCESS | 1677 | 07:15:27 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 07:15:27 INFO - PROCESS | 1677 | RSS: Main: 317386752 07:15:27 INFO - PROCESS | 1677 | 07:15:29 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:30 INFO - PROCESS | 1677 | RSS: Main: 309096448 07:15:30 INFO - PROCESS | 1677 | 07:15:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:32 INFO - PROCESS | 1677 | RSS: Main: 315772928 07:15:32 INFO - PROCESS | 1677 | 07:15:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:35 INFO - PROCESS | 1677 | RSS: Main: 318803968 07:15:35 INFO - PROCESS | 1677 | 07:15:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:38 INFO - PROCESS | 1677 | RSS: Main: 323805184 07:15:38 INFO - PROCESS | 1677 | 07:15:41 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:42 INFO - PROCESS | 1677 | RSS: Main: 321892352 07:15:42 INFO - PROCESS | 1677 | 07:15:43 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 07:15:44 INFO - PROCESS | 1677 | RSS: Main: 386007040 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | __start_tp_report 07:15:44 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 07:15:44 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 07:15:44 INFO - PROCESS | 1677 | |i|pagename|runs| 07:15:44 INFO - PROCESS | 1677 | |0;ai-astar;113;113;120;115;112;112;115;114;115;134 07:15:44 INFO - PROCESS | 1677 | |1;audio-beat-detection;155;123;146;164;118;139;138;118;168;119 07:15:44 INFO - PROCESS | 1677 | |2;audio-dft;184;183;184;182;186;183;184;185;185;185 07:15:44 INFO - PROCESS | 1677 | |3;audio-fft;70;79;76;152;56;56;56;64;132;57 07:15:44 INFO - PROCESS | 1677 | |4;audio-oscillator;89;88;146;76;82;85;127;80;77;127 07:15:44 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;85;89;88;88;84;91;85;87;83 07:15:44 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;93;94;93;92;93;93;93;92;93 07:15:44 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;86;84;85;84;86;85;86;86;85 07:15:44 INFO - PROCESS | 1677 | |8;json-parse-financial;58;63;65;64;65;63;66;81;57;57 07:15:44 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;63;67;73;77;75;73;68;69;68;69 07:15:44 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;82;81;82;81;79;80;78;80;81;84 07:15:44 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;129;131;128;127;126;125;126;125;135;131 07:15:44 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;166;166;223;174;167;164;163;168;165;162 07:15:44 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;69;67;66;67;69;67;67;67;68;69 07:15:44 INFO - PROCESS | 1677 | __end_tp_report 07:15:44 INFO - PROCESS | 1677 | __start_cc_report 07:15:44 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,2023 07:15:44 INFO - PROCESS | 1677 | __end_cc_report 07:15:44 INFO - PROCESS | 1677 | __startTimestamp1464012944185__endTimestamp 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | ------- Summary: start ------- 07:15:44 INFO - PROCESS | 1677 | Number of tests: 14 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:116.30 Median:115.00 stddev:6.63 (5.8%) stddev-sans-first:6.93 07:15:44 INFO - PROCESS | 1677 | Values: 113.0 113.0 120.0 115.0 112.0 112.0 115.0 114.0 115.0 134.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:142.50 stddev:19.18 (13.5%) stddev-sans-first:19.42 07:15:44 INFO - PROCESS | 1677 | Values: 155.0 123.0 146.0 164.0 118.0 139.0 138.0 118.0 168.0 119.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.20 (0.6%) stddev-sans-first:1.27 07:15:44 INFO - PROCESS | 1677 | Values: 184.0 183.0 184.0 182.0 186.0 183.0 184.0 185.0 185.0 185.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:79.80 Median:60.50 stddev:34.19 (56.5%) stddev-sans-first:36.07 07:15:44 INFO - PROCESS | 1677 | Values: 70.0 79.0 76.0 152.0 56.0 56.0 56.0 64.0 132.0 57.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:81.00 stddev:25.47 (31.4%) stddev-sans-first:26.82 07:15:44 INFO - PROCESS | 1677 | Values: 89.0 88.0 146.0 76.0 82.0 85.0 127.0 80.0 77.0 127.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:88.00 stddev:2.49 (2.8%) stddev-sans-first:2.60 07:15:44 INFO - PROCESS | 1677 | Values: 88.0 85.0 89.0 88.0 88.0 84.0 91.0 85.0 87.0 83.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:15:44 INFO - PROCESS | 1677 | Values: 93.0 93.0 94.0 93.0 92.0 93.0 93.0 93.0 92.0 93.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:0.79 (0.9%) stddev-sans-first:0.83 07:15:44 INFO - PROCESS | 1677 | Values: 85.0 86.0 84.0 85.0 84.0 86.0 85.0 86.0 86.0 85.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.50 stddev:6.92 (10.7%) stddev-sans-first:7.00 07:15:44 INFO - PROCESS | 1677 | Values: 58.0 63.0 65.0 64.0 65.0 63.0 66.0 81.0 57.0 57.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:71.00 stddev:4.21 (5.9%) stddev-sans-first:3.57 07:15:44 INFO - PROCESS | 1677 | Values: 63.0 67.0 73.0 77.0 75.0 73.0 68.0 69.0 68.0 69.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:1.69 (2.1%) stddev-sans-first:1.73 07:15:44 INFO - PROCESS | 1677 | Values: 82.0 81.0 82.0 81.0 79.0 80.0 78.0 80.0 81.0 84.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:128.50 stddev:3.23 (2.5%) stddev-sans-first:3.42 07:15:44 INFO - PROCESS | 1677 | Values: 129.0 131.0 128.0 127.0 126.0 125.0 126.0 125.0 135.0 131.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:166.50 stddev:18.29 (11.0%) stddev-sans-first:19.28 07:15:44 INFO - PROCESS | 1677 | Values: 166.0 166.0 223.0 174.0 167.0 164.0 163.0 168.0 165.0 162.0 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:1.01 07:15:44 INFO - PROCESS | 1677 | Values: 69.0 67.0 66.0 67.0 69.0 67.0 67.0 67.0 68.0 69.0 07:15:44 INFO - PROCESS | 1677 | -------- Summary: end -------- 07:15:44 INFO - PROCESS | 1677 | 07:15:44 INFO - TEST-INFO | 1677: exit 0 07:15:44 INFO - TEST-OK | kraken | took 57731ms 07:15:44 INFO - SUITE-END | took 1172s 07:15:45 INFO - Completed test suite (00:19:32) 07:15:45 INFO - javascript benchmark 07:15:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2495.6506089147515, 3458.2391873787756, 3471.6181220065796, 3499.7025252853505, 3538.8761393351238, 5669.262995810544, 5683.715814209294, 5689.345725241598, 5700.629459085162, 5719.027765279902, 5681.886362272752, 5734.770609175638, 5741.741621627027, 5742.655440673562, 5746.48281654651, 5097.0, 5137.332146820908, 5196.688198708071, 5240.764165612557, 5246.5278124968745, 5208.895822083556, 5213.869653258661, 5216.321878155834, 5234.26720259164, 5236.581073514129, 5116.411612664536, 5158.974205128988, 5172.612054095939, 5173.224016397533, 5211.895762084756, 5191.63658543904, 5277.102892508283, 5278.683279003272, 5283.260343551906, 5336.439673834269, 5067.290579318861, 5101.846944591668, 5127.102757017507, 5165.870853228662, 5196.168613021936, 4832.73419961902, 5537.197106419587, 5592.5246354059955, 5631.943680563224, 5690.089585666315, 6202.3797620238065, 6203.2866220384785, 6209.658468784215, 6214.5960512566535, 6217.222847144107, 5272.6836389816735, 6138.664296166084, 6233.501319894398, 6291.6854157291955, 6323.019931910561, 5759.596828222068, 5805.970970145122, 5813.128030795415, 5819.912701309526, 5840.094785308284, 6010.429009244115, 6367.395097465734, 6378.74485020594, 6379.936200638027, 6382.6170429774365, 6033.576344075336, 6049.455549000611, 6059.697015149225, 6091.329953705089, 6137.754489820357, 6172.722227499773, 6181.690915454209, 6222.066689996536, 6245.594036387621, 6253.46845518127, 6247.812565623039, 6260.154879091356, 6276.215473065867, 6293.056041593706, 6299.716512756937, 5248.396434410015, 6227.657478838617, 6278.623282603058, 6282.748690052346, 6292.46514046302, 4857.198562237191, 4906.092372910952, 4928.28539861718, 4967.5032496750755, 4986.601071914238, 4452.487963884195, 4457.2199865023495, 4472.865814025585, 4488.663350248745, 4496.100779844044, 5747.798827041033, 5749.85625359361, 5750.482456578928, 5773.422657734193, 5777.971110144423, 6161.137440758297, 6221.2845522765465, 6302.338254483305, 6302.527310451735, 6304.05439184126, 5723.627964182315, 5728.856778580569, 5735.082386818172, 5735.569832262597, 5742.425757424224, 5377.220303056113, 5381.892362152813, 5387.595930305243, 5396.865078372994, 5410.323709536308, 6279.497640188774, 6300.960341543594, 6368.235811702625, 6370.713317900613, 6375.4262116409745, 6292.2134733158355, 6304.0, 6305.0, 6328.778492752732, 6337.588056776295, 6348.682565871781, 6353.936460635335, 6379.712912918837, 6381.968090159519, 6385.521085918482, 6071.574989750852, 6139.798803208881, 6227.0, 6242.375762423721, 6255.812325630239, 6262.2172228471445, 6274.403931626488, 6275.215598050244, 6289.213848268966, 6290.433860952537, 5902.203202567598, 5946.643201407929, 6135.601185922901, 6139.877202456015, 6149.0776383542825, 6050.606710563799, 6122.4896795164905, 6132.477886260695, 6146.0473626587955, 6150.600210986271, 5955.612885162451, 5956.910646340221, 5965.880682386415, 5972.372900845348, 5977.581569290108, 5958.523318134452, 6114.7248373822395, 6127.479164271087, 6140.355262697352, 6150.415710507674, 5810.0, 5908.172855800278, 5943.108533719977, 6010.459058684739, 6017.969910150421], "value": 5695.082740465587, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.946035666255, 516.8268630008947, 565.8528782516545, 604.0214851939858, 624.7629693207449, 26235.606465903, 31349.059528214133, 38536.80731596345, 39712.41150353982, 39754.60245397545, 41965.58034419655, 42394.940126496855, 42441.78779106108, 42471.57528424715, 42699.57300426995, 9450.905490945072, 9668.274879384038, 9675.27435442341, 9681.806363872754, 9684.322097453181, 8667.566621668922, 8712.172343627346, 8717.520536370497, 8724.8691269631, 8731.34514911381, 11618.954294113528, 11833.994110500618, 11852.822207666892, 11854.585089521868, 11884.465199066062, 11512.539498420054, 11529.077673786078, 11535.653930382103, 11557.133215008824, 11559.537618495335, 8631.913680863174, 11417.143714221467, 11525.596604118899, 11547.595834145848, 11765.58820441289, 39104.60895391038, 39348.0, 39351.0, 39408.81773546798, 39537.61618343344, 3172.7144556989983, 3175.841207939594, 3223.1458663454205, 3318.303156337172, 3359.5968483781858, 26999.190024299303, 27793.583096253573, 28191.718082819116, 28499.715002849913, 28529.714702852914, 2746.436980419009, 2770.501309764242, 2789.191134570972, 2802.9159125226074, 2819.84490853003, 447617.0, 449535.0, 450328.0, 451162.744186277, 451275.0, 64245.35754642394, 64800.67599661971, 64805.02792458117, 64828.67585662136, 64881.0, 67852.32147678558, 67987.0, 68016.319836801, 68124.0, 68176.31823681798, 17377.304907803547, 17947.371841985467, 17951.281948722168, 17951.461456156074, 18004.36984705529, 13755.79366309506, 13868.791968120486, 13874.93062534681, 13877.722445551235, 13879.791803122962, 15340.846591534166, 17582.824171758373, 17714.5571360717, 17997.0, 18144.909275453538, 6782.084418603426, 6871.793846184622, 6911.308869113049, 6949.270326615733, 7012.123484564429, 930.06993006993, 971.1308379000754, 1027.7995790820867, 1034.7723500829804, 1101.1631160318057, 28912.710872891003, 29138.8344466219, 29468.557971630442, 29537.704622953926, 29695.406091878474, 1127.301073334538, 1191.523390643732, 1200.7778560966249, 1202.5310129049678, 1231.07054174098, 15340.232988350537, 15406.152661603719, 15469.0, 15654.9217253913, 15707.0, 598450.0, 607732.0, 609110.0, 609879.0, 611441.0, 60088.399116009154, 61675.691621541606, 61718.69140654268, 61842.38157618366, 61973.07040394397, 1361.1832900259765, 1436.7485690004207, 1511.5692027772252, 1528.8853335999622, 1589.4436947068664, 28492.287692807844, 29048.0, 29175.562366564092, 29816.552751709176, 29978.0, 48842.0, 48972.265416018075, 49332.75333623309, 49430.0, 49486.0, 364479.0, 367501.16249418585, 367773.0, 368348.0, 614122.0, 40401.0, 41089.0, 41490.792546037075, 41633.0, 42391.36412953746, 42891.0, 43119.78440107779, 44414.0, 44646.55353446424, 44740.10519789521, 33666.66333336733, 37890.0, 38064.23871522609, 39296.214075717755, 40168.995775105854, 36116.91649250527, 36174.0, 36335.90961078638, 37440.812795935846, 38231.0, 37169.628303716614, 37303.067423314635, 37338.8789898703, 37578.0, 38096.61903380931, 32158.356832862744, 33251.33497330088, 33396.66603334033, 33405.16487087842, 33484.49773253452, 21182.788172118697, 24665.0, 24936.25191244193, 25233.934498340495, 25537.616935745606], "value": 20131.77960979547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.64974898219174, 399.1458279282335, 399.3271337795815, 404.66412877311836, 412.9896752581185, 15137.470188543402, 17036.744448833277, 18116.36592719255, 20636.071376788044, 20686.0, 14394.49619263326, 16439.753403698924, 19744.901275493638, 20260.986950652445, 20277.594448111027, 5619.0, 5770.672745268591, 5955.52355811534, 5961.433663801932, 5964.79123230687, 4177.0, 5899.0266606009955, 5977.85055373617, 5998.790042348497, 6006.369331220225, 6212.9068063979075, 6512.185976752906, 6518.739250429977, 6523.249826269992, 6524.0540121682325, 5821.2141360916585, 6191.473724733403, 6475.740970361227, 6492.188476440445, 6497.707603157845, 5941.257342832146, 5970.641761494324, 5978.940210597882, 5981.491573216282, 5999.610025348338, 13247.801282980763, 16143.354265829354, 22780.886095569414, 25064.49871002588, 25991.870040649865, 2111.546017606222, 2184.388371256051, 2349.424391024193, 2454.9263522094366, 2484.6521486991837, 9699.981501942266, 9975.700728978143, 10003.399796012263, 10279.588816447333, 13450.663733406645, 1501.8573235542606, 1730.0917018565353, 1789.9463016109537, 1802.152988095593, 1835.6604028254815, 106911.46544267228, 118221.0, 119121.99999999913, 121432.0, 121697.39151304275, 11582.305061696325, 11602.70993225176, 11657.067434605211, 11692.47383867728, 11879.109066820023, 14971.475998340005, 15105.622359440882, 15145.0, 15177.165255911032, 15186.392544298325, 7953.5227886327, 8282.0, 8567.785805354915, 8804.163604457566, 8926.419782714103, 8278.213569710868, 8831.293496520262, 8834.646614135363, 8874.556272186364, 8943.105689431004, 4090.52741013235, 4227.6406505447385, 4229.513605935295, 4601.67788254819, 4657.510961349078, 1665.9416920407728, 1741.6957422063188, 1754.929802807899, 1859.1912518054419, 1866.6546688862604, 812.9390295727726, 953.2326477185793, 993.5926270229171, 1016.537475448669, 1053.7154968158707, 17932.462026139237, 18975.90512047431, 19213.615727685647, 19371.031448427522, 19487.530639991302, 954.2890546542732, 977.4575110813424, 980.3186785184371, 1016.6630880392261, 1060.660588611637, 10456.63401780934, 10533.999270069331, 10601.522931468102, 10620.150387968944, 10652.520636571373, 612412.0, 615024.0, 632318.0, 635823.8208809019, 638030.0, 106661.0, 113198.43400782943, 124789.0, 127842.36078819547, 138321.0, 1021.1779517488493, 1048.580567772897, 1060.3584831177182, 1061.9415932123652, 1064.4411683866188, 17958.640827183644, 18107.004114773816, 18115.456536303933, 18420.35528756487, 18756.906215468836, 55623.72188139033, 55808.72095639658, 56215.0, 57058.7147064262, 57959.0, 74833.0, 76105.61947190229, 81861.18138818536, 83781.58109209414, 84325.5783721102, 7961.800954976172, 8008.83982320362, 8225.341972642294, 8229.094799572162, 8558.82882342362, 9432.622695092394, 12379.814302785286, 12439.751204976032, 12771.36143192818, 12853.678658033625, 10815.621453249098, 10896.182786291218, 11058.391788451712, 11171.441427928734, 11361.977422032056, 10529.894701052892, 10621.522031508446, 10871.635332066886, 10983.560657573607, 10987.945060274647, 11143.83284250753, 11399.316041037564, 11417.885821142014, 11481.94259028733, 11555.4800033997, 8216.917830821616, 8314.0, 8319.667213311643, 8487.8726819099, 8641.351898607503, 9633.662821801203, 10837.945810270898, 11206.0, 11372.601958931398, 11545.480453379787], "value": 9533.73172781301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.2811189789668, 1444.5449683349736, 1587.515807678658, 1776.8578513718903, 1955.3254127326077, 7777.766666999985, 8337.2079652433, 8471.872921906177, 8478.194571515696, 8487.193716596928, 8361.83276334473, 8592.312614990802, 8592.8711069334, 8685.91314086859, 8831.425957312771, 2410.3733029412347, 2441.0357908626083, 2441.951160976779, 2447.0334217983973, 2448.2288079254977, 2394.976050239493, 2424.1151979527435, 2445.8043356531434, 2447.21689059501, 2448.2655203438985, 2395.281415575329, 2429.380507970474, 2439.902403903842, 2442.218490083174, 2448.20433359159, 2391.8325717199805, 2412.5054363855456, 2431.185552839801, 2431.258466167818, 2431.914882979096, 2312.5259321838985, 2409.975900240993, 2410.0, 2412.481316516957, 2416.1060407649106, 7602.467827252094, 7811.648475818602, 8562.0, 8601.354898382584, 8608.52653104079, 5105.591552675777, 5237.607179461517, 5244.8688782780355, 5246.632735708502, 5280.1815718563685, 3463.8441270142903, 3489.4068008438626, 3560.2701446203464, 3573.6247693992277, 3587.4260118381194, 886.2112719679491, 1029.9494515594051, 1047.7328281288299, 1057.5082586597268, 1057.8677665291839, 11314.943425282821, 11487.770244595062, 11518.251313664585, 11730.882691173065, 11766.411679415995, 4727.2436410174205, 4786.1863483207935, 4792.9281060784115, 4811.9518804812205, 4832.4684284728655, 10032.046955539357, 10133.08802207805, 10149.98500149994, 10161.237907156992, 10349.63776267827, 5379.704116273642, 5381.0, 5423.891522169534, 5428.647137936022, 5438.211459338374, 4762.190427627243, 4859.975700121548, 4867.440244371872, 4879.804807807719, 4933.0380575788095, 3837.4435706822355, 3942.0342016206214, 3948.230095131479, 3991.1219531702977, 4014.437978682987, 1272.3511009385095, 1293.230527835936, 1295.902807289457, 1308.5289295853486, 1312.6127792301295, 775.4106878772174, 879.4898958603994, 909.9226565741986, 917.6971599372191, 924.2744445610164, 4966.503349665005, 4994.950050499521, 5590.021746194481, 5650.308674270165, 5959.314678811906, 978.1490103609905, 988.2884323287221, 999.0, 1007.561710655867, 1008.8789345278614, 3741.6258374162367, 3815.9618403815607, 3860.6332398422664, 3876.089119057019, 3907.78507182102, 10222.693319200436, 10426.635067772591, 10558.102561282223, 10655.73360665974, 10675.946620266848, 10187.0, 10420.801607815047, 10423.947880260703, 10526.368417894952, 10542.209334299958, 8116.553589552631, 8276.048254450694, 8333.8333233335, 8359.749207523784, 8400.033996090528, 5382.4886635769535, 5448.754806033818, 5509.311336082989, 5629.662220266797, 5654.46282603152, 7639.465237433326, 9075.863862041942, 9549.665761698307, 9561.569729362056, 9587.041295870637, 9301.116393942564, 9671.951640242036, 9880.35777674449, 9903.55434005486, 9917.355371900803, 5892.882142357043, 7303.890441643486, 7309.720798860072, 7315.890261645973, 7317.743878964211, 7968.482048666818, 8101.432899696964, 8117.472364296302, 8124.22819832115, 8148.592570371339, 7128.964355178191, 7173.390261827803, 7332.560046397233, 7344.155422126524, 7351.558906465629, 6122.938770612237, 7144.64276786169, 7230.879213721882, 7234.529755565872, 7317.5609463432365, 6713.865722685421, 6714.597124172566, 6759.5606285591275, 6771.559848609824, 6779.559328643622, 3941.566427693009, 4459.3979812724865, 4715.858524244278, 4718.858434246841, 4863.294822250825, 4646.605038571624, 4778.952210477851, 4829.66192366531, 4895.241237608177, 5036.899262014813], "value": 4523.146705290562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.83949506761394, 319.7617774757805, 327.75254682714547, 332.1563229397328, 334.54167790127514, 6699.531032827704, 6707.631080290582, 6709.698063587138, 6763.830904227397, 6777.864442711143, 6489.1888513935755, 6695.866082678343, 6749.662516874149, 6801.183857937042, 6805.761798337059, 4029.597040295976, 4980.701157930518, 5022.146235140035, 5025.296458495814, 5025.623078269126, 5013.573846223076, 5033.823816166435, 5035.093683137034, 5045.142325804622, 5056.544910958013, 4973.502649735034, 4978.0, 4985.900281994358, 5012.373453318335, 5032.11937910866, 5027.014329339909, 5027.773750181214, 5035.370578677665, 5049.873753156164, 5060.367454068241, 3811.33301672209, 3865.207632435372, 4300.35494675798, 4343.956560434419, 4361.084172323815, 6448.64532450715, 6469.93530064698, 6480.384363485461, 6481.0, 6504.15445992018, 5955.0, 5984.73068711909, 6000.399960004008, 6002.639841609517, 6011.549133814938, 5811.331696854873, 7227.710891564331, 7233.638318084075, 7234.855302893965, 7236.276372362774, 4830.637702172351, 4836.951630483685, 4843.66094373394, 4850.878728031792, 4855.32025516428, 7202.819929501804, 7282.235365286621, 7453.180150183475, 7507.286807753255, 7557.319841214262, 4820.662553621213, 4835.1296766581645, 4881.023795240966, 4883.609311255091, 4886.2426323919135, 4974.37820272466, 4975.427825800007, 4977.0, 4992.301077849104, 5002.799888004512, 5611.663300201919, 5787.363390027093, 5901.409859014064, 5930.970345148246, 5957.731902064417, 6278.0269058296035, 6568.967155164193, 7242.782716518513, 7267.672954717051, 7283.417326613858, 1721.7245240761667, 1743.171993303171, 1744.345870298638, 1750.7373893916015, 1758.9648207035787, 1095.2606990281529, 1115.0800589513522, 1128.1820680006929, 1128.802459569572, 1141.8801025892328, 6740.191177058687, 6769.356911093439, 6788.558743681645, 6799.354061364163, 6804.761833335909, 6083.756649733961, 7533.171351151369, 7533.849323013509, 7538.946726575746, 7550.282723141293, 6754.324567543206, 6772.153480814898, 6784.864302714017, 6785.287544807823, 6793.898091528631, 3833.9041523962123, 3945.5659877413464, 3982.2234664240773, 3986.1828325193264, 3988.3020471417385, 6253.781117660951, 7811.570363630055, 7831.373490120776, 7838.921610783933, 7841.039740064984, 7676.963609912702, 7747.18654541265, 7751.844963100706, 7758.961205194051, 7759.650815713307, 7786.7663970080985, 7799.220077992155, 7802.492837965514, 7808.102068262109, 7823.061232652118, 6049.425304596057, 7225.530340527849, 7472.140703818913, 7514.549127052394, 7516.661750221362, 5766.654000759968, 7081.398081163159, 7342.48602597813, 7349.118105827121, 7359.595222262827, 6484.5460817742305, 7356.455144419518, 7881.13307536182, 7902.328302094386, 7935.246151615587, 4552.317152427162, 4927.901441971212, 4933.876653083702, 4951.084049450863, 4951.158303088411, 6474.4820414365795, 7174.708552460607, 7549.811254718676, 7560.735374261874, 7572.053493313336, 7081.752138675121, 7282.0, 7300.817479563053, 7305.196428392979, 7310.086239220098, 7193.892091618525, 7262.854742905218, 7267.890981635174, 7274.599897005503, 7279.017332660235, 7082.114735658043, 7110.288971103055, 7111.253318401494, 7112.110986126734, 7112.822179445348, 7305.707771689073, 7306.123265208209, 7307.794213954638, 7327.340539351484, 7347.0, 6774.86450270982, 6985.057017302803, 6994.720211191496, 6997.545159564612, 7142.5000249982], "value": 5280.34490891634, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.9796006119817, 750.3734381791204, 751.5528260684893, 753.5026882257707, 765.4450523370557, 14920.925395373008, 14958.252087395627, 15116.244187790622, 15217.923910380447, 15660.295286712097, 14224.786628200585, 14258.786118208236, 14281.143131412122, 14289.92855035726, 14297.213653249068, 746.0934964018716, 758.3857075768617, 899.9820003599924, 915.7756349694334, 934.9859752103724, 913.2785099771173, 941.8210539997378, 943.2218419803655, 947.469417126408, 947.7062110745657, 956.9043095690411, 990.484947827133, 991.1228562722007, 992.2607657295289, 993.3394292795282, 780.6057940739919, 955.8614000969856, 961.8941916389192, 964.8118616869713, 967.796762679838, 714.2036629158503, 718.0736849464184, 719.3669570777682, 722.443718336883, 730.550711312539, 14755.114693118447, 14777.7783333249, 14789.704205915928, 14799.926000370036, 14800.703985920329, 12601.18092323996, 12710.491580336775, 12743.132795121117, 12865.871341286562, 13150.473981040746, 8474.491530508127, 10079.596816127347, 10167.59329626814, 10284.97150284973, 10299.330543514647, 3356.077078803324, 3444.2594842109065, 3464.20323325634, 3464.9480257796154, 3546.042568506489, 79787.00532486734, 80128.0, 80198.59900700518, 83012.0, 84094.57952710259, 9359.344845860724, 9486.33595648298, 9508.90491095094, 9950.303478756417, 10074.798504029879, 22106.22628208005, 22120.778792211873, 22141.557168856532, 22141.778582214294, 22163.0, 7285.7814265572115, 7341.045664063638, 7630.656620452093, 7650.41519690629, 7730.342920851678, 3801.9429708554394, 3873.5158105236846, 3887.6501114899793, 3946.131850992777, 4113.794310284534, 3460.9480857787153, 3494.143934736006, 3514.964850351515, 3520.436730123168, 3528.68241858234, 568.9857753556195, 601.425638515217, 613.7268915332724, 621.3351713666334, 623.8284471770208, 517.7747679759317, 524.8110680155141, 544.5779520871356, 563.4534501533506, 611.1047315682457, 7768.821900032463, 7944.443888927835, 8039.196080391914, 8149.918500815034, 8169.918300817035, 589.5431040943304, 593.1991811055127, 610.188449362347, 611.2939554814196, 634.5177664974652, 3212.6305474870687, 3599.1002249437643, 3711.981440092782, 3863.2466668999837, 3880.5925377835483, 92244.53877730569, 92418.53790731003, 92915.0, 93684.53157734168, 93863.0, 78701.60649196718, 79169.45813792979, 79655.0, 81359.3728125446, 82030.17969820344, 69874.65062674654, 70490.64754676193, 70946.0, 72093.63953180306, 72908.0, 7584.852286301123, 7700.691972321044, 7721.53670779755, 7808.960955195188, 7885.684572617031, 40731.0, 48726.756366217945, 49137.26294105663, 49857.75071124621, 49909.25136122888, 61375.69312153411, 62725.74548508913, 63817.361826381144, 65612.67193664193, 69893.60212795614, 10986.890131098906, 11069.5018724156, 11218.66344009681, 11361.488733006869, 11366.715832103933, 11888.643340699793, 12055.51777928873, 12124.211926224767, 12272.0, 12445.942094922033, 11318.377489238172, 11463.942680286546, 11518.424078795859, 11642.417879105842, 11984.40077996114, 11205.66383008511, 11314.434278285888, 11573.421328933688, 12026.977706895012, 12489.0, 10911.399873007062, 11171.66485005451, 11210.327380357205, 11315.038221751243, 11490.712732181428, 9310.162085412074, 9342.719718408458, 9540.236781057638, 9588.316857362304, 10044.88693385794, 7661.770146895379, 9204.677836275698, 9310.348275620641, 9457.647654705948, 9569.760755981157], "value": 6869.012620692683, "unit": "score"}], "name": "dromaeo_css", "value": 7509.54078172396, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 120.0, 115.0, 112.0, 112.0, 115.0, 114.0, 115.0, 134.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 146.0, 164.0, 118.0, 139.0, 138.0, 118.0, 168.0, 119.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 184.0, 182.0, 186.0, 183.0, 184.0, 185.0, 185.0, 185.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 76.0, 152.0, 56.0, 56.0, 56.0, 64.0, 132.0, 57.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 146.0, 76.0, 82.0, 85.0, 127.0, 80.0, 77.0, 127.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 88.0, 88.0, 84.0, 91.0, 85.0, 87.0, 83.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 85.0, 84.0, 86.0, 85.0, 86.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 65.0, 64.0, 65.0, 63.0, 66.0, 81.0, 57.0, 57.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 73.0, 77.0, 75.0, 73.0, 68.0, 69.0, 68.0, 69.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 81.0, 79.0, 80.0, 78.0, 80.0, 81.0, 84.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 128.0, 127.0, 126.0, 125.0, 126.0, 125.0, 135.0, 131.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 223.0, 174.0, 167.0, 164.0, 163.0, 168.0, 165.0, 162.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 67.0, 69.0, 67.0, 67.0, 67.0, 68.0, 69.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1464.1999999999998, "alertThreshold": 2.0}]} 07:15:45 INFO - Return code: 0 07:15:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:15:45 ERROR - # TBPL SUCCESS # 07:15:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:45 INFO - 2016-05-23 07:15:45.478 screenresolution[1681:10368] starting screenresolution argv=screenresolution get 07:15:45 INFO - 2016-05-23 07:15:45.480 screenresolution[1681:10368] Display 0: 1600x1200x32@60 07:15:45 INFO - 2016-05-23 07:15:45.486 screenresolution[1682:10371] starting screenresolution argv=screenresolution list 07:15:45 INFO - Available Modes on Display 0 07:15:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:45 INFO - Intel Iris: 07:15:45 INFO - Chipset Model: Intel Iris 07:15:45 INFO - Type: GPU 07:15:45 INFO - Bus: Built-In 07:15:45 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:45 INFO - Vendor: Intel (0x8086) 07:15:45 INFO - Device ID: 0x0a2e 07:15:45 INFO - Revision ID: 0x0009 07:15:45 INFO - Displays: 07:15:45 INFO - Display: 07:15:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:45 INFO - Display Serial Number: 1600x1200 60 07:15:45 INFO - Main Display: Yes 07:15:45 INFO - Mirror: Off 07:15:45 INFO - Online: Yes 07:15:45 INFO - Rotation: Supported 07:15:45 INFO - Return code: 0 07:15:45 INFO - Running post-action listener: _resource_record_post_action 07:15:45 INFO - Running post-run listener: _resource_record_post_run 07:15:46 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 32968192; Write bytes: 655019008; Read time: 327; Write time: 1833 07:15:46 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 340644352; Write bytes: 335857152; Read time: 26625; Write time: 622 07:15:46 INFO - run-tests - Wall time: 1175s; CPU: 52.0%; Read bytes: 32030208; Write bytes: 298776064; Read time: 306; Write time: 1155 07:15:46 INFO - Running post-run listener: _upload_blobber_files 07:15:46 INFO - Blob upload gear active. 07:15:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:15:47 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:15:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:15:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:48 INFO - (blobuploader) - INFO - Done attempting. 07:15:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:15:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:15:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:49 INFO - (blobuploader) - INFO - Done attempting. 07:15:49 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:49 INFO - Return code: 0 07:15:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41aa2df15fe6fb72377cc391d145295ced37b7c32273f19007e5e7a9d2a231abcbc90916099424f51a0200070026124f539e11426c31f84b3a4da62ec250a96e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72d0380a4f89d218815ffed03d5ee42e0380c3a059bfa396bdd2706f8fe860ed27a86211462ff1675d1c4a664c3a28432c38e86008c2b5cee6e2d56ee7b8f820"} 07:15:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:49 INFO - Contents: 07:15:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41aa2df15fe6fb72377cc391d145295ced37b7c32273f19007e5e7a9d2a231abcbc90916099424f51a0200070026124f539e11426c31f84b3a4da62ec250a96e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72d0380a4f89d218815ffed03d5ee42e0380c3a059bfa396bdd2706f8fe860ed27a86211462ff1675d1c4a664c3a28432c38e86008c2b5cee6e2d56ee7b8f820"} 07:15:49 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:49 INFO - Copying logs to upload dir... 07:15:49 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1294.788442 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-05-23 07:15:49.403378) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 07:15:49.407143) ========= 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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-Aurora/sha512/41aa2df15fe6fb72377cc391d145295ced37b7c32273f19007e5e7a9d2a231abcbc90916099424f51a0200070026124f539e11426c31f84b3a4da62ec250a96e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72d0380a4f89d218815ffed03d5ee42e0380c3a059bfa396bdd2706f8fe860ed27a86211462ff1675d1c4a664c3a28432c38e86008c2b5cee6e2d56ee7b8f820"} build_url:https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/NSnRwo35R5SEESs-yizpGA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41aa2df15fe6fb72377cc391d145295ced37b7c32273f19007e5e7a9d2a231abcbc90916099424f51a0200070026124f539e11426c31f84b3a4da62ec250a96e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/72d0380a4f89d218815ffed03d5ee42e0380c3a059bfa396bdd2706f8fe860ed27a86211462ff1675d1c4a664c3a28432c38e86008c2b5cee6e2d56ee7b8f820"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 07:15:49.436656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:15:49.436997) ========= 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.IM3HVptpLc/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.DYJ06Lj5sT/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005143 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 07:15:49.488692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 07:15:49.489446) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 07:15:49.490195) ========= ========= Total master_lag: 0.23 =========