builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0005 starttime: 1462530035.77 results: success (0) buildid: 20160505123841 builduid: 1457772db7ef4c1982b4796b67a4914d revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.772296) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.772747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.773019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.793716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.794064) ========= 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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-06 03:20:35-- 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% 64.3M=0s 2016-05-06 03:20:36 (64.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126931 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.938093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.941413) ========= 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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.027383 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.988857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:35.989182) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --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 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rE6bLgWbrB/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.KRoQyEZ87T/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-06 03:20:36,163 truncating revision to first 12 chars 2016-05-06 03:20:36,163 Setting DEBUG logging. 2016-05-06 03:20:36,163 attempt 1/10 2016-05-06 03:20:36,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0123e9f41ced?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 03:20:36,859 unpacking tar archive at: mozilla-aurora-0123e9f41ced/testing/mozharness/ program finished with exit code 0 elapsedTime=0.962991 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:36.968151) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:36.970338) ========= script_repo_revision: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:36.970716) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:36.970976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 03:20:36.986838) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-06 03:20:36.987108) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:20:37 INFO - MultiFileLogger online at 20160506 03:20:37 in /builds/slave/test 03:20:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:20:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:37 INFO - {'append_to_log': False, 03:20:37 INFO - 'base_work_dir': '/builds/slave/test', 03:20:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:20:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:37 INFO - 'branch': 'Mozilla-Aurora', 03:20:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:37 INFO - 'config_files': ('talos/mac_config.py',), 03:20:37 INFO - 'default_actions': ('clobber', 03:20:37 INFO - 'read-buildbot-config', 03:20:37 INFO - 'download-and-extract', 03:20:37 INFO - 'populate-webroot', 03:20:37 INFO - 'create-virtualenv', 03:20:37 INFO - 'install', 03:20:37 INFO - 'run-tests'), 03:20:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:37 INFO - 'download_minidump_stackwalk': True, 03:20:37 INFO - 'download_symbols': 'ondemand', 03:20:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:37 INFO - 'installer_path': 'installer.exe', 03:20:37 INFO - 'log_level': 'info', 03:20:37 INFO - 'log_name': 'talos', 03:20:37 INFO - 'log_to_console': True, 03:20:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:20:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:20:37 INFO - 'opt_config_files': (), 03:20:37 INFO - 'pip_index': False, 03:20:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:37 INFO - 'cmd': ('bash', 03:20:37 INFO - '-c', 03:20:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:37 INFO - 'enabled': True, 03:20:37 INFO - 'halt_on_failure': False, 03:20:37 INFO - 'name': 'check_screen_resolution'},), 03:20:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:37 INFO - 'cmd': ('bash', 03:20:37 INFO - '-c', 03:20:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:37 INFO - 'enabled': True, 03:20:37 INFO - 'halt_on_failure': False, 03:20:37 INFO - 'name': 'check_screen_resolution'},), 03:20:37 INFO - 'run_cmd_checks_enabled': True, 03:20:37 INFO - 'sps_profile': False, 03:20:37 INFO - 'sps_profile_interval': 0, 03:20:37 INFO - 'suite': 'dromaeojs-e10s', 03:20:37 INFO - 'system_bits': '32', 03:20:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:37 INFO - 'title': 't-yosemite-r7-0005', 03:20:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:37 INFO - 'use_talos_json': True, 03:20:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:37 INFO - 'work_dir': 'build'} 03:20:37 INFO - ##### 03:20:37 INFO - ##### Running clobber step. 03:20:37 INFO - ##### 03:20:37 INFO - Running pre-action listener: _resource_record_pre_action 03:20:37 INFO - Running main action method: clobber 03:20:37 INFO - rmtree: /builds/slave/test/build 03:20:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:39 INFO - Running post-action listener: _resource_record_post_action 03:20:39 INFO - ##### 03:20:39 INFO - ##### Running read-buildbot-config step. 03:20:39 INFO - ##### 03:20:39 INFO - Running pre-action listener: _resource_record_pre_action 03:20:39 INFO - Running main action method: read_buildbot_config 03:20:39 INFO - Using buildbot properties: 03:20:39 INFO - { 03:20:39 INFO - "project": "", 03:20:39 INFO - "product": "firefox", 03:20:39 INFO - "script_repo_revision": "production", 03:20:39 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:20:39 INFO - "repository": "", 03:20:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:20:39 INFO - "buildid": "20160505123841", 03:20:39 INFO - "pgo_build": "False", 03:20:39 INFO - "basedir": "/builds/slave/test", 03:20:39 INFO - "buildnumber": 284, 03:20:39 INFO - "slavename": "t-yosemite-r7-0005", 03:20:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:20:39 INFO - "platform": "yosemite_r7", 03:20:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:20:39 INFO - "branch": "mozilla-aurora", 03:20:39 INFO - "repo_path": "releases/mozilla-aurora", 03:20:39 INFO - "revision": "0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b", 03:20:39 INFO - "stage_platform": "macosx64", 03:20:39 INFO - "builduid": "1457772db7ef4c1982b4796b67a4914d", 03:20:39 INFO - "slavebuilddir": "test" 03:20:39 INFO - } 03:20:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 03:20:39 INFO - Running post-action listener: _resource_record_post_action 03:20:39 INFO - ##### 03:20:39 INFO - ##### Running download-and-extract step. 03:20:39 INFO - ##### 03:20:39 INFO - Running pre-action listener: _resource_record_pre_action 03:20:39 INFO - Running main action method: download_and_extract 03:20:39 INFO - mkdir: /builds/slave/test/build/tests 03:20: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')]} 03:20:39 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:20:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:20:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 03:20:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:40 INFO - Downloaded 1199 bytes. 03:20:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 03:20:40 INFO - Using the following test package requirements: 03:20:40 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:20:40 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:20:40 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 03:20:40 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:20:40 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 03:20:40 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:20:40 INFO - u'jsshell-mac.zip'], 03:20:40 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:20:40 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 03:20:40 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 03:20:40 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:20:40 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 03:20:40 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:20:40 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 03:20:40 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:20:40 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 03:20:40 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 03:20:40 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 03:20:40 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:20:40 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')]} 03:20:40 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:41 INFO - Downloaded 18114223 bytes. 03:20:41 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'] 03:20:41 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 03:20:45 INFO - Return code: 0 03:20:45 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 03:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:45 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:20:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:20:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 03:20:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:46 INFO - Downloaded 18114223 bytes. 03:20:46 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'] 03:20:46 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 03:20:49 INFO - Return code: 0 03:20:49 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')]} 03:20:49 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:20:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:20:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 03:20:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:50 INFO - Downloaded 10840145 bytes. 03:20:50 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'] 03:20:50 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 03:20:50 INFO - Return code: 0 03:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:50 INFO - https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 03:20:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:20:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:20:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 03:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Kej6EClFTym5Td3ayIylNA/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 03:20:53 INFO - Downloaded 114081343 bytes. 03:20:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:20:53 INFO - mkdir: /builds/slave/test/properties 03:20:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:53 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:53 INFO - Contents: 03:20:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 03:20:54 INFO - Running post-action listener: _resource_record_post_action 03:20:54 INFO - Running post-action listener: set_extra_try_arguments 03:20:54 INFO - ##### 03:20:54 INFO - ##### Running populate-webroot step. 03:20:54 INFO - ##### 03:20:54 INFO - Running pre-action listener: _resource_record_pre_action 03:20:54 INFO - Running main action method: populate_webroot 03:20:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:20:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:20:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:20:55 INFO - '--tppagecycles', 03:20:55 INFO - '7'], 03:20:55 INFO - 'tests': ['tsvgm']}}, 03:20:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:20:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:20:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:55 INFO - 'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:55 INFO - 'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['damp', 'tps']}, 03:20:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:55 INFO - 'tests': ['damp', 'tps']}, 03:20:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['dromaeo_dom']}, 03:20:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['a11yr', 03:20:55 INFO - 'ts_paint', 03:20:55 INFO - 'tpaint', 03:20:55 INFO - 'sessionrestore', 03:20:55 INFO - 'sessionrestore_no_auto_restore', 03:20:55 INFO - 'tabpaint']}, 03:20:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:55 INFO - 'ts_paint', 03:20:55 INFO - 'tpaint', 03:20:55 INFO - 'sessionrestore', 03:20:55 INFO - 'sessionrestore_no_auto_restore', 03:20:55 INFO - 'tabpaint']}, 03:20:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:20:55 INFO - 'ts_paint', 03:20:55 INFO - 'tpaint', 03:20:55 INFO - 'sessionrestore', 03:20:55 INFO - 'sessionrestore_no_auto_restore', 03:20:55 INFO - 'tabpaint']}, 03:20:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:20:55 INFO - 'ts_paint', 03:20:55 INFO - 'tpaint', 03:20:55 INFO - 'sessionrestore', 03:20:55 INFO - 'sessionrestore_no_auto_restore', 03:20:55 INFO - 'tabpaint']}, 03:20:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['a11yr', 03:20:55 INFO - 'ts_paint', 03:20:55 INFO - 'tpaint', 03:20:55 INFO - 'sessionrestore', 03:20:55 INFO - 'sessionrestore_no_auto_restore', 03:20:55 INFO - 'tabpaint']}, 03:20:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['a11yr', 03:20:55 INFO - 'ts_paint', 03:20:55 INFO - 'tpaint', 03:20:55 INFO - 'sessionrestore', 03:20:55 INFO - 'sessionrestore_no_auto_restore', 03:20:55 INFO - 'tabpaint']}, 03:20:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['tsvgx', 03:20:55 INFO - 'tsvgr_opacity', 03:20:55 INFO - 'tart', 03:20:55 INFO - 'tscrollx', 03:20:55 INFO - 'cart']}, 03:20:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:55 INFO - 'tsvgr_opacity', 03:20:55 INFO - 'tart', 03:20:55 INFO - 'tscrollx', 03:20:55 INFO - 'cart']}, 03:20:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:55 INFO - 'talos_options': ['--disable-e10s'], 03:20:55 INFO - 'tests': ['tp5o']}, 03:20:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:55 INFO - 'tests': ['tp5o']}, 03:20:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:55 INFO - 'talos_options': ['--disable-e10s', 03:20:55 INFO - '--xperf_path', 03:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:55 INFO - 'tests': ['tp5n']}, 03:20:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:20:55 INFO - 'talos_options': ['--xperf_path', 03:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:55 INFO - 'tests': ['tp5n']}}, 03:20:55 INFO - 'talos.zip': {'path': '', 03:20:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:20:55 INFO - Running post-action listener: _resource_record_post_action 03:20:55 INFO - ##### 03:20:55 INFO - ##### Running create-virtualenv step. 03:20:55 INFO - ##### 03:20:55 INFO - Running pre-action listener: _resource_record_pre_action 03:20:55 INFO - Running main action method: create_virtualenv 03:20:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:55 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 03:20:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:20:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:55 INFO - Using real prefix '/tools/python27' 03:20:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:58 INFO - Installing pip.................done. 03:20:58 INFO - Return code: 0 03:20:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:58 INFO - 'HOME': '/Users/cltbld', 03:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:58 INFO - 'LOGNAME': 'cltbld', 03:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:58 INFO - 'MOZ_NO_REMOTE': '1', 03:20:58 INFO - 'NO_EM_RESTART': '1', 03:20:58 INFO - 'PAGER': '/bin/cat', 03:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:58 INFO - 'PWD': '/builds/slave/test', 03:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:58 INFO - 'SHELL': '/bin/bash', 03:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:20:58 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:58 INFO - 'USER': 'cltbld', 03:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:58 INFO - 'XPC_FLAGS': '0x0', 03:20:58 INFO - 'XPC_SERVICE_NAME': '0', 03:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:20:58 INFO - Cleaning up... 03:20:58 INFO - Return code: 0 03:20:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:20:58 INFO - 'HOME': '/Users/cltbld', 03:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:20:58 INFO - 'LOGNAME': 'cltbld', 03:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:58 INFO - 'MOZ_NO_REMOTE': '1', 03:20:58 INFO - 'NO_EM_RESTART': '1', 03:20:58 INFO - 'PAGER': '/bin/cat', 03:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:58 INFO - 'PWD': '/builds/slave/test', 03:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:20:58 INFO - 'SHELL': '/bin/bash', 03:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:20:58 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:20:58 INFO - 'USER': 'cltbld', 03:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:58 INFO - 'XPC_FLAGS': '0x0', 03:20:58 INFO - 'XPC_SERVICE_NAME': '0', 03:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:59 INFO - Downloading/unpacking psutil>=0.7.1 03:20:59 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 03:20:59 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 03:20:59 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 03:20:59 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 03:20:59 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 03:20:59 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 03:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:02 INFO - Installing collected packages: psutil 03:21:02 INFO - Running setup.py install for psutil 03:21:02 INFO - building 'psutil._psutil_osx' extension 03:21:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:21:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:21:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:21:03 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 03:21:03 INFO - building 'psutil._psutil_posix' extension 03:21:03 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 03:21:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:21:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:21:03 INFO - ^ 03:21:03 INFO - 1 warning generated. 03:21:03 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 03:21:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:03 INFO - Successfully installed psutil 03:21:03 INFO - Cleaning up... 03:21:03 INFO - Return code: 0 03:21:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:21:03 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')]} 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:03 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')]} 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:03 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 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:21:03 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 03:21:03 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 03:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:03 INFO - 'HOME': '/Users/cltbld', 03:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:03 INFO - 'LOGNAME': 'cltbld', 03:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:03 INFO - 'MOZ_NO_REMOTE': '1', 03:21:03 INFO - 'NO_EM_RESTART': '1', 03:21:03 INFO - 'PAGER': '/bin/cat', 03:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:03 INFO - 'PWD': '/builds/slave/test', 03:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:03 INFO - 'SHELL': '/bin/bash', 03:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:21:03 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:03 INFO - 'USER': 'cltbld', 03:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:03 INFO - 'XPC_FLAGS': '0x0', 03:21:03 INFO - 'XPC_SERVICE_NAME': '0', 03:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:21:06 INFO - Installing collected packages: mozsystemmonitor 03:21:06 INFO - Running setup.py install for mozsystemmonitor 03:21:06 INFO - Successfully installed mozsystemmonitor 03:21:06 INFO - Cleaning up... 03:21:06 INFO - Return code: 0 03:21:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:21:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:21:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:06 INFO - 'HOME': '/Users/cltbld', 03:21:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:06 INFO - 'LOGNAME': 'cltbld', 03:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:06 INFO - 'MOZ_NO_REMOTE': '1', 03:21:06 INFO - 'NO_EM_RESTART': '1', 03:21:06 INFO - 'PAGER': '/bin/cat', 03:21:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:06 INFO - 'PWD': '/builds/slave/test', 03:21:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:06 INFO - 'SHELL': '/bin/bash', 03:21:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:21:06 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:21:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:06 INFO - 'USER': 'cltbld', 03:21:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:06 INFO - 'XPC_FLAGS': '0x0', 03:21:06 INFO - 'XPC_SERVICE_NAME': '0', 03:21:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:06 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:09 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 03:21:09 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 03:21:09 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 03:21:09 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 03:21:09 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 03:21:09 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 03:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:09 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 03:21:09 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 03:21:09 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 03:21:09 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 03:21:09 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 03:21:09 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 03:21:10 INFO - Downloading docopt-0.6.1.tar.gz 03:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:10 INFO - Running setup.py install for blobuploader 03:21:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:10 INFO - Running setup.py install for requests 03:21:10 INFO - Running setup.py install for docopt 03:21:11 INFO - Successfully installed blobuploader requests docopt 03:21:11 INFO - Cleaning up... 03:21:11 INFO - Return code: 0 03:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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')]} 03:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:11 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 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:21:11 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 03:21:11 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 03:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:11 INFO - 'HOME': '/Users/cltbld', 03:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:11 INFO - 'LOGNAME': 'cltbld', 03:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:11 INFO - 'MOZ_NO_REMOTE': '1', 03:21:11 INFO - 'NO_EM_RESTART': '1', 03:21:11 INFO - 'PAGER': '/bin/cat', 03:21:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:11 INFO - 'PWD': '/builds/slave/test', 03:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:11 INFO - 'SHELL': '/bin/bash', 03:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:21:11 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:11 INFO - 'USER': 'cltbld', 03:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:11 INFO - 'XPC_FLAGS': '0x0', 03:21:11 INFO - 'XPC_SERVICE_NAME': '0', 03:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:11 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-HP3zoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:11 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-d4sIAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:11 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-9g7FRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:11 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-OtU0ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:11 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-KQnrGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:11 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ANl8zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-b9p4Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-nnhSvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-hUyTZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ENcwA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Su38eC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-QAd_JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-b7RlIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-BQer18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-jVsy5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-3iKL6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-O35A7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:13 INFO - Running setup.py install for manifestparser 03:21:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:13 INFO - Running setup.py install for mozcrash 03:21:13 INFO - Running setup.py install for mozdebug 03:21:13 INFO - Running setup.py install for mozdevice 03:21:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:21:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:13 INFO - Running setup.py install for mozfile 03:21:13 INFO - Running setup.py install for mozhttpd 03:21:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:14 INFO - Running setup.py install for mozinfo 03:21:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:14 INFO - Running setup.py install for mozInstall 03:21:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:14 INFO - Running setup.py install for mozleak 03:21:14 INFO - Running setup.py install for mozlog 03:21:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:14 INFO - Running setup.py install for moznetwork 03:21:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:14 INFO - Running setup.py install for mozprocess 03:21:14 INFO - Running setup.py install for mozprofile 03:21:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:15 INFO - Running setup.py install for mozrunner 03:21:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:15 INFO - Running setup.py install for mozscreenshot 03:21:15 INFO - Running setup.py install for moztest 03:21:15 INFO - Running setup.py install for mozversion 03:21:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:15 INFO - Cleaning up... 03:21:15 INFO - Return code: 0 03:21:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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')]} 03:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:15 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 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:21:15 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 03:21:15 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 03:21:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:21:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:15 INFO - 'HOME': '/Users/cltbld', 03:21:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:15 INFO - 'LOGNAME': 'cltbld', 03:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:15 INFO - 'MOZ_NO_REMOTE': '1', 03:21:15 INFO - 'NO_EM_RESTART': '1', 03:21:15 INFO - 'PAGER': '/bin/cat', 03:21:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:15 INFO - 'PWD': '/builds/slave/test', 03:21:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:15 INFO - 'SHELL': '/bin/bash', 03:21:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:21:15 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:21:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:15 INFO - 'USER': 'cltbld', 03:21:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:15 INFO - 'XPC_FLAGS': '0x0', 03:21:15 INFO - 'XPC_SERVICE_NAME': '0', 03:21:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:15 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-kt4n1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-XWds_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-6wsUL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-DvgSmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-PQ5F2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-zs8J2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ln3818-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-k7w2tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-vtPI4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:16 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)) 03:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:16 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ymQrsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:17 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)) 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:17 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-gOR90O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:17 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)) 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:17 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-CoU16b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:17 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)) 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:17 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-LWUwsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:17 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)) 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:17 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Bas1JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:17 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)) 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:17 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-njOq58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:17 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)) 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:17 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-eKifuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:17 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)) 03:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:17 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-fhHsXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:17 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)) 03:21:17 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)) 03:21:17 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)) 03:21:17 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)) 03:21:17 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)) 03:21:17 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)) 03:21:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:17 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 03:21:17 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 03:21:17 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 03:21:17 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 03:21:17 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 03:21:17 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 03:21:20 INFO - Downloading blessings-1.6.tar.gz 03:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:20 INFO - Installing collected packages: blessings 03:21:20 INFO - Running setup.py install for blessings 03:21:20 INFO - Successfully installed blessings 03:21:20 INFO - Cleaning up... 03:21:20 INFO - Return code: 0 03:21:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:20 INFO - Reading from file tmpfile_stdout 03:21:20 INFO - Current package versions: 03:21:20 INFO - blessings == 1.6 03:21:20 INFO - blobuploader == 1.2.4 03:21:20 INFO - docopt == 0.6.1 03:21:20 INFO - manifestparser == 1.1 03:21:20 INFO - mozInstall == 1.12 03:21:20 INFO - mozcrash == 0.17 03:21:20 INFO - mozdebug == 0.1 03:21:20 INFO - mozdevice == 0.48 03:21:20 INFO - mozfile == 1.2 03:21:20 INFO - mozhttpd == 0.7 03:21:20 INFO - mozinfo == 0.9 03:21:20 INFO - mozleak == 0.1 03:21:20 INFO - mozlog == 3.1 03:21:20 INFO - moznetwork == 0.27 03:21:20 INFO - mozprocess == 0.22 03:21:20 INFO - mozprofile == 0.28 03:21:20 INFO - mozrunner == 6.11 03:21:20 INFO - mozscreenshot == 0.1 03:21:20 INFO - mozsystemmonitor == 0.0 03:21:20 INFO - moztest == 0.7 03:21:20 INFO - mozversion == 1.4 03:21:20 INFO - psutil == 3.1.1 03:21:20 INFO - requests == 1.2.3 03:21:20 INFO - wsgiref == 0.1.2 03:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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')]} 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:20 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 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:21:20 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 03:21:20 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 03:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:20 INFO - 'HOME': '/Users/cltbld', 03:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:20 INFO - 'LOGNAME': 'cltbld', 03:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:20 INFO - 'MOZ_NO_REMOTE': '1', 03:21:20 INFO - 'NO_EM_RESTART': '1', 03:21:20 INFO - 'PAGER': '/bin/cat', 03:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:20 INFO - 'PWD': '/builds/slave/test', 03:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:20 INFO - 'SHELL': '/bin/bash', 03:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:21:20 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:20 INFO - 'USER': 'cltbld', 03:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:20 INFO - 'XPC_FLAGS': '0x0', 03:21:20 INFO - 'XPC_SERVICE_NAME': '0', 03:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 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)) 03:21:20 INFO - Cleaning up... 03:21:21 INFO - Return code: 0 03:21:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:21 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')]} 03:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:21 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')]} 03:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:21 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 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:21:21 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 03:21:21 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 03:21:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:21:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:21 INFO - 'HOME': '/Users/cltbld', 03:21:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:21 INFO - 'LOGNAME': 'cltbld', 03:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:21 INFO - 'MOZ_NO_REMOTE': '1', 03:21:21 INFO - 'NO_EM_RESTART': '1', 03:21:21 INFO - 'PAGER': '/bin/cat', 03:21:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:21 INFO - 'PWD': '/builds/slave/test', 03:21:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:21 INFO - 'SHELL': '/bin/bash', 03:21:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:21:21 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:21:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:21 INFO - 'USER': 'cltbld', 03:21:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:21 INFO - 'XPC_FLAGS': '0x0', 03:21:21 INFO - 'XPC_SERVICE_NAME': '0', 03:21:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:21 INFO - Downloading/unpacking jsonschema 03:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:23 INFO - Downloading/unpacking functools32 (from jsonschema) 03:21:23 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 03:21:23 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 03:21:23 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 03:21:23 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 03:21:23 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 03:21:23 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 03:21:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:24 INFO - warning: no files found matching '*.txt' 03:21:24 INFO - no previously-included directories found matching 'build' 03:21:24 INFO - no previously-included directories found matching 'dist' 03:21:24 INFO - no previously-included directories found matching '.git*' 03:21:24 INFO - Installing collected packages: jsonschema, functools32 03:21:24 INFO - Running setup.py install for functools32 03:21:24 INFO - warning: no files found matching '*.txt' 03:21:24 INFO - no previously-included directories found matching 'build' 03:21:24 INFO - no previously-included directories found matching 'dist' 03:21:24 INFO - no previously-included directories found matching '.git*' 03:21:24 INFO - Successfully installed jsonschema functools32 03:21:24 INFO - Cleaning up... 03:21:24 INFO - Return code: 0 03:21:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107228a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107238420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc0e15910e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, '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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 03:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:24 INFO - 'HOME': '/Users/cltbld', 03:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:24 INFO - 'LOGNAME': 'cltbld', 03:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:24 INFO - 'MOZ_NO_REMOTE': '1', 03:21:24 INFO - 'NO_EM_RESTART': '1', 03:21:24 INFO - 'PAGER': '/bin/cat', 03:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:24 INFO - 'PWD': '/builds/slave/test', 03:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:24 INFO - 'SHELL': '/bin/bash', 03:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:21:24 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:24 INFO - 'USER': 'cltbld', 03:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:24 INFO - 'XPC_FLAGS': '0x0', 03:21:24 INFO - 'XPC_SERVICE_NAME': '0', 03:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:24 INFO - Downloading/unpacking flake8 03:21:24 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 03:21:24 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 03:21:24 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 03:21:24 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 03:21:24 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 03:21:24 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 03:21:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:21:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:21:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:21:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:21:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:21:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:21:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:21:28 INFO - no previously-included directories found matching 'docs/_build' 03:21:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:21:28 INFO - Running setup.py install for pep8 03:21:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:21:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:21:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:21:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:21:28 INFO - no previously-included directories found matching 'docs/_build' 03:21:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:21:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:21:28 INFO - Cleaning up... 03:21:28 INFO - Return code: 0 03:21:28 INFO - Running post-action listener: _resource_record_post_action 03:21:28 INFO - Running post-action listener: _start_resource_monitoring 03:21:28 INFO - Starting resource monitoring. 03:21:28 INFO - ##### 03:21:28 INFO - ##### Running install step. 03:21:28 INFO - ##### 03:21:28 INFO - Running pre-action listener: _resource_record_pre_action 03:21:28 INFO - Running main action method: install 03:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:28 INFO - Reading from file tmpfile_stdout 03:21:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:29 INFO - Reading from file tmpfile_stdout 03:21:29 INFO - Output received: 03:21:29 INFO - Usage: mozinstall [options] installer 03:21:29 INFO - Options: 03:21:29 INFO - -h, --help show this help message and exit 03:21:29 INFO - -d DEST, --destination=DEST 03:21:29 INFO - Directory to install application into. [default: 03:21:29 INFO - "/builds/slave/test"] 03:21:29 INFO - --app=APP Application being installed. [default: firefox] 03:21:29 INFO - mkdir: /builds/slave/test/build/application 03:21:29 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'] 03:21:29 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 03:22:01 INFO - Reading from file tmpfile_stdout 03:22:01 INFO - Output received: 03:22:01 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:22:01 INFO - Running post-action listener: _resource_record_post_action 03:22:01 INFO - ##### 03:22:01 INFO - ##### Running run-tests step. 03:22:01 INFO - ##### 03:22:01 INFO - Running pre-action listener: _resource_record_pre_action 03:22:01 INFO - Running main action method: run_tests 03:22:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:22:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:22:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:22:01 INFO - 2016-05-06 03:22:01.348 screenresolution[1644:7519] starting screenresolution argv=screenresolution get 03:22:01 INFO - 2016-05-06 03:22:01.350 screenresolution[1644:7519] Display 0: 1600x1200x32@60 03:22:01 INFO - 2016-05-06 03:22:01.355 screenresolution[1645:7521] starting screenresolution argv=screenresolution list 03:22:01 INFO - Available Modes on Display 0 03:22:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:22:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:22:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:22:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:22:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:22:01 INFO - Intel Iris: 03:22:01 INFO - Chipset Model: Intel Iris 03:22:01 INFO - Type: GPU 03:22:01 INFO - Bus: Built-In 03:22:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:22:01 INFO - Vendor: Intel (0x8086) 03:22:01 INFO - Device ID: 0x0a2e 03:22:01 INFO - Revision ID: 0x0009 03:22:01 INFO - Displays: 03:22:01 INFO - Display: 03:22:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:22:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:22:01 INFO - Display Serial Number: 1600x1200 60 03:22:01 INFO - Main Display: Yes 03:22:01 INFO - Mirror: Off 03:22:01 INFO - Online: Yes 03:22:01 INFO - Rotation: Supported 03:22:01 INFO - Return code: 0 03:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:01 INFO - Python 2.7.3 03:22:01 INFO - Return code: 0 03:22:01 INFO - grabbing minidump binary from tooltool 03:22:01 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')]} 03:22:01 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 0x1070c7e00>, '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 0x106f30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070c2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:01 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 03:22:01 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 03:22:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:01 INFO - Return code: 0 03:22:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:22:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:22:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:22:02 INFO - Return code: 0 03:22:02 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:22:02 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:22:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rE6bLgWbrB/Render', 03:22:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:02 INFO - 'HOME': '/Users/cltbld', 03:22:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:02 INFO - 'LOGNAME': 'cltbld', 03:22:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:02 INFO - 'MOZ_NO_REMOTE': '1', 03:22:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:02 INFO - 'NO_EM_RESTART': '1', 03:22:02 INFO - 'PAGER': '/bin/cat', 03:22:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:02 INFO - 'PWD': '/builds/slave/test', 03:22:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:02 INFO - 'SHELL': '/bin/bash', 03:22:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KRoQyEZ87T/Listeners', 03:22:02 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 03:22:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:02 INFO - 'USER': 'cltbld', 03:22:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:02 INFO - 'XPC_FLAGS': '0x0', 03:22:02 INFO - 'XPC_SERVICE_NAME': '0', 03:22:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:22:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:22:02 INFO - mozversion application_buildid: 20160505123841 03:22:02 INFO - mozversion application_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:22:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:22:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:02 INFO - mozversion application_name: Firefox 03:22:02 INFO - mozversion application_remotingname: firefox-dev 03:22:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:02 INFO - mozversion application_vendor: Mozilla 03:22:02 INFO - mozversion application_version: 48.0a2 03:22:02 INFO - mozversion platform_buildid: 20160505123841 03:22:02 INFO - mozversion platform_changeset: 0123e9f41cedbcded87d8f6c3743ff6a4c1d8e5b 03:22:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:02 INFO - mozversion platform_version: 48.0a2 03:22:02 INFO - using testdate: 1462530122 03:22:02 INFO - actual date: 1462530122 03:22:02 INFO - starting webserver on 'localhost:49275' 03:22:02 INFO - SUITE-START | Running 2 tests 03:22:02 INFO - TEST-START | dromaeo_css 03:22:02 INFO - operating with platform_type : mac_ 03:22:02 INFO - Initialising browser for dromaeo_css test... 03:22:03 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpvTFpiz/profile http://localhost:49275/getInfo.html) 03:22:06 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 03:22:06 INFO - PROCESS | 1663 | colorDepth:24 03:22:06 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 03:22:06 INFO - PROCESS | 1663 | __metrics 03:22:06 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:22:06 INFO - TEST-INFO | 1663: exit 0 03:22:06 INFO - Browser initialized. 03:22:06 INFO - Running cycle 1/1 for dromaeo_css test... 03:22:06 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpvTFpiz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:18 INFO - PROCESS | 1666 | RSS: Main: 221495296 03:22:18 INFO - PROCESS | 1666 | 03:23:08 INFO - PROCESS | 1666 | 1462530188649 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] 03:25:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:25:21 INFO - PROCESS | 1666 | RSS: Main: 232001536 03:25:21 INFO - PROCESS | 1666 | 03:28:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:28:23 INFO - PROCESS | 1666 | RSS: Main: 243646464 03:28:23 INFO - PROCESS | 1666 | 03:31:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:31:26 INFO - PROCESS | 1666 | RSS: Main: 245428224 03:31:26 INFO - PROCESS | 1666 | 03:34:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:34:28 INFO - PROCESS | 1666 | RSS: Main: 247660544 03:34:28 INFO - PROCESS | 1666 | 03:37:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:37:32 INFO - PROCESS | 1666 | RSS: Main: 250163200 03:37:32 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:40:34 INFO - PROCESS | 1666 | RSS: Main: 251326464 03:40:34 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | __start_tp_report 03:40:34 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 03:40:34 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 03:40:34 INFO - PROCESS | 1666 | |i|pagename|runs| 03:40:34 INFO - PROCESS | 1666 | |0;dojo.html;2695.8247713898595;3150.3384289299247;3520.9119772005697;3550.7159427245824;3570.5715314162303;5771.913421298684;5780.104083866997;5797.623154494955;5807.883842323151;5819.185314056031;5788.942110578893;5819.214406055181;5824.242848429698;5837.532997360212;5849.824505264849;5222.608304377168;5259.947400525984;5286.127788914824;5299.311089558371;5309.62832601718;5153.510416510426;5277.419483856773;5311.097113490716;5374.167004114369;5382.8923421531545;5257.553107985826;5274.235235890794;5275.050490911634;5276.498732620395;5289.735513224324;5222;5263.236830659533;5267.288915996349;5302.310699609065;5320.281761962125;5093.643444958854;5198.40218374888;5199.818006369759;5203.505666961671;5307.097793375096;5183.196604526304;5346.946530534684;5779.508741756956;5815.302163740378;5820.825375238707;6114;6263.997760358367;6272.090546870724;6273.278572964122;6301.243850737895;6206.100115483229;6228.906566401508;6290.685465726695;6302.747890084391;6338.144350512668;5870.295564532284;5897.734601942923;5912.17229587858;5916.290045194604;5926.051831706949;6344.714487848058;6356;6367.649779262092;6376.39424254695;6377.426031657174;6080.391960803972;6145.678679083929;6176.4441200292185;6241.812745617639;6250.74997000124;6307.779227727007;6316.810495685137;6342.809715708444;6358.237011558643;6361.936380636227;6275.811725648238;6302.369763023661;6320.62076275425;6321.905171422432;6333.65164915934;6146.293176284785;6163.691815409301;6247.312795592481;6302.275238347649;6314.873702525923;4204.66362690984;4886.706797592155;4942.085714142895;4947.950520494821;4968.329275547755;4337.674674399433;4443.266860967969;4444.355568442557;4450.844220452269;4489.685721999429;5007.474215207423;5854.092615644582;5860.794872179454;5875.823725288248;5879.323877754027;5218.452062533455;6271.937280627135;6283.842903927439;6290.937090629035;6313.9368606314265;5661;5776.68228247442;5798.130280457881;5835.533157347402;5845.853853653608;5413.675179489164;5439.945600543944;5446.2647542582035;5467;5498.835034948958;6376.202974628171;6399.976003839456;6417.422431981144;6421.197350331208;6431.13179720741;5488.506034456918;6105.358937311518;6226.875462490815;6317.557770955989;6322.430981211529;6392.963048014572;6407.743690252338;6420.518461115528;6436.292007879223;6473.385028422293;6295.244570651368;6309.621422714652;6317.431431171217;6329.651869147241;6333.366663333814;6131.049687298476;6166.136740856194;6174.629522228681;6251.937480625135;6337.556371053982;6211.596246243979;6228.564000520101;6233.594816337105;6245.219347581552;6255.624662520263;6175.44421002112;6177.382261773787;6211.81364559064;6217.222847144107;6227.595206311576;5814.912776308443;5913.201717768046;6016.729247183975;6092.664903430354;6112;5109.335786347751;6182.443580077815;6200.503959683305;6237.7193026314835;6249.406306400884;5441.238226648352;5695.971520142372;5893.793717219876;6103.725332359965;6113.266408031065 03:40:34 INFO - PROCESS | 1666 | |1;ext.html;523.1498814426557;524.6406211744955;527.5357685236992;545.9426760190178;548.7695168029427;39058.609413905855;40252.396214056775;40260.79869600648;40319.99200020004;40373.798131009375;36073.819630901875;43191.78404107983;44282.55717442824;44347.89130271745;44352.778236108774;9482.146606805387;9671.323007389485;9748.171405430547;9750.609975600968;9767.804643907117;9518.333716639838;9627.470489123096;9635.084666956627;9650.469224192666;9663.903360966406;9556.426614403123;9635.22918166545;9651.95174024129;9661.227101831872;9703.272254580934;9575.760605984837;9638.614455421775;9641.710748677551;9664.903350966471;9670.70987870358;9591.520423978773;9700.223982081487;9705.708828735149;9710.417374957526;9713.271504637181;39540;39849.80075099635;40298;40310.79844600787;40480;2734.302752798024;3088.9536656950163;3091.5517249998625;3183.1405520509566;3279.262166012628;19367.322143725043;25639.48721025569;26536.86731566349;26636;27671.723282767318;2648.6689163854517;2672.2651270900465;2676.906308279201;2678.504476671822;2716.619673245747;302125.978740212;311495;314619;336858;345105;31419.528707069414;32402.027939161864;34762;36430.08924776902;36508.26983460369;34126.48810267848;35633.1091722709;35641.64358356435;35774;36597.08507287339;15693.607659808367;15904.920475397781;15910.76133857993;15919.522414327588;15944;11200.495977681025;12925.935370323088;13212.33938303081;13218.801717974238;13241.205527668179;8303.792405189919;8364.916350836414;8505.23452889243;8539.871901921477;8558.229759321692;3456.2223499712363;3467.4452087665854;3481.617022127564;3505.2638945821154;3522.031441353597;1049.1063630147505;1051.7370657335666;1086.8695756509112;1134.4044376702132;1158.8609366876028;26591.33521661974;30199.09402717922;31047;31063;31671.524927126113;1024.2778840917135;1098.9395583243;1141.3494308244221;1148.0815347721789;1153.0948205658685;11408.88591114095;15626.296816643278;15636.609084772972;15875.603109922344;15919.88560800756;468269;476737;477471;477875;483149;63557.72884542376;64861.67569162124;65296.69406611936;65369.34630653728;65624.6718766403;1550.0854495847504;1550.7518796992654;1554.1529866222936;1558.290977605187;1560.8985415947927;26795.732042679323;30121.84939075378;31652.841735791175;31978.84010579932;32429.513557296188;55895.72052139713;56159.43840561542;56411.15383269172;56517.43482565122;56640.716796415756;596098;596392;606213;608104.9189508049;608565.9571702114;28364.85817570899;28430.289242769097;41033;42013.94965125896;42763.14473710571;43660.78169609132;44687.32969005402;44816.77591612021;45930.54069459263;46166.53833461623;31188.34103083261;38932.41601376038;39023.80488097541;39343.426262949164;39847.203055939295;37612;38280.234395312495;38362.84911452661;38652;38926.83219503419;37620.62379376281;37813.81093094517;38136.23727525489;38536;39267;32907;34092.829535852165;34373;34442.65557344495;34882.825585871906;23018.07927682874;24473.755262447146;25435;25510.872445638397;26097.478050439266 03:40:34 INFO - PROCESS | 1666 | |2;jquery.html;401.1695789715289;403.5339183243354;406.28899426004494;407.22423782693977;412.9917401651967;17893;20258.6961195582;20687.896560517212;20997.47506312343;21081.683774743393;19540.609187816237;20572.89713551434;20779.16883324665;21600;21632.675509867364;4929.383827021631;5494.862628434281;5508.366537848138;5544.750486228129;5592.86017849553;4035.1727895781296;5499.862503437406;5503.284573005523;5968.1644569760265;6295.307516173218;6161.537884658646;6266.091416744569;6268.216472940882;6275.968620156893;6286;5418.241446197536;5883.70581470929;6153.753849846001;6686.765963191265;6830.965845170767;4762.809487620491;5079.8984020319385;5427.701476418795;6047.5766696331275;6090.786822461193;11855.051595872395;12342.938285308606;13482.325883705775;13720.93139534296;13747.518836840763;2079.6464601017865;2197.6923230747707;2202.9889850550803;2215.5125872308067;2344.5779759643256;9535.427874327494;9541.761455963588;9971.75070623233;10056.69829905104;10248;1620.3518592563069;1710.392810552261;1728.4468969929628;1778.4220128458303;1862.7299041639021;112053;131572.34213828965;135586;138323.30838345745;139090;11790.231465280105;11923.463444145034;12042.21725587834;12058.51765929353;12087.576934807239;15417.845821541641;15472.994255373365;15524.301406436738;15548.611284717746;15588.298526566332;8386.958065209636;8513.702020429255;9069.093090690878;9085;9141.680041198659;9044.81910361789;9144.3598948073;9172.8624070639;9248.630054797868;9299.814003720023;4659.627229821674;4748.3114948332295;4758.262469317261;4791.712497250176;4805.37530121082;1526.3665578784903;1912.728035856168;1958.7659774342073;1971.3198946363482;2013.9496512587302;954.7279025477706;967.1054274795786;1003.4079892863246;1050.0811789684026;1052.4264275969615;20082.694624849337;20279.783213007267;20693.68959465609;20787.68818467724;21334.679979800007;948.0850978805486;986.40815510693;1002.774375765447;1031.5203430404747;1051.3849398102195;10753.526299221965;11128;11142.610008649659;11197.384143872003;11223.382713950648;624351;635203;636989;637165;638009;139315.91026134617;140620.13181545917;143133;149577;150130.24934875255;1061.145777649;1063.6170978447599;1107.828286615576;1128.2046157458972;1130.5025788652965;18477;18849.90575047116;19035.619287613892;19269.903650481658;19303.93828339455;56568;56779;57208.85582288248;57362;57703.4229657698;81836.59081704554;85409.57295213484;85492.57253713692;86658.56670716606;87753;8158.102608713156;8163.591820409075;8205.630746616536;8380.20388063133;8401.495910245405;11487.655370338904;12582.622521324374;12593.622191334274;12884.162529435556;12974.156679815782;9398.624055037722;10963.671089867317;11033.724156896142;11077;11513.942430287794;10652.680419587425;10749.838752418877;10903.836442453528;11180.664580062612;11212.27120237182;11174.66476005721;11216.383098929637;11317.151213659174;11585.768284634429;11590.478428470571;8313.376496762889;8338.708145214889;8376.706815261437;8398.538080405391;8411.242988131098;10521.579136834442;11096.33421994683;11316.207865449669;11322.264052836868;11369.54521819118 03:40:34 INFO - PROCESS | 1666 | |3;mootools.html;1617.0378624718296;1644.4573290814033;1815.1559524820955;1899.1074195128285;1900.648380049691;6139.263288405397;7313.195548489662;7315.158756742976;8443.535605541692;8796.252318552915;8240;8315.958420207906;8365.832683346329;8384.077751447336;8386.62260198291;1881.8494520438367;2074.263636409068;2419.7459266777;2451.2646206138174;2453.9631905521433;2050;2406;2431.8540887546715;2440.694913135858;2447.0578827151585;2038.6228547718645;2430.5746494363416;2435.902563897442;2448.5470188015183;2472.5054989002183;2421.5278020785954;2426.3934016495878;2440.2679196241147;2445.4497738008986;2448.963265551018;2406.9398265043337;2425.629519321578;2457.201409541906;2477.7893879020303;2489.601663733794;8684.435511691783;8792.560371981375;8795.208431241219;8826.823463530693;8881.33389995753;5267.3152490176035;5474.7262636868;5481.451854814526;5485.4788795064405;5492.203630473599;2793.8044336896423;3445.913852153716;3574.803385813779;3584.9283014339826;3621.6016238213774;843.9957800211021;1034.3380236648552;1035.6271742172812;1045.3414348960107;1052.542144167282;11284.589426321792;11496.367699776509;11613.070954323633;11620.76758464826;11634.70913227176;4174;4816.229403295456;4875.2443371276795;4877.170880950176;4950.752462376939;7965.442419030613;9926.80146397068;9950.751231219132;9991.150752186146;10030.74923126913;5332.92000619991;5388.461153884658;5414.485623865727;5427.782888684408;5433.945660543423;4408.801603927831;4782.760861956888;4848.490908454632;4939.135651261015;4969.3291405659775;4033.274010678106;4115.061143366282;4124.670026397881;4148.502179738451;4159.376093585986;1343.1073989941567;1347.9123856949464;1352.9255890926092;1355.2884735513935;1370.5888233529902;820.3437250199817;865.536937738307;880.9471431714118;909.977250568741;957.1720461800493;5025.47232540578;5677;5858.56060795442;5891.793787217427;5911.940880591139;949.3307218411004;965.7682156282442;967.9691128947649;992.2805965674828;1002.8997100289913;3803.4294855771855;3878.1274213302345;3927.7446965947693;3955.802209889494;3975.4831871856472;10098.545565449573;10507.842382364272;10534.683959481228;10570.52432640533;10748.623798167184;10451.68644940653;10504.789904201873;10514.316569422963;10546.209034322303;10663.946680266548;7980.4812687175145;7993.440459167802;8223.01323841131;8253.711120110767;8412.284955778827;5683.602147849776;5804.21643078179;5878.588498805043;5883.411658834254;5931.970340148272;9780.26648001417;9959.402435853872;9967.152792012761;10039.096481316716;10053.04496072872;8242.670293188445;9764.218862490841;10020.34867733595;10055.245856560934;10072.949635251776;6362.77730279438;6757.155355580552;6821.624810635462;6985.1617805863625;7039.120109986252;7265;7323.645125651771;8115.147909469657;8140.470869393471;8264.21489958453;6885;7328.853422931618;7343.559386436831;7475.588842613708;7502.3622992046285;7325.157606875065;7332.670029848563;7350.411967042731;7358.632068396666;7373.631318434164;6127.019676851683;6774.051632771318;6846.315368463114;6880.58716477013;6926.515143939876;4168.8535652695755;4531.886702832456;4778.1399348117675;4838.903221935612;4882.658213924991;4904.607631389409;4904.945436730977;4979.203327467588;4987.625928055483;5108.131617625087 03:40:34 INFO - PROCESS | 1666 | |4;prototype.html;230.73119815415043;262.9263806134281;299.33099522567056;304.88414402527036;306.48663488656496;5370.140777475604;5475.72621368932;5539.806106786264;5615.915761263579;5652.325988107732;4211.431456753337;5248.107821670315;5523.558115350772;5580.720963951796;5597.384287728357;3866.381378979364;4216.915661686764;4220.109225180746;4230.3865939438765;4248.25655510286;3870.3033453978273;4154.563770804068;4216.156768646268;4229.386738922854;4229.942514371407;4036.3138266494766;4044.1102957349335;4067.97966010171;4087.795610219492;4093.2427500912277;3832.6550610445056;4061.6344528992386;4066.207089617526;4075.3886916962397;4092.9181416371507;3485.7037151842123;3485.9477107843404;3491.7555771096036;3505.3339865425487;3529.38235808735;4309.547497512747;4981.7831065176015;5320.388155362144;5342.893142137135;5363.302770639831;3678.393065144248;4095.89760255996;4692.536418380378;4759.904801903977;4762.261849413347;5565;5581.883623275361;5811.883762324772;5871.324797648283;5903.439173278574;3396.267903369275;3588.5334906461994;3901.1027463683513;3910.198409326081;3953.327934251184;5101.821436249714;5512.421195774426;5588.8542848715915;5857.619254748428;6169.198004259462;3165.0504848545343;3490.650934906489;3511.331388145028;3609.9819500902327;3957.980210098931;3404.774281258745;3424.126847653832;3671.6695497404826;4021.1153546219784;4024.114694767205;3812.675922546559;3836.961630383716;4667.579917807414;4694.737157675383;4754.5245475452175;5024.899502009939;5082.618803589746;5340.237721551878;5570.498655121059;5871.588988770831;1384.3424373422545;1398.81799879102;1416.978745318821;1451.9274036298143;1459.306829256116;757.4054367321626;910.7495438754396;937.2595649437005;947.6162154327509;957.1863915671762;4842.951570484321;5808.186853840466;5848.64908105515;5863.560232982543;5870.00419857242;6535.607863528204;6543.509236807258;6567.573107747981;6599.307072757388;6631.23740769808;5565.1930470082425;5856.502197313191;5857.531397488191;5860.355360910296;5894.263217097863;3395.2514455055666;3426.7601267911505;3438.570178727659;3438.5873695156743;3440.8795692150657;6052.818415447544;6436.292007879223;6656.7670131545165;6693.698783554752;6786.50696846693;6596.307387724316;6637.668116594151;6640.933590664128;6656.30108838565;6663.300353462817;6499.350064993558;6700.329967003261;6746.696398662072;6754.898676519856;6823.965880170567;6423.389777971085;6453.548251622529;6459.386358295955;6471.385218404433;6484.870302594016;6076.72654730547;6342.587731797418;6381.1704478417505;6410.551261411656;6450.225972883284;5423.755930983037;5910.822675319747;6221.3156552780065;6240.937590624036;6321.178246828067;3765.49165862616;3908.7654740715648;3980.3631418973982;3987.4018897165656;3989.0226894411053;4836.347093142381;5240.7641656126325;5349.010433069894;5804.245448091721;6132.068398454472;5515.531179849758;5838.277708076213;5848.84162552217;5852.27869040898;5912;4839.806407743651;5088.720120393414;5678.630888992202;5875.73671660595;5888.646681199141;5560.304961879765;5652.576056795675;5751.396103409082;5762.884742305214;5768.884622307614;5176.741162941763;5420.214068960057;5843.415658434123;5845.766169353178;5913.704314784158;4742.885421925914;5278.8944221116135;5566.304211973504;5599.608027438203;5783.016887129283 03:40:34 INFO - PROCESS | 1666 | |5;yui.html;616.4482787904823;653.3042309939916;699.8810202265614;722.3498851034069;771.3482107619062;14737.557873263806;14934.327955242014;15241.085534867916;15247.77128343073;15276.388944442222;12635.557755478538;13741.519046833362;15735.842641573581;15738.449154279573;15747.370105195778;719.2016861283971;909.6043221198767;918.9724308270729;920.0339643374464;921.0053142606002;895.2435192262528;929.1405449958795;938.7840796616782;939.281449690987;942.2509105261299;955.4553904274567;956.0582825916466;971.4996776660025;976.2092704909011;978.7602037500823;965.0783501755841;966.1884017425397;967.0909345215475;982.9213662907022;985.8225519406504;722.4328901812105;725.5392825555757;729.0704351951251;733.5891900535664;733.673515285698;15020.699586008328;15094.16982065986;15115.244237788176;15233.314500847488;15319.923400383039;10315.277930544866;12729.936350318281;12806.231626102464;12988.675283117904;12988.675283117998;9751.268654850914;10059.949700251525;10111.393316400967;10116.393016418964;10226.6420675276;3124.375124974991;3467.219875528011;3485.337785820686;3549.8580056797696;3554.626764189749;82028.58985705093;82327.58836205781;82336.35327293421;82756;83930.16069839346;9513.762155946019;9575.952120239353;9586.808263834684;9649.469279189572;9819.459929703935;22800.771992279864;22882;22897.969591368095;23207.955641996152;23319.76680233176;7486.288802563748;7652.885206721904;7660.80847978805;7781.844363112706;7798.025246844145;4076.5108187017154;4120.17596480705;4148.108156746314;4163.399795551776;4216.894577635584;3518.225990282185;3630.7821530708243;3640;3650.963490365062;3665.8716944907333;626.3548544998567;633.192679333853;639.9104125422444;648.3905129178652;651.5960104735094;572.7565784541553;583.5360888093976;587.1926101610286;589.6432658241788;607.271274470637;5754.913676294859;6966.616836073963;7687.923120768721;8131.064927533291;8319.875201871977;587.5064945445761;587.7531436796555;599.2240049136379;599.6402158704742;602.4969150759077;3699.1491956850077;3895.7078219133678;3908.2769687607315;3909.1204478992;4005.7396269242404;85587;88724;88817;91148.54425727962;100046;82989.75515367274;83197;83263;83791.58104209563;85575.288494231;65913;68498;73547.63226183834;73600;74674.12102367837;8032.277095061472;8261.752147435587;8325.708600198965;8357.373197010127;8440;45275.77362113168;45688.31467528056;46905;47163.76418117888;47210.819729507035;64451;67890.3210967884;68535;68680.96978545225;69646.65176674085;10948.34309941406;10990.725231869268;11113.777484476863;11230.438478075901;11544.249623774427;11964.521419143484;12018.939905300767;12086.637400877988;12106.213096148722;12140.210886292363;11137.777244455228;11309.547618095514;11355.318680879174;11448;11619.6514104577;11162.55349786032;11297.661070167907;11464.197506174487;11571.247868888495;12039;11153.996140347408;11158.609448669258;11174.329540227613;11333.036691881283;11587.710307242387;9497.620095196391;9514.33399662017;9525.285603579898;9568.234541236823;10099.44453055089;9447.669331573363;9502.857457138287;9699.951500242454;9708.223342132753;9760.560774765294 03:40:34 INFO - PROCESS | 1666 | __end_tp_report 03:40:34 INFO - PROCESS | 1666 | __start_cc_report 03:40:34 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,418 03:40:34 INFO - PROCESS | 1666 | __end_cc_report 03:40:34 INFO - PROCESS | 1666 | __startTimestamp1462531234522__endTimestamp 03:40:34 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | ------- Summary: start ------- 03:40:34 INFO - PROCESS | 1666 | Number of tests: 6 03:40:34 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5777.00 Median:5926.05 stddev:679.94 (11.5%) stddev-sans-first:637.62 03:40:34 INFO - PROCESS | 1666 | Values: 2695.8 3150.3 3520.9 3550.7 3570.6 5771.9 5780.1 5797.6 5807.9 5819.2 5788.9 5819.2 5824.2 5837.5 5849.8 5222.6 5259.9 5286.1 5299.3 5309.6 5153.5 5277.4 5311.1 5374.2 5382.9 5257.6 5274.2 5275.1 5276.5 5289.7 5222.0 5263.2 5267.3 5302.3 5320.3 5093.6 5198.4 5199.8 5203.5 5307.1 5183.2 5346.9 5779.5 5815.3 5820.8 6114.0 6264.0 6272.1 6273.3 6301.2 6206.1 6228.9 6290.7 6302.7 6338.1 5870.3 5897.7 5912.2 5916.3 5926.1 6344.7 6356.0 6367.6 6376.4 6377.4 6080.4 6145.7 6176.4 6241.8 6250.7 6307.8 6316.8 6342.8 6358.2 6361.9 6275.8 6302.4 6320.6 6321.9 6333.7 6146.3 6163.7 6247.3 6302.3 6314.9 4204.7 4886.7 4942.1 4948.0 4968.3 4337.7 4443.3 4444.4 4450.8 4489.7 5007.5 5854.1 5860.8 5875.8 5879.3 5218.5 6271.9 6283.8 6290.9 6313.9 5661.0 5776.7 5798.1 5835.5 5845.9 5413.7 5439.9 5446.3 5467.0 5498.8 6376.2 6400.0 6417.4 6421.2 6431.1 5488.5 6105.4 6226.9 6317.6 6322.4 6393.0 6407.7 6420.5 6436.3 6473.4 6295.2 6309.6 6317.4 6329.7 6333.4 6131.0 6166.1 6174.6 6251.9 6337.6 6211.6 6228.6 6233.6 6245.2 6255.6 6175.4 6177.4 6211.8 6217.2 6227.6 5814.9 5913.2 6016.7 6092.7 6112.0 5109.3 6182.4 6200.5 6237.7 6249.4 5441.2 5696.0 5893.8 6103.7 6113.3 03:40:34 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:60281.59 Median:37717.22 stddev:128623.93 (341.0%) stddev-sans-first:128906.50 03:40:34 INFO - PROCESS | 1666 | Values: 523.1 524.6 527.5 545.9 548.8 39058.6 40252.4 40260.8 40320.0 40373.8 36073.8 43191.8 44282.6 44347.9 44352.8 9482.1 9671.3 9748.2 9750.6 9767.8 9518.3 9627.5 9635.1 9650.5 9663.9 9556.4 9635.2 9652.0 9661.2 9703.3 9575.8 9638.6 9641.7 9664.9 9670.7 9591.5 9700.2 9705.7 9710.4 9713.3 39540.0 39849.8 40298.0 40310.8 40480.0 2734.3 3089.0 3091.6 3183.1 3279.3 19367.3 25639.5 26536.9 26636.0 27671.7 2648.7 2672.3 2676.9 2678.5 2716.6 302126.0 311495.0 314619.0 336858.0 345105.0 31419.5 32402.0 34762.0 36430.1 36508.3 34126.5 35633.1 35641.6 35774.0 36597.1 15693.6 15904.9 15910.8 15919.5 15944.0 11200.5 12925.9 13212.3 13218.8 13241.2 8303.8 8364.9 8505.2 8539.9 8558.2 3456.2 3467.4 3481.6 3505.3 3522.0 1049.1 1051.7 1086.9 1134.4 1158.9 26591.3 30199.1 31047.0 31063.0 31671.5 1024.3 1098.9 1141.3 1148.1 1153.1 11408.9 15626.3 15636.6 15875.6 15919.9 468269.0 476737.0 477471.0 477875.0 483149.0 63557.7 64861.7 65296.7 65369.3 65624.7 1550.1 1550.8 1554.2 1558.3 1560.9 26795.7 30121.8 31652.8 31978.8 32429.5 55895.7 56159.4 56411.2 56517.4 56640.7 596098.0 596392.0 606213.0 608104.9 608566.0 28364.9 28430.3 41033.0 42013.9 42763.1 43660.8 44687.3 44816.8 45930.5 46166.5 31188.3 38932.4 39023.8 39343.4 39847.2 37612.0 38280.2 38362.8 38652.0 38926.8 37620.6 37813.8 38136.2 38536.0 39267.0 32907.0 34092.8 34373.0 34442.7 34882.8 23018.1 24473.8 25435.0 25510.9 26097.5 03:40:34 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:36921.63 Median:20783.43 stddev:106457.39 (512.2%) stddev-sans-first:106720.71 03:40:34 INFO - PROCESS | 1666 | Values: 401.2 403.5 406.3 407.2 413.0 17893.0 20258.7 20687.9 20997.5 21081.7 19540.6 20572.9 20779.2 21600.0 21632.7 4929.4 5494.9 5508.4 5544.8 5592.9 4035.2 5499.9 5503.3 5968.2 6295.3 6161.5 6266.1 6268.2 6276.0 6286.0 5418.2 5883.7 6153.8 6686.8 6831.0 4762.8 5079.9 5427.7 6047.6 6090.8 11855.1 12342.9 13482.3 13720.9 13747.5 2079.6 2197.7 2203.0 2215.5 2344.6 9535.4 9541.8 9971.8 10056.7 10248.0 1620.4 1710.4 1728.4 1778.4 1862.7 112053.0 131572.3 135586.0 138323.3 139090.0 11790.2 11923.5 12042.2 12058.5 12087.6 15417.8 15473.0 15524.3 15548.6 15588.3 8387.0 8513.7 9069.1 9085.0 9141.7 9044.8 9144.4 9172.9 9248.6 9299.8 4659.6 4748.3 4758.3 4791.7 4805.4 1526.4 1912.7 1958.8 1971.3 2013.9 954.7 967.1 1003.4 1050.1 1052.4 20082.7 20279.8 20693.7 20787.7 21334.7 948.1 986.4 1002.8 1031.5 1051.4 10753.5 11128.0 11142.6 11197.4 11223.4 624351.0 635203.0 636989.0 637165.0 638009.0 139315.9 140620.1 143133.0 149577.0 150130.2 1061.1 1063.6 1107.8 1128.2 1130.5 18477.0 18849.9 19035.6 19269.9 19303.9 56568.0 56779.0 57208.9 57362.0 57703.4 81836.6 85409.6 85492.6 86658.6 87753.0 8158.1 8163.6 8205.6 8380.2 8401.5 11487.7 12582.6 12593.6 12884.2 12974.2 9398.6 10963.7 11033.7 11077.0 11513.9 10652.7 10749.8 10903.8 11180.7 11212.3 11174.7 11216.4 11317.2 11585.8 11590.5 8313.4 8338.7 8376.7 8398.5 8411.2 10521.6 11096.3 11316.2 11322.3 11369.5 03:40:34 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5594.25 Median:4944.94 stddev:3089.44 (62.5%) stddev-sans-first:3083.65 03:40:34 INFO - PROCESS | 1666 | Values: 1617.0 1644.5 1815.2 1899.1 1900.6 6139.3 7313.2 7315.2 8443.5 8796.3 8240.0 8316.0 8365.8 8384.1 8386.6 1881.8 2074.3 2419.7 2451.3 2454.0 2050.0 2406.0 2431.9 2440.7 2447.1 2038.6 2430.6 2435.9 2448.5 2472.5 2421.5 2426.4 2440.3 2445.4 2449.0 2406.9 2425.6 2457.2 2477.8 2489.6 8684.4 8792.6 8795.2 8826.8 8881.3 5267.3 5474.7 5481.5 5485.5 5492.2 2793.8 3445.9 3574.8 3584.9 3621.6 844.0 1034.3 1035.6 1045.3 1052.5 11284.6 11496.4 11613.1 11620.8 11634.7 4174.0 4816.2 4875.2 4877.2 4950.8 7965.4 9926.8 9950.8 9991.2 10030.7 5332.9 5388.5 5414.5 5427.8 5433.9 4408.8 4782.8 4848.5 4939.1 4969.3 4033.3 4115.1 4124.7 4148.5 4159.4 1343.1 1347.9 1352.9 1355.3 1370.6 820.3 865.5 880.9 910.0 957.2 5025.5 5677.0 5858.6 5891.8 5911.9 949.3 965.8 968.0 992.3 1002.9 3803.4 3878.1 3927.7 3955.8 3975.5 10098.5 10507.8 10534.7 10570.5 10748.6 10451.7 10504.8 10514.3 10546.2 10663.9 7980.5 7993.4 8223.0 8253.7 8412.3 5683.6 5804.2 5878.6 5883.4 5932.0 9780.3 9959.4 9967.2 10039.1 10053.0 8242.7 9764.2 10020.3 10055.2 10072.9 6362.8 6757.2 6821.6 6985.2 7039.1 7265.0 7323.6 8115.1 8140.5 8264.2 6885.0 7328.9 7343.6 7475.6 7502.4 7325.2 7332.7 7350.4 7358.6 7373.6 6127.0 6774.1 6846.3 6880.6 6926.5 4168.9 4531.9 4778.1 4838.9 4882.7 4904.6 4904.9 4979.2 4987.6 5108.1 03:40:34 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4788.54 Median:5395.18 stddev:1566.75 (29.0%) stddev-sans-first:1533.34 03:40:34 INFO - PROCESS | 1666 | Values: 230.7 262.9 299.3 304.9 306.5 5370.1 5475.7 5539.8 5615.9 5652.3 4211.4 5248.1 5523.6 5580.7 5597.4 3866.4 4216.9 4220.1 4230.4 4248.3 3870.3 4154.6 4216.2 4229.4 4229.9 4036.3 4044.1 4068.0 4087.8 4093.2 3832.7 4061.6 4066.2 4075.4 4092.9 3485.7 3485.9 3491.8 3505.3 3529.4 4309.5 4981.8 5320.4 5342.9 5363.3 3678.4 4095.9 4692.5 4759.9 4762.3 5565.0 5581.9 5811.9 5871.3 5903.4 3396.3 3588.5 3901.1 3910.2 3953.3 5101.8 5512.4 5588.9 5857.6 6169.2 3165.1 3490.7 3511.3 3610.0 3958.0 3404.8 3424.1 3671.7 4021.1 4024.1 3812.7 3837.0 4667.6 4694.7 4754.5 5024.9 5082.6 5340.2 5570.5 5871.6 1384.3 1398.8 1417.0 1451.9 1459.3 757.4 910.7 937.3 947.6 957.2 4843.0 5808.2 5848.6 5863.6 5870.0 6535.6 6543.5 6567.6 6599.3 6631.2 5565.2 5856.5 5857.5 5860.4 5894.3 3395.3 3426.8 3438.6 3438.6 3440.9 6052.8 6436.3 6656.8 6693.7 6786.5 6596.3 6637.7 6640.9 6656.3 6663.3 6499.4 6700.3 6746.7 6754.9 6824.0 6423.4 6453.5 6459.4 6471.4 6484.9 6076.7 6342.6 6381.2 6410.6 6450.2 5423.8 5910.8 6221.3 6240.9 6321.2 3765.5 3908.8 3980.4 3987.4 3989.0 4836.3 5240.8 5349.0 5804.2 6132.1 5515.5 5838.3 5848.8 5852.3 5912.0 4839.8 5088.7 5678.6 5875.7 5888.6 5560.3 5652.6 5751.4 5762.9 5768.9 5176.7 5420.2 5843.4 5845.8 5913.7 4742.9 5278.9 5566.3 5599.6 5783.0 03:40:34 INFO - PROCESS | 1666 | 03:40:34 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18470.54 Median:604.88 stddev:26078.68 (4311.4%) stddev-sans-first:26117.38 03:40:34 INFO - PROCESS | 1666 | Values: 616.4 653.3 699.9 722.3 771.3 14737.6 14934.3 15241.1 15247.8 15276.4 12635.6 13741.5 15735.8 15738.4 15747.4 719.2 909.6 919.0 920.0 921.0 895.2 929.1 938.8 939.3 942.3 955.5 956.1 971.5 976.2 978.8 965.1 966.2 967.1 982.9 985.8 722.4 725.5 729.1 733.6 733.7 15020.7 15094.2 15115.2 15233.3 15319.9 10315.3 12729.9 12806.2 12988.7 12988.7 9751.3 10059.9 10111.4 10116.4 10226.6 3124.4 3467.2 3485.3 3549.9 3554.6 82028.6 82327.6 82336.4 82756.0 83930.2 9513.8 9576.0 9586.8 9649.5 9819.5 22800.8 22882.0 22898.0 23208.0 23319.8 7486.3 7652.9 7660.8 7781.8 7798.0 4076.5 4120.2 4148.1 4163.4 4216.9 3518.2 3630.8 3640.0 3651.0 3665.9 626.4 633.2 639.9 648.4 651.6 572.8 583.5 587.2 589.6 607.3 5754.9 6966.6 7687.9 8131.1 8319.9 587.5 587.8 599.2 599.6 602.5 3699.1 3895.7 3908.3 3909.1 4005.7 85587.0 88724.0 88817.0 91148.5 100046.0 82989.8 83197.0 83263.0 83791.6 85575.3 65913.0 68498.0 73547.6 73600.0 74674.1 8032.3 8261.8 8325.7 8357.4 8440.0 45275.8 45688.3 46905.0 47163.8 47210.8 64451.0 67890.3 68535.0 68681.0 69646.7 10948.3 10990.7 11113.8 11230.4 11544.2 11964.5 12018.9 12086.6 12106.2 12140.2 11137.8 11309.5 11355.3 11448.0 11619.7 11162.6 11297.7 11464.2 11571.2 12039.0 11154.0 11158.6 11174.3 11333.0 11587.7 9497.6 9514.3 9525.3 9568.2 10099.4 9447.7 9502.9 9700.0 9708.2 9760.6 03:40:34 INFO - PROCESS | 1666 | -------- Summary: end -------- 03:40:34 INFO - PROCESS | 1666 | 03:40:35 INFO - TEST-INFO | 1666: exit 0 03:40:35 INFO - TEST-OK | dromaeo_css | took 1112191ms 03:40:35 INFO - TEST-START | kraken 03:40:35 INFO - operating with platform_type : mac_ 03:40:35 INFO - Initialising browser for kraken test... 03:40:35 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpDUEBG5/profile http://localhost:49275/getInfo.html) 03:40:37 INFO - PROCESS | 1700 | __metrics Screen width/height:1600/1200 03:40:37 INFO - PROCESS | 1700 | colorDepth:24 03:40:37 INFO - PROCESS | 1700 | Browser inner width/height: 1024/689 03:40:37 INFO - PROCESS | 1700 | __metrics 03:40:37 ERROR - PROCESS | 1700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:40:38 INFO - TEST-INFO | 1700: exit 0 03:40:38 INFO - Browser initialized. 03:40:38 INFO - Running cycle 1/1 for kraken test... 03:40:38 INFO - TEST-INFO | started process 1703 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpDUEBG5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:50 INFO - PROCESS | 1703 | RSS: Main: 221470720 03:40:50 INFO - PROCESS | 1703 | 03:40:53 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:54 INFO - PROCESS | 1703 | RSS: Main: 233529344 03:40:54 INFO - PROCESS | 1703 | 03:40:57 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 03:40:57 INFO - PROCESS | 1703 | RSS: Main: 242937856 03:40:57 INFO - PROCESS | 1703 | 03:41:01 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 03:41:01 INFO - PROCESS | 1703 | RSS: Main: 245932032 03:41:01 INFO - PROCESS | 1703 | 03:41:03 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 03:41:04 INFO - PROCESS | 1703 | RSS: Main: 247959552 03:41:04 INFO - PROCESS | 1703 | 03:41:06 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:07 INFO - PROCESS | 1703 | RSS: Main: 248430592 03:41:07 INFO - PROCESS | 1703 | 03:41:10 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:10 INFO - PROCESS | 1703 | RSS: Main: 248184832 03:41:10 INFO - PROCESS | 1703 | 03:41:13 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:14 INFO - PROCESS | 1703 | RSS: Main: 248303616 03:41:14 INFO - PROCESS | 1703 | 03:41:17 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 03:41:17 INFO - PROCESS | 1703 | RSS: Main: 248438784 03:41:17 INFO - PROCESS | 1703 | 03:41:19 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:20 INFO - PROCESS | 1703 | RSS: Main: 248107008 03:41:20 INFO - PROCESS | 1703 | 03:41:21 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:22 INFO - PROCESS | 1703 | RSS: Main: 248086528 03:41:22 INFO - PROCESS | 1703 | 03:41:24 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:25 INFO - PROCESS | 1703 | RSS: Main: 249004032 03:41:25 INFO - PROCESS | 1703 | 03:41:28 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:29 INFO - PROCESS | 1703 | RSS: Main: 248475648 03:41:29 INFO - PROCESS | 1703 | 03:41:31 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:32 INFO - PROCESS | 1703 | RSS: Main: 248438784 03:41:32 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 03:41:34 INFO - PROCESS | 1703 | RSS: Main: 250372096 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | __start_tp_report 03:41:34 INFO - PROCESS | 1703 | _x_x_mozilla_page_load 03:41:34 INFO - PROCESS | 1703 | _x_x_mozilla_page_load_details 03:41:34 INFO - PROCESS | 1703 | |i|pagename|runs| 03:41:34 INFO - PROCESS | 1703 | |0;ai-astar;166;168;166;119;121;195;171;117;118;114 03:41:34 INFO - PROCESS | 1703 | |1;audio-beat-detection;146;123;145;167;150;156;127;151;161;127 03:41:34 INFO - PROCESS | 1703 | |2;audio-dft;195;220;201;200;231;262;195;196;195;195 03:41:34 INFO - PROCESS | 1703 | |3;audio-fft;64;73;78;142;62;47;55;68;149;89 03:41:34 INFO - PROCESS | 1703 | |4;audio-oscillator;77;85;137;78;79;84;120;81;79;122 03:41:34 INFO - PROCESS | 1703 | |5;imaging-gaussian-blur;136;129;90;88;90;86;91;115;98;132 03:41:34 INFO - PROCESS | 1703 | |6;imaging-darkroom;96;97;125;97;139;154;117;96;94;97 03:41:34 INFO - PROCESS | 1703 | |7;imaging-desaturate;91;94;91;90;91;94;90;149;100;90 03:41:34 INFO - PROCESS | 1703 | |8;json-parse-financial;61;66;66;66;65;65;65;83;65;59 03:41:34 INFO - PROCESS | 1703 | |9;json-stringify-tinderbox;63;66;72;71;78;76;71;68;68;68 03:41:34 INFO - PROCESS | 1703 | |10;stanford-crypto-aes;93;110;104;83;84;82;82;81;84;85 03:41:34 INFO - PROCESS | 1703 | |11;stanford-crypto-ccm;136;139;140;158;158;135;139;137;195;160 03:41:34 INFO - PROCESS | 1703 | |12;stanford-crypto-pbkdf2;166;223;219;168;169;167;178;165;165;166 03:41:34 INFO - PROCESS | 1703 | |13;stanford-crypto-sha256-iterative;70;68;87;89;84;67;65;70;70;66 03:41:34 INFO - PROCESS | 1703 | __end_tp_report 03:41:34 INFO - PROCESS | 1703 | __start_cc_report 03:41:34 INFO - PROCESS | 1703 | _x_x_mozilla_cycle_collect,1094 03:41:34 INFO - PROCESS | 1703 | __end_cc_report 03:41:34 INFO - PROCESS | 1703 | __startTimestamp1462531294581__endTimestamp 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | ------- Summary: start ------- 03:41:34 INFO - PROCESS | 1703 | Number of tests: 14 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#0] ai-astar Cycles:10 Average:145.50 Median:166.00 stddev:30.39 (18.3%) stddev-sans-first:31.31 03:41:34 INFO - PROCESS | 1703 | Values: 166.0 168.0 166.0 119.0 121.0 195.0 171.0 117.0 118.0 114.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:150.50 stddev:15.11 (10.0%) stddev-sans-first:16.02 03:41:34 INFO - PROCESS | 1703 | Values: 146.0 123.0 145.0 167.0 150.0 156.0 127.0 151.0 161.0 127.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#2] audio-dft Cycles:10 Average:209.00 Median:200.50 stddev:22.39 (11.2%) stddev-sans-first:23.17 03:41:34 INFO - PROCESS | 1703 | Values: 195.0 220.0 201.0 200.0 231.0 262.0 195.0 196.0 195.0 195.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#3] audio-fft Cycles:10 Average:82.70 Median:66.00 stddev:35.13 (53.2%) stddev-sans-first:36.60 03:41:34 INFO - PROCESS | 1703 | Values: 64.0 73.0 78.0 142.0 62.0 47.0 55.0 68.0 149.0 89.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.00 stddev:22.74 (28.8%) stddev-sans-first:23.25 03:41:34 INFO - PROCESS | 1703 | Values: 77.0 85.0 137.0 78.0 79.0 84.0 120.0 81.0 79.0 122.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#5] imaging-gaussian-blur Cycles:10 Average:105.50 Median:89.00 stddev:20.30 (22.8%) stddev-sans-first:18.29 03:41:34 INFO - PROCESS | 1703 | Values: 136.0 129.0 90.0 88.0 90.0 86.0 91.0 115.0 98.0 132.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#6] imaging-darkroom Cycles:10 Average:111.20 Median:96.00 stddev:21.58 (22.5%) stddev-sans-first:22.18 03:41:34 INFO - PROCESS | 1703 | Values: 96.0 97.0 125.0 97.0 139.0 154.0 117.0 96.0 94.0 97.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:91.00 stddev:18.18 (20.0%) stddev-sans-first:19.11 03:41:34 INFO - PROCESS | 1703 | Values: 91.0 94.0 91.0 90.0 91.0 94.0 90.0 149.0 100.0 90.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.50 stddev:6.38 (9.7%) stddev-sans-first:6.50 03:41:34 INFO - PROCESS | 1703 | Values: 61.0 66.0 66.0 66.0 65.0 65.0 65.0 83.0 65.0 59.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:4.51 (6.3%) stddev-sans-first:3.98 03:41:34 INFO - PROCESS | 1703 | Values: 63.0 66.0 72.0 71.0 78.0 76.0 71.0 68.0 68.0 68.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:83.50 stddev:10.25 (12.3%) stddev-sans-first:10.76 03:41:34 INFO - PROCESS | 1703 | Values: 93.0 110.0 104.0 83.0 84.0 82.0 82.0 81.0 84.0 85.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#11] stanford-crypto-ccm Cycles:10 Average:149.70 Median:149.00 stddev:18.81 (12.6%) stddev-sans-first:19.29 03:41:34 INFO - PROCESS | 1703 | Values: 136.0 139.0 140.0 158.0 158.0 135.0 139.0 137.0 195.0 160.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:168.50 stddev:22.68 (13.5%) stddev-sans-first:23.60 03:41:34 INFO - PROCESS | 1703 | Values: 166.0 223.0 219.0 168.0 169.0 167.0 178.0 165.0 165.0 166.0 03:41:34 INFO - PROCESS | 1703 | 03:41:34 INFO - PROCESS | 1703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:70.00 stddev:9.25 (13.2%) stddev-sans-first:9.72 03:41:34 INFO - PROCESS | 1703 | Values: 70.0 68.0 87.0 89.0 84.0 67.0 65.0 70.0 70.0 66.0 03:41:34 INFO - PROCESS | 1703 | -------- Summary: end -------- 03:41:34 INFO - PROCESS | 1703 | 03:41:35 INFO - TEST-INFO | 1703: exit 0 03:41:35 INFO - TEST-OK | kraken | took 60154ms 03:41:35 INFO - SUITE-END | took 1172s 03:41:35 INFO - Completed test suite (00:19:32) 03:41:35 INFO - javascript benchmark 03:41:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2695.8247713898595, 3150.3384289299247, 3520.9119772005697, 3550.7159427245824, 3570.5715314162303, 5771.913421298684, 5780.104083866997, 5797.623154494955, 5807.883842323151, 5819.185314056031, 5788.942110578893, 5819.214406055181, 5824.242848429698, 5837.532997360212, 5849.824505264849, 5222.608304377168, 5259.947400525984, 5286.127788914824, 5299.311089558371, 5309.62832601718, 5153.510416510426, 5277.419483856773, 5311.097113490716, 5374.167004114369, 5382.8923421531545, 5257.553107985826, 5274.235235890794, 5275.050490911634, 5276.498732620395, 5289.735513224324, 5222.0, 5263.236830659533, 5267.288915996349, 5302.310699609065, 5320.281761962125, 5093.643444958854, 5198.40218374888, 5199.818006369759, 5203.505666961671, 5307.097793375096, 5183.196604526304, 5346.946530534684, 5779.508741756956, 5815.302163740378, 5820.825375238707, 6114.0, 6263.997760358367, 6272.090546870724, 6273.278572964122, 6301.243850737895, 6206.100115483229, 6228.906566401508, 6290.685465726695, 6302.747890084391, 6338.144350512668, 5870.295564532284, 5897.734601942923, 5912.17229587858, 5916.290045194604, 5926.051831706949, 6344.714487848058, 6356.0, 6367.649779262092, 6376.39424254695, 6377.426031657174, 6080.391960803972, 6145.678679083929, 6176.4441200292185, 6241.812745617639, 6250.74997000124, 6307.779227727007, 6316.810495685137, 6342.809715708444, 6358.237011558643, 6361.936380636227, 6275.811725648238, 6302.369763023661, 6320.62076275425, 6321.905171422432, 6333.65164915934, 6146.293176284785, 6163.691815409301, 6247.312795592481, 6302.275238347649, 6314.873702525923, 4204.66362690984, 4886.706797592155, 4942.085714142895, 4947.950520494821, 4968.329275547755, 4337.674674399433, 4443.266860967969, 4444.355568442557, 4450.844220452269, 4489.685721999429, 5007.474215207423, 5854.092615644582, 5860.794872179454, 5875.823725288248, 5879.323877754027, 5218.452062533455, 6271.937280627135, 6283.842903927439, 6290.937090629035, 6313.9368606314265, 5661.0, 5776.68228247442, 5798.130280457881, 5835.533157347402, 5845.853853653608, 5413.675179489164, 5439.945600543944, 5446.2647542582035, 5467.0, 5498.835034948958, 6376.202974628171, 6399.976003839456, 6417.422431981144, 6421.197350331208, 6431.13179720741, 5488.506034456918, 6105.358937311518, 6226.875462490815, 6317.557770955989, 6322.430981211529, 6392.963048014572, 6407.743690252338, 6420.518461115528, 6436.292007879223, 6473.385028422293, 6295.244570651368, 6309.621422714652, 6317.431431171217, 6329.651869147241, 6333.366663333814, 6131.049687298476, 6166.136740856194, 6174.629522228681, 6251.937480625135, 6337.556371053982, 6211.596246243979, 6228.564000520101, 6233.594816337105, 6245.219347581552, 6255.624662520263, 6175.44421002112, 6177.382261773787, 6211.81364559064, 6217.222847144107, 6227.595206311576, 5814.912776308443, 5913.201717768046, 6016.729247183975, 6092.664903430354, 6112.0, 5109.335786347751, 6182.443580077815, 6200.503959683305, 6237.7193026314835, 6249.406306400884, 5441.238226648352, 5695.971520142372, 5893.793717219876, 6103.725332359965, 6113.266408031065], "value": 5732.2164772311025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.1498814426557, 524.6406211744955, 527.5357685236992, 545.9426760190178, 548.7695168029427, 39058.609413905855, 40252.396214056775, 40260.79869600648, 40319.99200020004, 40373.798131009375, 36073.819630901875, 43191.78404107983, 44282.55717442824, 44347.89130271745, 44352.778236108774, 9482.146606805387, 9671.323007389485, 9748.171405430547, 9750.609975600968, 9767.804643907117, 9518.333716639838, 9627.470489123096, 9635.084666956627, 9650.469224192666, 9663.903360966406, 9556.426614403123, 9635.22918166545, 9651.95174024129, 9661.227101831872, 9703.272254580934, 9575.760605984837, 9638.614455421775, 9641.710748677551, 9664.903350966471, 9670.70987870358, 9591.520423978773, 9700.223982081487, 9705.708828735149, 9710.417374957526, 9713.271504637181, 39540.0, 39849.80075099635, 40298.0, 40310.79844600787, 40480.0, 2734.302752798024, 3088.9536656950163, 3091.5517249998625, 3183.1405520509566, 3279.262166012628, 19367.322143725043, 25639.48721025569, 26536.86731566349, 26636.0, 27671.723282767318, 2648.6689163854517, 2672.2651270900465, 2676.906308279201, 2678.504476671822, 2716.619673245747, 302125.978740212, 311495.0, 314619.0, 336858.0, 345105.0, 31419.528707069414, 32402.027939161864, 34762.0, 36430.08924776902, 36508.26983460369, 34126.48810267848, 35633.1091722709, 35641.64358356435, 35774.0, 36597.08507287339, 15693.607659808367, 15904.920475397781, 15910.76133857993, 15919.522414327588, 15944.0, 11200.495977681025, 12925.935370323088, 13212.33938303081, 13218.801717974238, 13241.205527668179, 8303.792405189919, 8364.916350836414, 8505.23452889243, 8539.871901921477, 8558.229759321692, 3456.2223499712363, 3467.4452087665854, 3481.617022127564, 3505.2638945821154, 3522.031441353597, 1049.1063630147505, 1051.7370657335666, 1086.8695756509112, 1134.4044376702132, 1158.8609366876028, 26591.33521661974, 30199.09402717922, 31047.0, 31063.0, 31671.524927126113, 1024.2778840917135, 1098.9395583243, 1141.3494308244221, 1148.0815347721789, 1153.0948205658685, 11408.88591114095, 15626.296816643278, 15636.609084772972, 15875.603109922344, 15919.88560800756, 468269.0, 476737.0, 477471.0, 477875.0, 483149.0, 63557.72884542376, 64861.67569162124, 65296.69406611936, 65369.34630653728, 65624.6718766403, 1550.0854495847504, 1550.7518796992654, 1554.1529866222936, 1558.290977605187, 1560.8985415947927, 26795.732042679323, 30121.84939075378, 31652.841735791175, 31978.84010579932, 32429.513557296188, 55895.72052139713, 56159.43840561542, 56411.15383269172, 56517.43482565122, 56640.716796415756, 596098.0, 596392.0, 606213.0, 608104.9189508049, 608565.9571702114, 28364.85817570899, 28430.289242769097, 41033.0, 42013.94965125896, 42763.14473710571, 43660.78169609132, 44687.32969005402, 44816.77591612021, 45930.54069459263, 46166.53833461623, 31188.34103083261, 38932.41601376038, 39023.80488097541, 39343.426262949164, 39847.203055939295, 37612.0, 38280.234395312495, 38362.84911452661, 38652.0, 38926.83219503419, 37620.62379376281, 37813.81093094517, 38136.23727525489, 38536.0, 39267.0, 32907.0, 34092.829535852165, 34373.0, 34442.65557344495, 34882.825585871906, 23018.07927682874, 24473.755262447146, 25435.0, 25510.872445638397, 26097.478050439266], "value": 18360.139665830415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.1695789715289, 403.5339183243354, 406.28899426004494, 407.22423782693977, 412.9917401651967, 17893.0, 20258.6961195582, 20687.896560517212, 20997.47506312343, 21081.683774743393, 19540.609187816237, 20572.89713551434, 20779.16883324665, 21600.0, 21632.675509867364, 4929.383827021631, 5494.862628434281, 5508.366537848138, 5544.750486228129, 5592.86017849553, 4035.1727895781296, 5499.862503437406, 5503.284573005523, 5968.1644569760265, 6295.307516173218, 6161.537884658646, 6266.091416744569, 6268.216472940882, 6275.968620156893, 6286.0, 5418.241446197536, 5883.70581470929, 6153.753849846001, 6686.765963191265, 6830.965845170767, 4762.809487620491, 5079.8984020319385, 5427.701476418795, 6047.5766696331275, 6090.786822461193, 11855.051595872395, 12342.938285308606, 13482.325883705775, 13720.93139534296, 13747.518836840763, 2079.6464601017865, 2197.6923230747707, 2202.9889850550803, 2215.5125872308067, 2344.5779759643256, 9535.427874327494, 9541.761455963588, 9971.75070623233, 10056.69829905104, 10248.0, 1620.3518592563069, 1710.392810552261, 1728.4468969929628, 1778.4220128458303, 1862.7299041639021, 112053.0, 131572.34213828965, 135586.0, 138323.30838345745, 139090.0, 11790.231465280105, 11923.463444145034, 12042.21725587834, 12058.51765929353, 12087.576934807239, 15417.845821541641, 15472.994255373365, 15524.301406436738, 15548.611284717746, 15588.298526566332, 8386.958065209636, 8513.702020429255, 9069.093090690878, 9085.0, 9141.680041198659, 9044.81910361789, 9144.3598948073, 9172.8624070639, 9248.630054797868, 9299.814003720023, 4659.627229821674, 4748.3114948332295, 4758.262469317261, 4791.712497250176, 4805.37530121082, 1526.3665578784903, 1912.728035856168, 1958.7659774342073, 1971.3198946363482, 2013.9496512587302, 954.7279025477706, 967.1054274795786, 1003.4079892863246, 1050.0811789684026, 1052.4264275969615, 20082.694624849337, 20279.783213007267, 20693.68959465609, 20787.68818467724, 21334.679979800007, 948.0850978805486, 986.40815510693, 1002.774375765447, 1031.5203430404747, 1051.3849398102195, 10753.526299221965, 11128.0, 11142.610008649659, 11197.384143872003, 11223.382713950648, 624351.0, 635203.0, 636989.0, 637165.0, 638009.0, 139315.91026134617, 140620.13181545917, 143133.0, 149577.0, 150130.24934875255, 1061.145777649, 1063.6170978447599, 1107.828286615576, 1128.2046157458972, 1130.5025788652965, 18477.0, 18849.90575047116, 19035.619287613892, 19269.903650481658, 19303.93828339455, 56568.0, 56779.0, 57208.85582288248, 57362.0, 57703.4229657698, 81836.59081704554, 85409.57295213484, 85492.57253713692, 86658.56670716606, 87753.0, 8158.102608713156, 8163.591820409075, 8205.630746616536, 8380.20388063133, 8401.495910245405, 11487.655370338904, 12582.622521324374, 12593.622191334274, 12884.162529435556, 12974.156679815782, 9398.624055037722, 10963.671089867317, 11033.724156896142, 11077.0, 11513.942430287794, 10652.680419587425, 10749.838752418877, 10903.836442453528, 11180.664580062612, 11212.27120237182, 11174.66476005721, 11216.383098929637, 11317.151213659174, 11585.768284634429, 11590.478428470571, 8313.376496762889, 8338.708145214889, 8376.706815261437, 8398.538080405391, 8411.242988131098, 10521.579136834442, 11096.33421994683, 11316.207865449669, 11322.264052836868, 11369.54521819118], "value": 9634.952691560027, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1617.0378624718296, 1644.4573290814033, 1815.1559524820955, 1899.1074195128285, 1900.648380049691, 6139.263288405397, 7313.195548489662, 7315.158756742976, 8443.535605541692, 8796.252318552915, 8240.0, 8315.958420207906, 8365.832683346329, 8384.077751447336, 8386.62260198291, 1881.8494520438367, 2074.263636409068, 2419.7459266777, 2451.2646206138174, 2453.9631905521433, 2050.0, 2406.0, 2431.8540887546715, 2440.694913135858, 2447.0578827151585, 2038.6228547718645, 2430.5746494363416, 2435.902563897442, 2448.5470188015183, 2472.5054989002183, 2421.5278020785954, 2426.3934016495878, 2440.2679196241147, 2445.4497738008986, 2448.963265551018, 2406.9398265043337, 2425.629519321578, 2457.201409541906, 2477.7893879020303, 2489.601663733794, 8684.435511691783, 8792.560371981375, 8795.208431241219, 8826.823463530693, 8881.33389995753, 5267.3152490176035, 5474.7262636868, 5481.451854814526, 5485.4788795064405, 5492.203630473599, 2793.8044336896423, 3445.913852153716, 3574.803385813779, 3584.9283014339826, 3621.6016238213774, 843.9957800211021, 1034.3380236648552, 1035.6271742172812, 1045.3414348960107, 1052.542144167282, 11284.589426321792, 11496.367699776509, 11613.070954323633, 11620.76758464826, 11634.70913227176, 4174.0, 4816.229403295456, 4875.2443371276795, 4877.170880950176, 4950.752462376939, 7965.442419030613, 9926.80146397068, 9950.751231219132, 9991.150752186146, 10030.74923126913, 5332.92000619991, 5388.461153884658, 5414.485623865727, 5427.782888684408, 5433.945660543423, 4408.801603927831, 4782.760861956888, 4848.490908454632, 4939.135651261015, 4969.3291405659775, 4033.274010678106, 4115.061143366282, 4124.670026397881, 4148.502179738451, 4159.376093585986, 1343.1073989941567, 1347.9123856949464, 1352.9255890926092, 1355.2884735513935, 1370.5888233529902, 820.3437250199817, 865.536937738307, 880.9471431714118, 909.977250568741, 957.1720461800493, 5025.47232540578, 5677.0, 5858.56060795442, 5891.793787217427, 5911.940880591139, 949.3307218411004, 965.7682156282442, 967.9691128947649, 992.2805965674828, 1002.8997100289913, 3803.4294855771855, 3878.1274213302345, 3927.7446965947693, 3955.802209889494, 3975.4831871856472, 10098.545565449573, 10507.842382364272, 10534.683959481228, 10570.52432640533, 10748.623798167184, 10451.68644940653, 10504.789904201873, 10514.316569422963, 10546.209034322303, 10663.946680266548, 7980.4812687175145, 7993.440459167802, 8223.01323841131, 8253.711120110767, 8412.284955778827, 5683.602147849776, 5804.21643078179, 5878.588498805043, 5883.411658834254, 5931.970340148272, 9780.26648001417, 9959.402435853872, 9967.152792012761, 10039.096481316716, 10053.04496072872, 8242.670293188445, 9764.218862490841, 10020.34867733595, 10055.245856560934, 10072.949635251776, 6362.77730279438, 6757.155355580552, 6821.624810635462, 6985.1617805863625, 7039.120109986252, 7265.0, 7323.645125651771, 8115.147909469657, 8140.470869393471, 8264.21489958453, 6885.0, 7328.853422931618, 7343.559386436831, 7475.588842613708, 7502.3622992046285, 7325.157606875065, 7332.670029848563, 7350.411967042731, 7358.632068396666, 7373.631318434164, 6127.019676851683, 6774.051632771318, 6846.315368463114, 6880.58716477013, 6926.515143939876, 4168.8535652695755, 4531.886702832456, 4778.1399348117675, 4838.903221935612, 4882.658213924991, 4904.607631389409, 4904.945436730977, 4979.203327467588, 4987.625928055483, 5108.131617625087], "value": 4539.001155797018, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [230.73119815415043, 262.9263806134281, 299.33099522567056, 304.88414402527036, 306.48663488656496, 5370.140777475604, 5475.72621368932, 5539.806106786264, 5615.915761263579, 5652.325988107732, 4211.431456753337, 5248.107821670315, 5523.558115350772, 5580.720963951796, 5597.384287728357, 3866.381378979364, 4216.915661686764, 4220.109225180746, 4230.3865939438765, 4248.25655510286, 3870.3033453978273, 4154.563770804068, 4216.156768646268, 4229.386738922854, 4229.942514371407, 4036.3138266494766, 4044.1102957349335, 4067.97966010171, 4087.795610219492, 4093.2427500912277, 3832.6550610445056, 4061.6344528992386, 4066.207089617526, 4075.3886916962397, 4092.9181416371507, 3485.7037151842123, 3485.9477107843404, 3491.7555771096036, 3505.3339865425487, 3529.38235808735, 4309.547497512747, 4981.7831065176015, 5320.388155362144, 5342.893142137135, 5363.302770639831, 3678.393065144248, 4095.89760255996, 4692.536418380378, 4759.904801903977, 4762.261849413347, 5565.0, 5581.883623275361, 5811.883762324772, 5871.324797648283, 5903.439173278574, 3396.267903369275, 3588.5334906461994, 3901.1027463683513, 3910.198409326081, 3953.327934251184, 5101.821436249714, 5512.421195774426, 5588.8542848715915, 5857.619254748428, 6169.198004259462, 3165.0504848545343, 3490.650934906489, 3511.331388145028, 3609.9819500902327, 3957.980210098931, 3404.774281258745, 3424.126847653832, 3671.6695497404826, 4021.1153546219784, 4024.114694767205, 3812.675922546559, 3836.961630383716, 4667.579917807414, 4694.737157675383, 4754.5245475452175, 5024.899502009939, 5082.618803589746, 5340.237721551878, 5570.498655121059, 5871.588988770831, 1384.3424373422545, 1398.81799879102, 1416.978745318821, 1451.9274036298143, 1459.306829256116, 757.4054367321626, 910.7495438754396, 937.2595649437005, 947.6162154327509, 957.1863915671762, 4842.951570484321, 5808.186853840466, 5848.64908105515, 5863.560232982543, 5870.00419857242, 6535.607863528204, 6543.509236807258, 6567.573107747981, 6599.307072757388, 6631.23740769808, 5565.1930470082425, 5856.502197313191, 5857.531397488191, 5860.355360910296, 5894.263217097863, 3395.2514455055666, 3426.7601267911505, 3438.570178727659, 3438.5873695156743, 3440.8795692150657, 6052.818415447544, 6436.292007879223, 6656.7670131545165, 6693.698783554752, 6786.50696846693, 6596.307387724316, 6637.668116594151, 6640.933590664128, 6656.30108838565, 6663.300353462817, 6499.350064993558, 6700.329967003261, 6746.696398662072, 6754.898676519856, 6823.965880170567, 6423.389777971085, 6453.548251622529, 6459.386358295955, 6471.385218404433, 6484.870302594016, 6076.72654730547, 6342.587731797418, 6381.1704478417505, 6410.551261411656, 6450.225972883284, 5423.755930983037, 5910.822675319747, 6221.3156552780065, 6240.937590624036, 6321.178246828067, 3765.49165862616, 3908.7654740715648, 3980.3631418973982, 3987.4018897165656, 3989.0226894411053, 4836.347093142381, 5240.7641656126325, 5349.010433069894, 5804.245448091721, 6132.068398454472, 5515.531179849758, 5838.277708076213, 5848.84162552217, 5852.27869040898, 5912.0, 4839.806407743651, 5088.720120393414, 5678.630888992202, 5875.73671660595, 5888.646681199141, 5560.304961879765, 5652.576056795675, 5751.396103409082, 5762.884742305214, 5768.884622307614, 5176.741162941763, 5420.214068960057, 5843.415658434123, 5845.766169353178, 5913.704314784158, 4742.885421925914, 5278.8944221116135, 5566.304211973504, 5599.608027438203, 5783.016887129283], "value": 4279.6623218712675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.4482787904823, 653.3042309939916, 699.8810202265614, 722.3498851034069, 771.3482107619062, 14737.557873263806, 14934.327955242014, 15241.085534867916, 15247.77128343073, 15276.388944442222, 12635.557755478538, 13741.519046833362, 15735.842641573581, 15738.449154279573, 15747.370105195778, 719.2016861283971, 909.6043221198767, 918.9724308270729, 920.0339643374464, 921.0053142606002, 895.2435192262528, 929.1405449958795, 938.7840796616782, 939.281449690987, 942.2509105261299, 955.4553904274567, 956.0582825916466, 971.4996776660025, 976.2092704909011, 978.7602037500823, 965.0783501755841, 966.1884017425397, 967.0909345215475, 982.9213662907022, 985.8225519406504, 722.4328901812105, 725.5392825555757, 729.0704351951251, 733.5891900535664, 733.673515285698, 15020.699586008328, 15094.16982065986, 15115.244237788176, 15233.314500847488, 15319.923400383039, 10315.277930544866, 12729.936350318281, 12806.231626102464, 12988.675283117904, 12988.675283117998, 9751.268654850914, 10059.949700251525, 10111.393316400967, 10116.393016418964, 10226.6420675276, 3124.375124974991, 3467.219875528011, 3485.337785820686, 3549.8580056797696, 3554.626764189749, 82028.58985705093, 82327.58836205781, 82336.35327293421, 82756.0, 83930.16069839346, 9513.762155946019, 9575.952120239353, 9586.808263834684, 9649.469279189572, 9819.459929703935, 22800.771992279864, 22882.0, 22897.969591368095, 23207.955641996152, 23319.76680233176, 7486.288802563748, 7652.885206721904, 7660.80847978805, 7781.844363112706, 7798.025246844145, 4076.5108187017154, 4120.17596480705, 4148.108156746314, 4163.399795551776, 4216.894577635584, 3518.225990282185, 3630.7821530708243, 3640.0, 3650.963490365062, 3665.8716944907333, 626.3548544998567, 633.192679333853, 639.9104125422444, 648.3905129178652, 651.5960104735094, 572.7565784541553, 583.5360888093976, 587.1926101610286, 589.6432658241788, 607.271274470637, 5754.913676294859, 6966.616836073963, 7687.923120768721, 8131.064927533291, 8319.875201871977, 587.5064945445761, 587.7531436796555, 599.2240049136379, 599.6402158704742, 602.4969150759077, 3699.1491956850077, 3895.7078219133678, 3908.2769687607315, 3909.1204478992, 4005.7396269242404, 85587.0, 88724.0, 88817.0, 91148.54425727962, 100046.0, 82989.75515367274, 83197.0, 83263.0, 83791.58104209563, 85575.288494231, 65913.0, 68498.0, 73547.63226183834, 73600.0, 74674.12102367837, 8032.277095061472, 8261.752147435587, 8325.708600198965, 8357.373197010127, 8440.0, 45275.77362113168, 45688.31467528056, 46905.0, 47163.76418117888, 47210.819729507035, 64451.0, 67890.3210967884, 68535.0, 68680.96978545225, 69646.65176674085, 10948.34309941406, 10990.725231869268, 11113.777484476863, 11230.438478075901, 11544.249623774427, 11964.521419143484, 12018.939905300767, 12086.637400877988, 12106.213096148722, 12140.210886292363, 11137.777244455228, 11309.547618095514, 11355.318680879174, 11448.0, 11619.6514104577, 11162.55349786032, 11297.661070167907, 11464.197506174487, 11571.247868888495, 12039.0, 11153.996140347408, 11158.609448669258, 11174.329540227613, 11333.036691881283, 11587.710307242387, 9497.620095196391, 9514.33399662017, 9525.285603579898, 9568.234541236823, 10099.44453055089, 9447.669331573363, 9502.857457138287, 9699.951500242454, 9708.223342132753, 9760.560774765294], "value": 6944.502270829756, "unit": "score"}], "name": "dromaeo_css", "value": 7178.219042310272, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 166.0, 119.0, 121.0, 195.0, 171.0, 117.0, 118.0, 114.0], "value": 145.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 145.0, 167.0, 150.0, 156.0, 127.0, 151.0, 161.0, 127.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 220.0, 201.0, 200.0, 231.0, 262.0, 195.0, 196.0, 195.0, 195.0], "value": 209.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 78.0, 142.0, 62.0, 47.0, 55.0, 68.0, 149.0, 89.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 137.0, 78.0, 79.0, 84.0, 120.0, 81.0, 79.0, 122.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 90.0, 88.0, 90.0, 86.0, 91.0, 115.0, 98.0, 132.0], "value": 105.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 125.0, 97.0, 139.0, 154.0, 117.0, 96.0, 94.0, 97.0], "value": 111.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 91.0, 90.0, 91.0, 94.0, 90.0, 149.0, 100.0, 90.0], "value": 98.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 83.0, 65.0, 59.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 72.0, 71.0, 78.0, 76.0, 71.0, 68.0, 68.0, 68.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 110.0, 104.0, 83.0, 84.0, 82.0, 82.0, 81.0, 84.0, 85.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 140.0, 158.0, 158.0, 135.0, 139.0, 137.0, 195.0, 160.0], "value": 149.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 223.0, 219.0, 168.0, 169.0, 167.0, 178.0, 165.0, 165.0, 166.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 87.0, 89.0, 84.0, 67.0, 65.0, 70.0, 70.0, 66.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1618.2999999999997, "alertThreshold": 2.0}]} 03:41:35 INFO - Return code: 0 03:41:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:41:35 ERROR - # TBPL SUCCESS # 03:41:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:41:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:41:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:41:35 INFO - 2016-05-06 03:41:35.885 screenresolution[1708:10341] starting screenresolution argv=screenresolution get 03:41:35 INFO - 2016-05-06 03:41:35.887 screenresolution[1708:10341] Display 0: 1600x1200x32@60 03:41:35 INFO - 2016-05-06 03:41:35.893 screenresolution[1709:10344] starting screenresolution argv=screenresolution list 03:41:35 INFO - Available Modes on Display 0 03:41:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:41:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:41:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:41:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:41:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:41:36 INFO - Intel Iris: 03:41:36 INFO - Chipset Model: Intel Iris 03:41:36 INFO - Type: GPU 03:41:36 INFO - Bus: Built-In 03:41:36 INFO - VRAM (Dynamic, Max): 1536 MB 03:41:36 INFO - Vendor: Intel (0x8086) 03:41:36 INFO - Device ID: 0x0a2e 03:41:36 INFO - Revision ID: 0x0009 03:41:36 INFO - Displays: 03:41:36 INFO - Display: 03:41:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:41:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:41:36 INFO - Display Serial Number: 1600x1200 60 03:41:36 INFO - Main Display: Yes 03:41:36 INFO - Mirror: Off 03:41:36 INFO - Online: Yes 03:41:36 INFO - Rotation: Supported 03:41:36 INFO - Return code: 0 03:41:36 INFO - Running post-action listener: _resource_record_post_action 03:41:36 INFO - Running post-run listener: _resource_record_post_run 03:41:37 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 38016512; Write bytes: 652422144; Read time: 395; Write time: 1836 03:41:37 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 346837504; Write bytes: 346224640; Read time: 27432; Write time: 617 03:41:37 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36263424; Write bytes: 295408640; Read time: 376; Write time: 1190 03:41:37 INFO - Running post-run listener: _upload_blobber_files 03:41:37 INFO - Blob upload gear active. 03:41:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:37 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 03:41:37 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'] 03:41:37 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 03:41:37 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:41:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:41:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:38 INFO - (blobuploader) - INFO - Done attempting. 03:41:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:41:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:41:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:39 INFO - (blobuploader) - INFO - Done attempting. 03:41:39 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:39 INFO - Return code: 0 03:41:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d15623eefe6dfd3715ec15798c4f22da3c6d8f0f9cae0dc4f78358c8daa824998a3405e263d950ef02eddcbd44a6508cce9e7503ac77711814699a3d04e28e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ced0687fab47e5de2c65579e33a4a81a0e6cca8dcaad099f96a116a6a0d1d22a75713eff7e0ad09e2d1c12b2da995a57fc528c1fdfd25d2299b7fb7e981a5ab9"} 03:41:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:39 INFO - Contents: 03:41:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d15623eefe6dfd3715ec15798c4f22da3c6d8f0f9cae0dc4f78358c8daa824998a3405e263d950ef02eddcbd44a6508cce9e7503ac77711814699a3d04e28e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ced0687fab47e5de2c65579e33a4a81a0e6cca8dcaad099f96a116a6a0d1d22a75713eff7e0ad09e2d1c12b2da995a57fc528c1fdfd25d2299b7fb7e981a5ab9"} 03:41:39 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:39 INFO - Copying logs to upload dir... 03:41:39 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.301661 ========= master_lag: 1.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-05-06 03:41:40.775988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:41:40.780452) ========= 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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d15623eefe6dfd3715ec15798c4f22da3c6d8f0f9cae0dc4f78358c8daa824998a3405e263d950ef02eddcbd44a6508cce9e7503ac77711814699a3d04e28e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ced0687fab47e5de2c65579e33a4a81a0e6cca8dcaad099f96a116a6a0d1d22a75713eff7e0ad09e2d1c12b2da995a57fc528c1fdfd25d2299b7fb7e981a5ab9"} build_url:https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/Kej6EClFTym5Td3ayIylNA/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d15623eefe6dfd3715ec15798c4f22da3c6d8f0f9cae0dc4f78358c8daa824998a3405e263d950ef02eddcbd44a6508cce9e7503ac77711814699a3d04e28e8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ced0687fab47e5de2c65579e33a4a81a0e6cca8dcaad099f96a116a6a0d1d22a75713eff7e0ad09e2d1c12b2da995a57fc528c1fdfd25d2299b7fb7e981a5ab9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 03:41:40.813487) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:41:40.817481) ========= 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.rE6bLgWbrB/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.KRoQyEZ87T/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005164 ========= master_lag: 0.19 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 03:41:41.016739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:41:41.017051) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 03:41:41.017386) ========= ========= Total master_lag: 1.76 =========