builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0106 starttime: 1461162972.97 results: success (0) buildid: 20160420053850 builduid: db978b6c5222466a89fb1ea0fc60f9d5 revision: 19b8851d8d4c19997ecc73960f4de8d90c981c28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 07:36:12.974154) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 07:36:12.974626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 44 secs) (at 2016-04-20 07:36:12.974950) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 44 secs) (at 2016-04-20 07:36:57.548157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:36:57.548434) ========= 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.z21FAiNMUc/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.xE1GX4Nflg/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-04-20 07:36:57-- 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% 19.6M=0.001s 2016-04-20 07:36:57 (19.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129380 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:36:57.947867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 07:36:57.948162) ========= 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.z21FAiNMUc/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.xE1GX4Nflg/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.028035 ========= master_lag: 5.83 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-20 07:37:03.805414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 07:37:03.805755) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 19b8851d8d4c19997ecc73960f4de8d90c981c28 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 19b8851d8d4c19997ecc73960f4de8d90c981c28 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z21FAiNMUc/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.xE1GX4Nflg/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-04-20 07:37:03,958 truncating revision to first 12 chars 2016-04-20 07:37:03,958 Setting DEBUG logging. 2016-04-20 07:37:03,959 attempt 1/10 2016-04-20 07:37:03,959 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/19b8851d8d4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 07:37:04,660 unpacking tar archive at: fx-team-19b8851d8d4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.953015 ========= master_lag: 0.81 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 07:37:05.564823) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 07:37:05.565146) ========= script_repo_revision: 19b8851d8d4c19997ecc73960f4de8d90c981c28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 07:37:05.565571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 07:37:05.565894) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 07:37:05.631930) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-20 07:37:05.632200) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z21FAiNMUc/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.xE1GX4Nflg/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:05 INFO - MultiFileLogger online at 20160420 07:37:05 in /builds/slave/test 07:37:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:37:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:05 INFO - {'append_to_log': False, 07:37:05 INFO - 'base_work_dir': '/builds/slave/test', 07:37:05 INFO - 'blob_upload_branch': 'Fx-Team', 07:37:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:05 INFO - 'branch': 'Fx-Team', 07:37:05 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:05 INFO - 'config_files': ('talos/mac_config.py',), 07:37:05 INFO - 'default_actions': ('clobber', 07:37:05 INFO - 'read-buildbot-config', 07:37:05 INFO - 'download-and-extract', 07:37:05 INFO - 'populate-webroot', 07:37:05 INFO - 'create-virtualenv', 07:37:05 INFO - 'install', 07:37:05 INFO - 'run-tests'), 07:37:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:05 INFO - 'download_minidump_stackwalk': True, 07:37:05 INFO - 'download_symbols': 'ondemand', 07:37:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:05 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:05 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:05 INFO - 'installer_path': 'installer.exe', 07:37:05 INFO - 'log_level': 'info', 07:37:05 INFO - 'log_name': 'talos', 07:37:05 INFO - 'log_to_console': True, 07:37:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:37:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:37:05 INFO - 'opt_config_files': (), 07:37:05 INFO - 'pip_index': False, 07:37:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:05 INFO - 'cmd': ('bash', 07:37:05 INFO - '-c', 07:37:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:05 INFO - 'enabled': True, 07:37:05 INFO - 'halt_on_failure': False, 07:37:05 INFO - 'name': 'check_screen_resolution'},), 07:37:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:37:05 INFO - 'cmd': ('bash', 07:37:05 INFO - '-c', 07:37:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:37:05 INFO - 'enabled': True, 07:37:05 INFO - 'halt_on_failure': False, 07:37:05 INFO - 'name': 'check_screen_resolution'},), 07:37:05 INFO - 'run_cmd_checks_enabled': True, 07:37:05 INFO - 'sps_profile': False, 07:37:05 INFO - 'sps_profile_interval': 0, 07:37:05 INFO - 'suite': 'dromaeojs', 07:37:05 INFO - 'system_bits': '32', 07:37:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:05 INFO - 'title': 't-yosemite-r7-0106', 07:37:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:05 INFO - 'use_talos_json': True, 07:37:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:05 INFO - 'work_dir': 'build'} 07:37:05 INFO - ##### 07:37:05 INFO - ##### Running clobber step. 07:37:05 INFO - ##### 07:37:05 INFO - Running pre-action listener: _resource_record_pre_action 07:37:05 INFO - Running main action method: clobber 07:37:05 INFO - rmtree: /builds/slave/test/build 07:37:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:07 INFO - Running post-action listener: _resource_record_post_action 07:37:07 INFO - ##### 07:37:07 INFO - ##### Running read-buildbot-config step. 07:37:07 INFO - ##### 07:37:07 INFO - Running pre-action listener: _resource_record_pre_action 07:37:07 INFO - Running main action method: read_buildbot_config 07:37:07 INFO - Using buildbot properties: 07:37:07 INFO - { 07:37:07 INFO - "project": "", 07:37:07 INFO - "product": "firefox", 07:37:07 INFO - "script_repo_revision": "production", 07:37:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:37:07 INFO - "repository": "", 07:37:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:37:07 INFO - "buildid": "20160420053850", 07:37:07 INFO - "pgo_build": "False", 07:37:07 INFO - "basedir": "/builds/slave/test", 07:37:07 INFO - "buildnumber": 653, 07:37:07 INFO - "slavename": "t-yosemite-r7-0106", 07:37:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:37:07 INFO - "platform": "yosemite_r7", 07:37:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:37:07 INFO - "branch": "fx-team", 07:37:07 INFO - "repo_path": "integration/fx-team", 07:37:07 INFO - "revision": "19b8851d8d4c19997ecc73960f4de8d90c981c28", 07:37:07 INFO - "stage_platform": "macosx64", 07:37:07 INFO - "builduid": "db978b6c5222466a89fb1ea0fc60f9d5", 07:37:07 INFO - "slavebuilddir": "test" 07:37:07 INFO - } 07:37:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:37:07 INFO - Running post-action listener: _resource_record_post_action 07:37:07 INFO - ##### 07:37:07 INFO - ##### Running download-and-extract step. 07:37:07 INFO - ##### 07:37:07 INFO - Running pre-action listener: _resource_record_pre_action 07:37:07 INFO - Running main action method: download_and_extract 07:37:07 INFO - mkdir: /builds/slave/test/build/tests 07:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:07 INFO - https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:37:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:37:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:37:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:37:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:37:09 INFO - Downloaded 1199 bytes. 07:37:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:37:09 INFO - Using the following test package requirements: 07:37:09 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:37:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:37:09 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:37:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:37:09 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:37:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:37:09 INFO - u'jsshell-mac.zip'], 07:37:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:37:09 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:37:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:37:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:37:09 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:37:09 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:37:09 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:37:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:37:09 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:37:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:37:09 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:37:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:09 INFO - https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:37:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:37:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:37:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:37:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:37:10 INFO - Downloaded 18096150 bytes. 07:37:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:37:14 INFO - Return code: 0 07:37:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:14 INFO - https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:37:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:37:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:37:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:37:17 INFO - Downloaded 18096150 bytes. 07:37:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:37:21 INFO - Return code: 0 07:37: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')]} 07:37:21 INFO - https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:37:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:37:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:37:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:37:22 INFO - Downloaded 10845952 bytes. 07:37:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:37:22 INFO - Return code: 0 07:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:22 INFO - https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:37:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:37:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:37:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:37:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:37:27 INFO - Downloaded 110041716 bytes. 07:37:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:37:27 INFO - mkdir: /builds/slave/test/properties 07:37:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:27 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:27 INFO - Contents: 07:37:27 INFO - build_url:https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:37:28 INFO - Running post-action listener: _resource_record_post_action 07:37:28 INFO - Running post-action listener: set_extra_try_arguments 07:37:28 INFO - ##### 07:37:28 INFO - ##### Running populate-webroot step. 07:37:28 INFO - ##### 07:37:28 INFO - Running pre-action listener: _resource_record_pre_action 07:37:28 INFO - Running main action method: populate_webroot 07:37:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:28 INFO - '--tppagecycles', 07:37:28 INFO - '7'], 07:37:28 INFO - 'tests': ['tsvgm']}}, 07:37:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:28 INFO - 'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:28 INFO - 'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['damp', 'tps']}, 07:37:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:28 INFO - 'tests': ['damp', 'tps']}, 07:37:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['dromaeo_dom']}, 07:37:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['a11yr', 07:37:28 INFO - 'ts_paint', 07:37:28 INFO - 'tpaint', 07:37:28 INFO - 'sessionrestore', 07:37:28 INFO - 'sessionrestore_no_auto_restore', 07:37:28 INFO - 'tabpaint']}, 07:37:28 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:28 INFO - 'ts_paint', 07:37:28 INFO - 'tpaint', 07:37:28 INFO - 'sessionrestore', 07:37:28 INFO - 'sessionrestore_no_auto_restore', 07:37:28 INFO - 'tabpaint']}, 07:37:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:28 INFO - 'ts_paint', 07:37:28 INFO - 'tpaint', 07:37:28 INFO - 'sessionrestore', 07:37:28 INFO - 'sessionrestore_no_auto_restore', 07:37:28 INFO - 'tabpaint']}, 07:37:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:28 INFO - 'ts_paint', 07:37:28 INFO - 'tpaint', 07:37:28 INFO - 'sessionrestore', 07:37:28 INFO - 'sessionrestore_no_auto_restore', 07:37:28 INFO - 'tabpaint']}, 07:37:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['a11yr', 07:37:28 INFO - 'ts_paint', 07:37:28 INFO - 'tpaint', 07:37:28 INFO - 'sessionrestore', 07:37:28 INFO - 'sessionrestore_no_auto_restore', 07:37:28 INFO - 'tabpaint']}, 07:37:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['a11yr', 07:37:28 INFO - 'ts_paint', 07:37:28 INFO - 'tpaint', 07:37:28 INFO - 'sessionrestore', 07:37:28 INFO - 'sessionrestore_no_auto_restore', 07:37:28 INFO - 'tabpaint']}, 07:37:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['tsvgx', 07:37:28 INFO - 'tsvgr_opacity', 07:37:28 INFO - 'tart', 07:37:28 INFO - 'tscrollx', 07:37:28 INFO - 'cart']}, 07:37:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:28 INFO - 'tsvgr_opacity', 07:37:28 INFO - 'tart', 07:37:28 INFO - 'tscrollx', 07:37:28 INFO - 'cart']}, 07:37:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:28 INFO - 'talos_options': ['--disable-e10s'], 07:37:28 INFO - 'tests': ['tp5o']}, 07:37:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:28 INFO - 'tests': ['tp5o']}, 07:37:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:28 INFO - 'talos_options': ['--disable-e10s', 07:37:28 INFO - '--xperf_path', 07:37:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:28 INFO - 'tests': ['tp5n']}, 07:37:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:28 INFO - 'talos_options': ['--xperf_path', 07:37:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:28 INFO - 'tests': ['tp5n']}}, 07:37:28 INFO - 'talos.zip': {'path': '', 07:37:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:28 INFO - Running post-action listener: _resource_record_post_action 07:37:28 INFO - ##### 07:37:28 INFO - ##### Running create-virtualenv step. 07:37:28 INFO - ##### 07:37:28 INFO - Running pre-action listener: _resource_record_pre_action 07:37:28 INFO - Running main action method: create_virtualenv 07:37:28 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:28 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 07:37:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:28 INFO - Using real prefix '/tools/python27' 07:37:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:29 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:32 INFO - Installing pip.................done. 07:37:32 INFO - Return code: 0 07:37:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:32 INFO - 'HOME': '/Users/cltbld', 07:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:32 INFO - 'LOGNAME': 'cltbld', 07:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:32 INFO - 'MOZ_NO_REMOTE': '1', 07:37:32 INFO - 'NO_EM_RESTART': '1', 07:37:32 INFO - 'PAGER': '/bin/cat', 07:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:32 INFO - 'PWD': '/builds/slave/test', 07:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:32 INFO - 'SHELL': '/bin/bash', 07:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:32 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:32 INFO - 'USER': 'cltbld', 07:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:32 INFO - 'XPC_FLAGS': '0x0', 07:37:32 INFO - 'XPC_SERVICE_NAME': '0', 07:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:32 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 07:37:32 INFO - Cleaning up... 07:37:32 INFO - Return code: 0 07:37:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:32 INFO - 'HOME': '/Users/cltbld', 07:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:32 INFO - 'LOGNAME': 'cltbld', 07:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:32 INFO - 'MOZ_NO_REMOTE': '1', 07:37:32 INFO - 'NO_EM_RESTART': '1', 07:37:32 INFO - 'PAGER': '/bin/cat', 07:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:32 INFO - 'PWD': '/builds/slave/test', 07:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:32 INFO - 'SHELL': '/bin/bash', 07:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:32 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:32 INFO - 'USER': 'cltbld', 07:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:32 INFO - 'XPC_FLAGS': '0x0', 07:37:32 INFO - 'XPC_SERVICE_NAME': '0', 07:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:32 INFO - Downloading/unpacking psutil>=0.7.1 07:37:32 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 07:37:32 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 07:37:32 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 07:37:32 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 07:37:32 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 07:37:32 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 07:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:36 INFO - Installing collected packages: psutil 07:37:36 INFO - Running setup.py install for psutil 07:37:36 INFO - building 'psutil._psutil_osx' extension 07:37:36 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 07:37:36 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 07:37:36 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 07:37:37 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 07:37:37 INFO - building 'psutil._psutil_posix' extension 07:37:37 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 07:37:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:37:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:37:37 INFO - ^ 07:37:37 INFO - 1 warning generated. 07:37:37 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 07:37:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:37 INFO - Successfully installed psutil 07:37:37 INFO - Cleaning up... 07:37:37 INFO - Return code: 0 07:37:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:37 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 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:37 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 07:37:37 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 07:37:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:37 INFO - 'HOME': '/Users/cltbld', 07:37:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:37 INFO - 'LOGNAME': 'cltbld', 07:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:37 INFO - 'MOZ_NO_REMOTE': '1', 07:37:37 INFO - 'NO_EM_RESTART': '1', 07:37:37 INFO - 'PAGER': '/bin/cat', 07:37:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:37 INFO - 'PWD': '/builds/slave/test', 07:37:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:37 INFO - 'SHELL': '/bin/bash', 07:37:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:37 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:37 INFO - 'USER': 'cltbld', 07:37:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:37 INFO - 'XPC_FLAGS': '0x0', 07:37:37 INFO - 'XPC_SERVICE_NAME': '0', 07:37:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:37:40 INFO - Installing collected packages: mozsystemmonitor 07:37:40 INFO - Running setup.py install for mozsystemmonitor 07:37:40 INFO - Successfully installed mozsystemmonitor 07:37:40 INFO - Cleaning up... 07:37:40 INFO - Return code: 0 07:37:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:40 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 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:40 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 07:37:40 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 07:37:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:40 INFO - 'HOME': '/Users/cltbld', 07:37:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:40 INFO - 'LOGNAME': 'cltbld', 07:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:40 INFO - 'MOZ_NO_REMOTE': '1', 07:37:40 INFO - 'NO_EM_RESTART': '1', 07:37:40 INFO - 'PAGER': '/bin/cat', 07:37:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:40 INFO - 'PWD': '/builds/slave/test', 07:37:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:40 INFO - 'SHELL': '/bin/bash', 07:37:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:40 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:40 INFO - 'USER': 'cltbld', 07:37:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:40 INFO - 'XPC_FLAGS': '0x0', 07:37:40 INFO - 'XPC_SERVICE_NAME': '0', 07:37:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:40 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 07:37:40 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 07:37:40 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 07:37:40 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 07:37:40 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 07:37:40 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 07:37:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:43 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 07:37:44 INFO - Downloading docopt-0.6.1.tar.gz 07:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:44 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:44 INFO - Running setup.py install for blobuploader 07:37:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:44 INFO - Running setup.py install for requests 07:37:45 INFO - Running setup.py install for docopt 07:37:45 INFO - Successfully installed blobuploader requests docopt 07:37:45 INFO - Cleaning up... 07:37:45 INFO - Return code: 0 07:37:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:45 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 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:45 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 07:37:45 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 07:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:45 INFO - 'HOME': '/Users/cltbld', 07:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:45 INFO - 'LOGNAME': 'cltbld', 07:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:45 INFO - 'MOZ_NO_REMOTE': '1', 07:37:45 INFO - 'NO_EM_RESTART': '1', 07:37:45 INFO - 'PAGER': '/bin/cat', 07:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:45 INFO - 'PWD': '/builds/slave/test', 07:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:45 INFO - 'SHELL': '/bin/bash', 07:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:45 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:45 INFO - 'USER': 'cltbld', 07:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:45 INFO - 'XPC_FLAGS': '0x0', 07:37:45 INFO - 'XPC_SERVICE_NAME': '0', 07:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Ouax1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-lIPCSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-g1ogtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Onx_6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:45 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-VAZDNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-DExP14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-O1ZuU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-wgMNwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-CG5Jq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-a9nZyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ytwBeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-QJpgyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-tCOisZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Xjh1Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-uN3tHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-hmt4jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-N5xTyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:47 INFO - Running setup.py install for manifestparser 07:37:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:47 INFO - Running setup.py install for mozcrash 07:37:47 INFO - Running setup.py install for mozdebug 07:37:47 INFO - Running setup.py install for mozdevice 07:37:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:47 INFO - Running setup.py install for mozfile 07:37:48 INFO - Running setup.py install for mozhttpd 07:37:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Running setup.py install for mozinfo 07:37:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Running setup.py install for mozInstall 07:37:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Running setup.py install for mozleak 07:37:48 INFO - Running setup.py install for mozlog 07:37:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Running setup.py install for moznetwork 07:37:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:48 INFO - Running setup.py install for mozprocess 07:37:49 INFO - Running setup.py install for mozprofile 07:37:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozrunner 07:37:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Running setup.py install for mozscreenshot 07:37:49 INFO - Running setup.py install for moztest 07:37:49 INFO - Running setup.py install for mozversion 07:37:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:49 INFO - Cleaning up... 07:37:49 INFO - Return code: 0 07:37:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:49 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 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:49 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 07:37:49 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 07:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:49 INFO - 'HOME': '/Users/cltbld', 07:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:49 INFO - 'LOGNAME': 'cltbld', 07:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:49 INFO - 'MOZ_NO_REMOTE': '1', 07:37:49 INFO - 'NO_EM_RESTART': '1', 07:37:49 INFO - 'PAGER': '/bin/cat', 07:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:49 INFO - 'PWD': '/builds/slave/test', 07:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:49 INFO - 'SHELL': '/bin/bash', 07:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:49 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:49 INFO - 'USER': 'cltbld', 07:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:49 INFO - 'XPC_FLAGS': '0x0', 07:37:49 INFO - 'XPC_SERVICE_NAME': '0', 07:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-ir4iW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2M3F6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-meMpdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-7243Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-XHGNGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-7zXyeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zfTICz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zqX6Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:50 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)) 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:50 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-QXs5Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9VsWqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-BO0WZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-VSHhQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-HOpoWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-N_WIOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Id3TYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-gYKHk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:51 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)) 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:51 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-D6DX1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:51 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)) 07:37:51 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)) 07:37:51 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)) 07:37:51 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)) 07:37:51 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)) 07:37:51 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)) 07:37:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:54 INFO - Downloading blessings-1.6.tar.gz 07:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:54 INFO - Installing collected packages: blessings 07:37:54 INFO - Running setup.py install for blessings 07:37:54 INFO - Successfully installed blessings 07:37:54 INFO - Cleaning up... 07:37:54 INFO - Return code: 0 07:37:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:55 INFO - Reading from file tmpfile_stdout 07:37:55 INFO - Current package versions: 07:37:55 INFO - blessings == 1.6 07:37:55 INFO - blobuploader == 1.2.4 07:37:55 INFO - docopt == 0.6.1 07:37:55 INFO - manifestparser == 1.1 07:37:55 INFO - mozInstall == 1.12 07:37:55 INFO - mozcrash == 0.17 07:37:55 INFO - mozdebug == 0.1 07:37:55 INFO - mozdevice == 0.48 07:37:55 INFO - mozfile == 1.2 07:37:55 INFO - mozhttpd == 0.7 07:37:55 INFO - mozinfo == 0.9 07:37:55 INFO - mozleak == 0.1 07:37:55 INFO - mozlog == 3.1 07:37:55 INFO - moznetwork == 0.27 07:37:55 INFO - mozprocess == 0.22 07:37:55 INFO - mozprofile == 0.28 07:37:55 INFO - mozrunner == 6.11 07:37:55 INFO - mozscreenshot == 0.1 07:37:55 INFO - mozsystemmonitor == 0.0 07:37:55 INFO - moztest == 0.7 07:37:55 INFO - mozversion == 1.4 07:37:55 INFO - psutil == 3.1.1 07:37:55 INFO - requests == 1.2.3 07:37:55 INFO - wsgiref == 0.1.2 07:37:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:55 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 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:55 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 07:37:55 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 07:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:55 INFO - 'HOME': '/Users/cltbld', 07:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:55 INFO - 'LOGNAME': 'cltbld', 07:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:55 INFO - 'MOZ_NO_REMOTE': '1', 07:37:55 INFO - 'NO_EM_RESTART': '1', 07:37:55 INFO - 'PAGER': '/bin/cat', 07:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:55 INFO - 'PWD': '/builds/slave/test', 07:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:55 INFO - 'SHELL': '/bin/bash', 07:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:55 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:55 INFO - 'USER': 'cltbld', 07:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:55 INFO - 'XPC_FLAGS': '0x0', 07:37:55 INFO - 'XPC_SERVICE_NAME': '0', 07:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 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)) 07:37:55 INFO - Cleaning up... 07:37:55 INFO - Return code: 0 07:37:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:55 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 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37:55 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 07:37:55 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 07:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:55 INFO - 'HOME': '/Users/cltbld', 07:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:55 INFO - 'LOGNAME': 'cltbld', 07:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:55 INFO - 'MOZ_NO_REMOTE': '1', 07:37:55 INFO - 'NO_EM_RESTART': '1', 07:37:55 INFO - 'PAGER': '/bin/cat', 07:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:55 INFO - 'PWD': '/builds/slave/test', 07:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:55 INFO - 'SHELL': '/bin/bash', 07:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:55 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:55 INFO - 'USER': 'cltbld', 07:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:55 INFO - 'XPC_FLAGS': '0x0', 07:37:55 INFO - 'XPC_SERVICE_NAME': '0', 07:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:55 INFO - Downloading/unpacking jsonschema 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:57 INFO - Downloading/unpacking functools32 (from jsonschema) 07:37:57 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 07:37:57 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 07:37:57 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 07:37:57 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 07:37:57 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 07:37:57 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 07:37:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:58 INFO - warning: no files found matching '*.txt' 07:37:58 INFO - no previously-included directories found matching 'build' 07:37:58 INFO - no previously-included directories found matching 'dist' 07:37:58 INFO - no previously-included directories found matching '.git*' 07:37:58 INFO - Installing collected packages: jsonschema, functools32 07:37:58 INFO - Running setup.py install for functools32 07:37:58 INFO - warning: no files found matching '*.txt' 07:37:58 INFO - no previously-included directories found matching 'build' 07:37:58 INFO - no previously-included directories found matching 'dist' 07:37:58 INFO - no previously-included directories found matching '.git*' 07:37:58 INFO - Successfully installed jsonschema functools32 07:37:58 INFO - Cleaning up... 07:37:58 INFO - Return code: 0 07:37:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104c41a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c51420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce2b5d7530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, '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.z21FAiNMUc/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.xE1GX4Nflg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 07:37: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', 'flake8'] in /builds/slave/test/build 07:37: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 flake8 07:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:58 INFO - 'HOME': '/Users/cltbld', 07:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:58 INFO - 'LOGNAME': 'cltbld', 07:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:58 INFO - 'MOZ_NO_REMOTE': '1', 07:37:58 INFO - 'NO_EM_RESTART': '1', 07:37:58 INFO - 'PAGER': '/bin/cat', 07:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:58 INFO - 'PWD': '/builds/slave/test', 07:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:58 INFO - 'SHELL': '/bin/bash', 07:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:37:58 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:58 INFO - 'USER': 'cltbld', 07:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:58 INFO - 'XPC_FLAGS': '0x0', 07:37:58 INFO - 'XPC_SERVICE_NAME': '0', 07:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:58 INFO - Downloading/unpacking flake8 07:37:58 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 07:37:58 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 07:37:58 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 07:37:58 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 07:37:58 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 07:37:58 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 07:38:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:38:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:38:01 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 07:38:01 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 07:38:01 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 07:38:01 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 07:38:01 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 07:38:01 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 07:38:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:38:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:38:01 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 07:38:01 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 07:38:01 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 07:38:01 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 07:38:01 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 07:38:01 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 07:38:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:38:02 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 07:38:02 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 07:38:02 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 07:38:02 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 07:38:02 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 07:38:02 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 07:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:38:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:02 INFO - no previously-included directories found matching 'docs/_build' 07:38:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:38:02 INFO - Running setup.py install for pep8 07:38:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:02 INFO - no previously-included directories found matching 'docs/_build' 07:38:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:38:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:38:02 INFO - Cleaning up... 07:38:02 INFO - Return code: 0 07:38:02 INFO - Running post-action listener: _resource_record_post_action 07:38:02 INFO - Running post-action listener: _start_resource_monitoring 07:38:02 INFO - Starting resource monitoring. 07:38:02 INFO - ##### 07:38:02 INFO - ##### Running install step. 07:38:02 INFO - ##### 07:38:02 INFO - Running pre-action listener: _resource_record_pre_action 07:38:02 INFO - Running main action method: install 07:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:03 INFO - Reading from file tmpfile_stdout 07:38:03 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:03 INFO - Reading from file tmpfile_stdout 07:38:03 INFO - Output received: 07:38:03 INFO - Usage: mozinstall [options] installer 07:38:03 INFO - Options: 07:38:03 INFO - -h, --help show this help message and exit 07:38:03 INFO - -d DEST, --destination=DEST 07:38:03 INFO - Directory to install application into. [default: 07:38:03 INFO - "/builds/slave/test"] 07:38:03 INFO - --app=APP Application being installed. [default: firefox] 07:38:03 INFO - mkdir: /builds/slave/test/build/application 07:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:38:37 INFO - Reading from file tmpfile_stdout 07:38:37 INFO - Output received: 07:38:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:38:37 INFO - Running post-action listener: _resource_record_post_action 07:38:37 INFO - ##### 07:38:37 INFO - ##### Running run-tests step. 07:38:37 INFO - ##### 07:38:37 INFO - Running pre-action listener: _resource_record_pre_action 07:38:37 INFO - Running main action method: run_tests 07:38:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:38:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:38:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:38:37 INFO - 2016-04-20 07:38:37.175 screenresolution[1649:8005] starting screenresolution argv=screenresolution get 07:38:37 INFO - 2016-04-20 07:38:37.177 screenresolution[1649:8005] Display 0: 1600x1200x32@60 07:38:37 INFO - 2016-04-20 07:38:37.182 screenresolution[1650:8008] starting screenresolution argv=screenresolution list 07:38:37 INFO - Available Modes on Display 0 07:38:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:38:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:38:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:38:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:38:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:38:37 INFO - Intel Iris: 07:38:37 INFO - Chipset Model: Intel Iris 07:38:37 INFO - Type: GPU 07:38:37 INFO - Bus: Built-In 07:38:37 INFO - VRAM (Dynamic, Max): 1536 MB 07:38:37 INFO - Vendor: Intel (0x8086) 07:38:37 INFO - Device ID: 0x0a2e 07:38:37 INFO - Revision ID: 0x0009 07:38:37 INFO - Displays: 07:38:37 INFO - Display: 07:38:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:38:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:38:37 INFO - Display Serial Number: 1600x1200 60 07:38:37 INFO - Main Display: Yes 07:38:37 INFO - Mirror: Off 07:38:37 INFO - Online: Yes 07:38:37 INFO - Rotation: Supported 07:38:37 INFO - Return code: 0 07:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:37 INFO - Python 2.7.3 07:38:37 INFO - Return code: 0 07:38:37 INFO - grabbing minidump binary from tooltool 07:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:37 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 0x104ae0e00>, '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 0x104909db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104adbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:37 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 07:38:37 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 07:38:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:37 INFO - Return code: 0 07:38:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:38:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:38:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:38:38 INFO - Return code: 0 07:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:38:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z21FAiNMUc/Render', 07:38:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:38 INFO - 'HOME': '/Users/cltbld', 07:38:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:38 INFO - 'LOGNAME': 'cltbld', 07:38:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:38 INFO - 'MOZ_NO_REMOTE': '1', 07:38:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:38 INFO - 'NO_EM_RESTART': '1', 07:38:38 INFO - 'PAGER': '/bin/cat', 07:38:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:38 INFO - 'PWD': '/builds/slave/test', 07:38:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:38 INFO - 'SHELL': '/bin/bash', 07:38:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xE1GX4Nflg/Listeners', 07:38:38 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 07:38:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:38 INFO - 'USER': 'cltbld', 07:38:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:38 INFO - 'XPC_FLAGS': '0x0', 07:38:38 INFO - 'XPC_SERVICE_NAME': '0', 07:38:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:38:38 INFO - mozversion application_buildid: 20160420053850 07:38:38 INFO - mozversion application_changeset: 19b8851d8d4c19997ecc73960f4de8d90c981c28 07:38:38 INFO - mozversion application_display_name: Nightly 07:38:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:38 INFO - mozversion application_name: Firefox 07:38:38 INFO - mozversion application_remotingname: firefox 07:38:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:38:38 INFO - mozversion application_vendor: Mozilla 07:38:38 INFO - mozversion application_version: 48.0a1 07:38:38 INFO - mozversion platform_buildid: 20160420053850 07:38:38 INFO - mozversion platform_changeset: 19b8851d8d4c19997ecc73960f4de8d90c981c28 07:38:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:38:38 INFO - mozversion platform_version: 48.0a1 07:38:38 INFO - using testdate: 1461163118 07:38:38 INFO - actual date: 1461163118 07:38:38 INFO - starting webserver on 'localhost:49276' 07:38:38 INFO - SUITE-START | Running 2 tests 07:38:38 INFO - TEST-START | dromaeo_css 07:38:38 INFO - operating with platform_type : mac_ 07:38:38 INFO - Initialising browser for dromaeo_css test... 07:38:38 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpLaJHqf/profile http://localhost:49276/getInfo.html) 07:38:41 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 07:38:41 INFO - PROCESS | 1668 | colorDepth:24 07:38:41 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 07:38:41 INFO - PROCESS | 1668 | __metrics 07:38:41 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:41 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:38:42 INFO - TEST-INFO | 1668: exit 0 07:38:42 INFO - Browser initialized. 07:38:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:42 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpLaJHqf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:54 INFO - PROCESS | 1671 | RSS: Main: 237920256 07:38:54 INFO - PROCESS | 1671 | 07:39:46 INFO - PROCESS | 1671 | 1461163186266 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] 07:41:56 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 07:41:58 INFO - PROCESS | 1671 | RSS: Main: 379842560 07:41:58 INFO - PROCESS | 1671 | 07:45:01 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 07:45:02 INFO - PROCESS | 1671 | RSS: Main: 377409536 07:45:02 INFO - PROCESS | 1671 | 07:48:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 07:48:05 INFO - PROCESS | 1671 | RSS: Main: 373235712 07:48:05 INFO - PROCESS | 1671 | 07:51:07 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 07:51:07 INFO - PROCESS | 1671 | RSS: Main: 375513088 07:51:07 INFO - PROCESS | 1671 | 07:54:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 07:54:11 INFO - PROCESS | 1671 | RSS: Main: 341225472 07:54:11 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 07:57:14 INFO - PROCESS | 1671 | RSS: Main: 444649472 07:57:14 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | __start_tp_report 07:57:14 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 07:57:14 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 07:57:14 INFO - PROCESS | 1671 | |i|pagename|runs| 07:57:14 INFO - PROCESS | 1671 | |0;dojo.html;3415.231572896098;3441.156916555443;3485.198404366994;3490.144914495949;3535.1692352297205;5520.503154716085;5578.497935185833;5732.168835518847;5742.224799652051;5746.339170995331;5670.971645141779;5702.45826646469;5704.686242256685;5728.16941543476;5735.053716136843;5184.948150518494;5194.117000109972;5213.478652134775;5226.451222621627;5285.418603953562;5277.076511610472;5280.788768449276;5285.682859028451;5288.444713305086;5300.257963885059;5226.08543504887;5281.947180528203;5282.07563676357;5292.841214763564;5328.333958255218;5275.261463395147;5300.284461597674;5328.813491527778;5339.5728341732565;5339.839804805862;5110.616703747234;5146.768395422215;5212.947870521284;5238;5263.842084737464;5574.60977731559;5584.664920104807;5654.943450565483;5692.6299790513895;5754.769809207669;6210.534209934228;6250.656213908233;6252.937470625327;6267.561270711052;6280.87438251237;6206.782762603287;6258.78094266703;6280.905786413162;6281.214848143982;6289;5730.656160630376;5816.214811000503;5922.940770592239;5962.284525856925;5970.462658360769;6226.937730622726;6286.622802631857;6297.307296197415;6309.936900631027;6322.430981211713;6195.4424101831055;6203.751849925952;6212.378762123752;6215.751369945242;6221.657808820558;6129.664444256096;6188;6288.811335659938;6288.9056664150075;6295.464885484785;6185.876282474415;6234.438900498886;6248.343923887926;6249.937500625027;6254.124422580842;6104.641056839945;6269.404406581368;6283.057541368831;6287.182666253358;6292;4199.748015119103;4882.707037577757;4904.141775189328;4950.6782059166035;4956.876078098005;4432.645388368923;4462.732236065846;4466.486354069259;4468.798904049326;4476.26141686618;5547.694876781735;5746.540276777848;5781.71091445426;5802.993901312122;5851.531877449794;6185.226846644169;6220.222472190976;6225.906611400742;6282.371762823681;6289.496840252768;5706.885862282814;5713.342965559014;5717.028105222123;5726.312842458931;5748.48263656273;5301.9926214019215;5387.730613469311;5388.622796404293;5404.32445944257;5404.513593776579;6289.339619339903;6362.172917520786;6368.554201205871;6370.299267080525;6396.680165991775;6258.812235632939;6263.123162757127;6273.215848018997;6299.086632438362;6321;6221.2845522765465;6306.684665766602;6322.715477803602;6329.430351268408;6383.904241436289;5555.777768889199;5906.084556893688;6145.539084568764;6199.628022318675;6203.596766210182;6094.573379863545;6254.593451425642;6261.937380626136;6271.3728627136925;6271.592346497463;6018.879622407615;6092.116643086816;6155.768846230682;6156;6184.690765461799;6146.4468197860615;6150.923588372107;6171.290301615192;6174.660393678211;6177.4749146321265;6041.456268935817;6042.395760423922;6056.424639659225;6069.696515174312;6100.908486372797;5806.883862322646;5983.611065280743;6036.849078773066;6097.695115244132;6159.969200153971;5973.611715238496;6089.875495217711;6098.009036294196;6119.868162944292;6142.109394137914 07:57:14 INFO - PROCESS | 1671 | |1;ext.html;510.2270060857801;520.0872468817228;527.5199568392763;530.7611574791343;536.1180857489429;22482;29757.10728678138;29933.55099673504;37315.25369492608;38743.80628096862;40325.59674403255;41098.79450602743;41195.79402102993;41242.7937860311;41362.37956430649;9306.39508431953;9530.666426675069;9534.189593884528;9541;9547.23622110233;7810;8375.329973602098;8453.535055571941;8700.347473939448;9402.952985235064;8583.227509524142;11232.943835280812;11520.193586448951;11523.481443335028;11613.593524226653;11088.722781930435;11223.32660040392;11225.719357016058;11226.438678066146;11228.214025018253;6707.396334329885;11158.051565616932;11318.547258109666;11324.716882078013;11331.603393881174;38776.61223387758;39841;39844;39865.60134398677;39913.201735965406;3196.3127927495466;3239.7732158748895;3450.1374656335915;3611.368010598135;3994.660453861425;26588.867055664792;26730.198094057014;26793.19620411391;26851.597226041624;26962.191134266002;2641.0624228398833;2666.533356662596;2676.51822671919;2880.942381152386;2925.400292939942;293744;353006;356068;356353;356438;34492.65507344894;35260.294794103975;35329.646703532635;35447;57544.71227643835;28663.856680716464;34513.30973380568;34743.82628086843;34750.13124671904;34753.82623086919;13164.539241126515;13291.136076155019;13296.202227866359;13320.600381988555;13323.800142997863;11263.774724505463;11307.151963602599;11331.603393881174;11339.319640821577;11468.082553395709;7581.734639287709;7792.337651299703;8077.717279895293;8092.028956525137;8175.059868115124;3335.366280406715;3438.1748380388526;3438.398280300937;3438.6045604755273;3470.670286322795;853.5604163855619;951.6050838901779;979.9755006124904;1069.9144068474504;1105.1490352428584;28043.158705238875;28691.696245563333;28878.42243155125;28995.275118122216;29007;1061.596593294543;1067.8024565455416;1085.7068591480413;1101.7025403141267;1126.594426006637;14967.401303947938;14977.176255305845;15270.770938435933;15396.769048464283;15452.227388630523;582786;714947.8273477706;725292;726323;727395;52193;53613.46386536163;56067.71966140143;56542.717286414125;56925.71537142288;1300.1808860417875;1442.7114577084626;1467.6404280951235;1486.1454663568275;1493.5071426429035;25281.49437011286;25305.87347063253;28392.716072839008;28480.85759571189;29369.265768355963;51130;52488.21267681064;52607;52632;52743.20885186802;647472;648760;669298.1096606648;814303;814505;27071.323216919736;27457.31356716098;27483.587746183424;27511.724882750917;27534.724652753215;44216.55783442253;44505.55494445014;44535;44956.550434495235;44978.55021449875;36550.4517432244;36602.26795464023;36656.81671591625;37426.625733742316;37544.62455375411;35839.104022399646;35933.64066359407;36004.14170989222;36218.63781362153;36926;35693.643063569034;36051.0987225311;36903.63096369002;36904.26191476209;36999.260014799016;28124.59377031181;30533.847330763205;31727.52408713825;31786.205344866565;32035.03894883064;24068.51862962766;24104;24410.51178976446;24416.389590259674;24450.755492445558 07:57:14 INFO - PROCESS | 1671 | |2;jquery.html;394.05820089984957;394.30798947846534;397.4554859842016;397.68582819572504;405.25433202906663;19112.184342487442;19195.712064319046;20090.799092009074;20142.89928550357;20168.39494815156;18690.158942847604;19307.517312067204;20049.899750501263;20768;20773.79226207741;5546.195801608765;5822.068469044964;5907.7046147692445;5928.02187639039;5938.079597662369;4882.731449770261;5895.233619629442;5947.672877991708;5966;5981.5214782817275;5848.7660493580415;5988.490978266853;6022.969885150568;6025.638461692312;6027.578069535134;5940.435658612425;6028.7588496460085;6031.758729650809;6057.697115144248;6064.42387973144;5614.438556144353;5791.82624521265;5833.212516310286;5833.562482813763;5835.212246346774;13646.590602281947;16760;21183.89408052965;21694.91525423738;26397.604035939476;1981.2867367747745;2029.249177804222;2065.3597384810755;2135.7010018597252;2734.0840818325883;9819.36174148678;9952.253580981456;9959.701208963743;10181.18550515957;10303.175745940307;1689.501597028867;1719.5271300392492;1742.4859666398443;1773.9024353660543;1775.7602723632403;86759.56620216921;109618.45190773995;110663;112388.43805780918;116551;11582.189246752814;11753.118516111326;11758.470868810924;11767.646970590897;11896.940515297541;14909.478168264059;15169.924150379178;15172.544823655307;15186.620334491727;15188.924055379874;8189.918100819034;8200.05699344571;8398.496090234605;8509.064002959669;8585.699500517452;8046.9597652012535;8088.514689118671;8096.149904259968;8161.347092232607;8193.713220037389;4499.437570303712;4585.518520555293;4590.288505281686;4655.580997710223;4665.533446655375;1635.9039443572597;1780.608266181438;1830.881732387429;1908.9809101909082;1967.9409617711492;782.5265714242915;861.8448679237797;913.3469569258012;920.6132136238858;985.2216748768393;18861.717074243898;19991.60016799656;20523.897380513;20591.279305224245;20730.378088657366;948.307735353196;956.9952150239344;977.237754551451;989.8713167288206;1056.9630062947913;10788.46057697112;10986;11002.284851484788;11043.392613406178;11060.612878549213;569634.1518292382;580306;581586;583053;586775;106476.87046259186;107385;125726;128798;130894.34552827365;917.6604656277086;1017.7099526635021;1018.3940555369543;1043.9164866810636;1044.9373037617615;13868;17870.285188592312;18018.91886486815;18151.12114567177;18215.633827463258;43199.70400887978;46650.76674616605;48103.75948120237;49279.260811087144;49752.75123624359;69556.6522167386;70433;70840;70850.64574677094;72715.63642181967;8211.055728591049;8275.420720549504;8338.624761885609;8472.57637118154;8642.22220000178;11789.233699809485;12294.139410241198;12550.1842380245;12716.36418179106;12761.298128603015;10656;10993.065589424989;11241.718957025812;11299.943500282447;11567;10627.09669678086;10895.128389728961;11032.779344412906;11246.66260012201;11356.545738170711;11210.887891120985;11357.204995650225;11368.886311137114;11754.177207595729;11797.646070617895;6879.8968015480805;7545.153040837687;7603.0876294844975;8196.221358970888;8759.03650598421;8930.687425940061;11059.944700276768;11264.38045907483;11349.54601815918;11436.313821170756 07:57:14 INFO - PROCESS | 1671 | |3;mootools.html;1390.395178097527;1611.0897343001204;1615.951521454356;1902.391234804862;2020.7575090989073;7968.840623187532;8620.482771033743;8878.911210887889;8897.1102889711;8897.199252067305;8521.488710677364;8718.912810871905;8759.824803503927;8778.122187781235;8795.868061979076;2401.6637670726113;2435.2450740270483;2438.183208625113;2438.8170887183533;2438.975610243893;2393.628987506939;2426.9393265168337;2437.098273638756;2439.4023464251195;2474.1958863369387;2425.5391475619576;2436.3300092474533;2447.0578827151585;2449.608062709967;2455.373879660684;2402.4714562796157;2429.744876787938;2431.0761910474084;2431.902723891042;2450.15469662966;2399.9520009599887;2409.0965887792077;2412.4692567635093;2417.6736140620965;2419.0444774314224;8565.357598180099;8784.12158784123;8835.514046727427;8856.822863542757;8869.2017718405;5276.92084618731;5465.398806131322;5482.013237617227;5487.75305111267;5490.780368785244;3358.697717205463;3363.209645733251;3452.4993875887853;3484.1463841358777;3492.109512074405;920.4891285336636;1014.6550172941236;1020.9795804083876;1033.421284080917;1046.7540128069897;11380.544778208861;11630.127740419503;11675.065994720488;11689.883101168965;11713.648590542298;4545.159145558082;4584.931226031612;4676.321933319718;4737.431508218967;4773.76131193439;9359.110884465965;9373.671921482852;9381.530923453936;9386.95306523463;9390.154886060287;5342.305500284938;5343.412224655285;5347.946520534822;5357.1696387060065;5366.382865970385;4452.48796388413;4547.590716835501;4818.542238487338;4987;5032.169692000852;3799.4490798834013;3801.7718936863325;3890.4942357493346;3924.117073658404;3929.6070392961046;1194.2595590733627;1205.6081773423673;1209.2079687804503;1221.3404761428906;1222.6698791326291;621.2451870976785;758.5624099020685;827.5820710541138;898.1108702384593;901.8016036471965;4544.545545445429;5288.312519372457;5505.642133261325;5553.361363443175;5595.63628364155;544.8910217956425;571.6655756382563;573.3435216676965;575.3211210771331;703.7712743358429;3555.982220088883;3725.5343082114737;3786.659200671953;3842.3852183650483;3855.7108216883285;10444.843327350096;10655.680329590125;10790;10892.074173695166;10919.235653504178;10728.624498142528;10733.677989660322;10861.83707244392;10879.238453308193;10901.83647245292;7831.138574756772;8128.674853005932;8214.26071653554;8275.462094963928;8308.83382332362;5074.391073071255;5834.066549352084;5843.94156058434;5983.192269043623;5990.063027092765;9101.590428430603;9821.263405244777;9831.066048725359;9967.302288839712;10081.344712593658;9841.950790246003;9947.602095916081;9960.501974901372;9974.152197063331;10000.24998125129;7333.816654583678;7346.77959661211;7351.081114860643;7521.210272921265;7537.585432801248;8002.319802816825;8016.8797468036855;8080.353571714366;8088.150744171778;8102.7569172924905;6104.847378815388;7194.856102878018;7307.123145222395;7515.511491753018;7534.811629709082;7166.784996450115;7252.492325537161;7348.889766653398;7406.5926374047785;7409.37020353276;6917.619530925847;6941.444684425132;7016.5088443808445;7027.789166325018;7038.049863268393;4696.2955556666775;4711.1519926413575;4742.241241401359;4813.975930120327;4941.308216849716;4777.665563410528;4795;4811.711297322172;4890.119778439915;5033.169527028 07:57:14 INFO - PROCESS | 1671 | |4;prototype.html;301.9018818883862;311.5855911637522;319.9952000719989;325.2064961493956;329.51725721817564;5834.504067154292;5897.823065308043;5950.880982380355;5975.551833612475;6019.157317975487;4337.848175313865;5851.385604511518;5852.795152169675;5856.47291743743;5881.941180588204;4143.8964025899295;4170.937435938456;4225.218334608092;4290.4851417829905;4353.869383918472;4325.307950727868;4428.490723566782;4431.778411079433;4448.510663826976;4449.953021610063;4401.493828209765;4402.141582391435;4402.7578483183415;4427.623651989585;4450.62169715573;4311.396404503356;4405.096955124224;4418.756968366739;4453.554644535553;4461.866144015685;3447.8103704296254;3479.5302634144573;3546.1666508370513;3820;3826.8660596879254;5527.39198688144;5546.61656389602;5589.860253493654;5613.642270246506;5614.943850561483;4927.778249978724;5104;5115.718635475047;5116.667416617908;5135.3837539495125;5260.447652996457;5412.377576578665;6020.886136064842;6177.289611694668;6239.937600624026;4252.510961239466;4260.2970509866145;4261.296886013804;4270.530241673413;4288.534092896597;5627.465390787868;5641.548676105943;6377.471282331784;6402.807915762534;6573.58667886402;4263.168682107022;4291.485021797342;4297.656187504992;4298.570142985739;4310.827566897352;4354.172707185625;4383.167198232326;4386.298192289219;4388.341748737651;4389.780510974439;4046.5144182698264;4639.37368455261;4967.776450059684;4969.602431805447;5092.166819944817;5927.436893495111;6148.385161483816;6221.191245138103;6243.689834761077;6262.279837818618;1284.1973766396002;1364.8089267502558;1455.1196526101767;1457.3951809998944;1458.824941007086;904.6833608237064;945.5603144537823;957.9558281473228;969.1665167955553;974.2366316966313;5490.780368785204;5493.752781124859;5759.942400576025;5787.623804452697;5804.65172089676;5652.18043383707;6357.904631430532;6378.808635740936;6386.221993432871;6450.161479007793;5419.6477228980775;5719.969410859085;5771.105478650816;5786.3961217452315;5801.767929282782;3196.6483686794436;3330.8834190803204;3357.6306606273292;3377.7297816174646;3380.6281309055985;6257.061440783918;6396.392342727433;6669.199696036507;6710;6849;5290.513458674417;5713.857153571111;6609.900851487231;6700.530962832652;6751.594904305757;5277.050130976461;6494.415502604788;6755.459563235027;6797.6601169941305;6854.2117656470145;6412.447162514481;6429.9678501607195;6484;6488.156539649815;6552.443042341454;5369.436209198134;6272.341404152681;6295.370462953668;6406.519511036598;6450.258220304725;6407.006913928349;6812.591244525344;6854.8286292841085;6859.965700171467;6873.896891546531;4275.914481710286;4340;4365.821228268286;4414.6247568957;4459.843905463423;5396.352437707344;5902.970485147718;6154.815355539341;6428.87494688437;6518.274251167865;5224.477552244745;6320.810375688737;6333.493320534439;6337.081123237197;6338.8732225354315;5534.363548192009;5611;6043.576949613661;6261.24865016201;6294.181756371642;5902.468777810018;6159.784407545714;6168.840905682975;6196.659183744938;6211.503079753518;6295.3389894060465;6331.599538320823;6337.904931426125;6343.5876668016435;6350.301122023029;5572.0746608029485;5804.332501762183;6190.442860142609;6206.782762603287;6227.532935029801 07:57:14 INFO - PROCESS | 1671 | |5;yui.html;737.3806002957515;749.5952185819658;751.0199190056974;756.9621518924052;769.3114662377171;14760;15043.849561504381;15203.239838008098;15256.0846349219;15355;14155.43378264868;14238.786418203736;14294.285285735697;14299.213543255142;14301.713965720679;714.6819665248967;734.4491631276543;885.132570081319;902.0618556701056;904.7195369435464;706.4172058052128;724.6376811594203;735.8344372516194;735.9916913828063;868.1752335281508;919.4804935211617;947.7772723409993;950.2160717408132;950.9667161649344;951.3530799056673;903.3044555692113;937.9718608441724;940.2712897504421;940.5203346293371;940.5438362394199;547.654977364262;677.5054210426367;681.5569879578264;690.5131882023212;693.2028167607292;15156.621084472976;15169.089854608648;15182.924085379502;15188;15215;12550.874491255061;12606.81089783654;12677.809832852514;12700;12845.614631561068;9796.412215267106;9951.800963980751;10017.198624110053;10031.247656425725;10623.468826558641;3451.637578054293;3488.2674638325984;3517.8416971236356;3540.345036168317;3611.3860643690637;79444;80058;80142;80460.59769701114;81899;9503.192228660502;9540.236781057638;9661.661841835503;9716.9028309716;9837.324965953403;22168.778312216993;22193.44516387103;22201;22238.99924503401;22250.443738906655;6440.355964403616;7374.33630973215;7610.695572177051;7649.502782319243;7764.22357764219;4036.394540818842;4072.735272207297;4099.9180016400105;4147.232761939051;4148.9834990427535;3432.4508078707286;3541.734369922266;3542.0613537412605;3542.291541691672;3550.7869527827897;615.0620304036291;651.3649192037725;686.3445409633788;700.399099063501;709.6274455910689;435.8474533913105;572.1789232451446;589.3782059926733;600.9158717779515;606.6057062909144;6928.515003949675;7598.8100297493;7609;7663.965364675698;7814.726484573012;496.2680444154904;504.5257457989478;521.3274875410677;537.2076187623303;570.3298624116646;3712.3688972874675;3750.474933509311;3763.2473505298503;3849.0954625663508;3932.3511620582854;79475.60262198652;82844;82878.17121828825;83890.32219355578;84382;70853;71387.2861271391;71628;72118.63940680263;72637;64981.67509162424;65175;65321.34678653248;66224.33775662375;67742.3225767736;6536.281009088902;7150.284971502808;7252.927470725436;7343.045404097433;7450.292222238879;44151.77924110359;44460.55539444564;44785.10429791321;44866.77566612277;44888.55111448975;57797.864415197415;61172;61750.69124654348;61811.690941545006;62906.741865163356;9678;9959.900400995897;10073.69778906634;10136.645217417356;10288.2798204125;10667.41329226869;10742.462876855969;10745.355278683304;10761;11893.405329733305;10058.446785426871;10153.289269751342;10500.212484063879;10971.341719496855;11112.555497780322;10164.136048435967;10210.132138768287;10235.795284094425;10340.586376544854;10441.321314114559;10365.222608304559;10405.375677459377;10457.63398281087;10478.214133940137;10484.737881553023;8603.612837422455;8619.655213791379;8658.740237792876;8950.865737013819;9199;7650.387968962358;7932.920670793218;8073.515589064675;8082.919170808452;8811.383203175716 07:57:14 INFO - PROCESS | 1671 | __end_tp_report 07:57:14 INFO - PROCESS | 1671 | __start_cc_report 07:57:14 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1384 07:57:14 INFO - PROCESS | 1671 | __end_cc_report 07:57:14 INFO - PROCESS | 1671 | __startTimestamp1461164234835__endTimestamp 07:57:14 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | ------- Summary: start ------- 07:57:14 INFO - PROCESS | 1671 | Number of tests: 6 07:57:14 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5768.97 Median:6041.46 stddev:635.09 (10.5%) stddev-sans-first:609.61 07:57:14 INFO - PROCESS | 1671 | Values: 3415.2 3441.2 3485.2 3490.1 3535.2 5520.5 5578.5 5732.2 5742.2 5746.3 5671.0 5702.5 5704.7 5728.2 5735.1 5184.9 5194.1 5213.5 5226.5 5285.4 5277.1 5280.8 5285.7 5288.4 5300.3 5226.1 5281.9 5282.1 5292.8 5328.3 5275.3 5300.3 5328.8 5339.6 5339.8 5110.6 5146.8 5212.9 5238.0 5263.8 5574.6 5584.7 5654.9 5692.6 5754.8 6210.5 6250.7 6252.9 6267.6 6280.9 6206.8 6258.8 6280.9 6281.2 6289.0 5730.7 5816.2 5922.9 5962.3 5970.5 6226.9 6286.6 6297.3 6309.9 6322.4 6195.4 6203.8 6212.4 6215.8 6221.7 6129.7 6188.0 6288.8 6288.9 6295.5 6185.9 6234.4 6248.3 6249.9 6254.1 6104.6 6269.4 6283.1 6287.2 6292.0 4199.7 4882.7 4904.1 4950.7 4956.9 4432.6 4462.7 4466.5 4468.8 4476.3 5547.7 5746.5 5781.7 5803.0 5851.5 6185.2 6220.2 6225.9 6282.4 6289.5 5706.9 5713.3 5717.0 5726.3 5748.5 5302.0 5387.7 5388.6 5404.3 5404.5 6289.3 6362.2 6368.6 6370.3 6396.7 6258.8 6263.1 6273.2 6299.1 6321.0 6221.3 6306.7 6322.7 6329.4 6383.9 5555.8 5906.1 6145.5 6199.6 6203.6 6094.6 6254.6 6261.9 6271.4 6271.6 6018.9 6092.1 6155.8 6156.0 6184.7 6146.4 6150.9 6171.3 6174.7 6177.5 6041.5 6042.4 6056.4 6069.7 6100.9 5806.9 5983.6 6036.8 6097.7 6160.0 5973.6 6089.9 6098.0 6119.9 6142.1 07:57:14 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:68941.03 Median:34746.98 stddev:165573.60 (476.5%) stddev-sans-first:165958.36 07:57:14 INFO - PROCESS | 1671 | Values: 510.2 520.1 527.5 530.8 536.1 22482.0 29757.1 29933.6 37315.3 38743.8 40325.6 41098.8 41195.8 41242.8 41362.4 9306.4 9530.7 9534.2 9541.0 9547.2 7810.0 8375.3 8453.5 8700.3 9403.0 8583.2 11232.9 11520.2 11523.5 11613.6 11088.7 11223.3 11225.7 11226.4 11228.2 6707.4 11158.1 11318.5 11324.7 11331.6 38776.6 39841.0 39844.0 39865.6 39913.2 3196.3 3239.8 3450.1 3611.4 3994.7 26588.9 26730.2 26793.2 26851.6 26962.2 2641.1 2666.5 2676.5 2880.9 2925.4 293744.0 353006.0 356068.0 356353.0 356438.0 34492.7 35260.3 35329.6 35447.0 57544.7 28663.9 34513.3 34743.8 34750.1 34753.8 13164.5 13291.1 13296.2 13320.6 13323.8 11263.8 11307.2 11331.6 11339.3 11468.1 7581.7 7792.3 8077.7 8092.0 8175.1 3335.4 3438.2 3438.4 3438.6 3470.7 853.6 951.6 980.0 1069.9 1105.1 28043.2 28691.7 28878.4 28995.3 29007.0 1061.6 1067.8 1085.7 1101.7 1126.6 14967.4 14977.2 15270.8 15396.8 15452.2 582786.0 714947.8 725292.0 726323.0 727395.0 52193.0 53613.5 56067.7 56542.7 56925.7 1300.2 1442.7 1467.6 1486.1 1493.5 25281.5 25305.9 28392.7 28480.9 29369.3 51130.0 52488.2 52607.0 52632.0 52743.2 647472.0 648760.0 669298.1 814303.0 814505.0 27071.3 27457.3 27483.6 27511.7 27534.7 44216.6 44505.6 44535.0 44956.6 44978.6 36550.5 36602.3 36656.8 37426.6 37544.6 35839.1 35933.6 36004.1 36218.6 36926.0 35693.6 36051.1 36903.6 36904.3 36999.3 28124.6 30533.8 31727.5 31786.2 32035.0 24068.5 24104.0 24410.5 24416.4 24450.8 07:57:14 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:33417.70 Median:11659.80 stddev:96521.37 (827.8%) stddev-sans-first:96760.29 07:57:14 INFO - PROCESS | 1671 | Values: 394.1 394.3 397.5 397.7 405.3 19112.2 19195.7 20090.8 20142.9 20168.4 18690.2 19307.5 20049.9 20768.0 20773.8 5546.2 5822.1 5907.7 5928.0 5938.1 4882.7 5895.2 5947.7 5966.0 5981.5 5848.8 5988.5 6023.0 6025.6 6027.6 5940.4 6028.8 6031.8 6057.7 6064.4 5614.4 5791.8 5833.2 5833.6 5835.2 13646.6 16760.0 21183.9 21694.9 26397.6 1981.3 2029.2 2065.4 2135.7 2734.1 9819.4 9952.3 9959.7 10181.2 10303.2 1689.5 1719.5 1742.5 1773.9 1775.8 86759.6 109618.5 110663.0 112388.4 116551.0 11582.2 11753.1 11758.5 11767.6 11896.9 14909.5 15169.9 15172.5 15186.6 15188.9 8189.9 8200.1 8398.5 8509.1 8585.7 8047.0 8088.5 8096.1 8161.3 8193.7 4499.4 4585.5 4590.3 4655.6 4665.5 1635.9 1780.6 1830.9 1909.0 1967.9 782.5 861.8 913.3 920.6 985.2 18861.7 19991.6 20523.9 20591.3 20730.4 948.3 957.0 977.2 989.9 1057.0 10788.5 10986.0 11002.3 11043.4 11060.6 569634.2 580306.0 581586.0 583053.0 586775.0 106476.9 107385.0 125726.0 128798.0 130894.3 917.7 1017.7 1018.4 1043.9 1044.9 13868.0 17870.3 18018.9 18151.1 18215.6 43199.7 46650.8 48103.8 49279.3 49752.8 69556.7 70433.0 70840.0 70850.6 72715.6 8211.1 8275.4 8338.6 8472.6 8642.2 11789.2 12294.1 12550.2 12716.4 12761.3 10656.0 10993.1 11241.7 11299.9 11567.0 10627.1 10895.1 11032.8 11246.7 11356.5 11210.9 11357.2 11368.9 11754.2 11797.6 6879.9 7545.2 7603.1 8196.2 8759.0 8930.7 11059.9 11264.4 11349.5 11436.3 07:57:14 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5636.31 Median:5032.67 stddev:3178.07 (63.1%) stddev-sans-first:3170.96 07:57:14 INFO - PROCESS | 1671 | Values: 1390.4 1611.1 1616.0 1902.4 2020.8 7968.8 8620.5 8878.9 8897.1 8897.2 8521.5 8718.9 8759.8 8778.1 8795.9 2401.7 2435.2 2438.2 2438.8 2439.0 2393.6 2426.9 2437.1 2439.4 2474.2 2425.5 2436.3 2447.1 2449.6 2455.4 2402.5 2429.7 2431.1 2431.9 2450.2 2400.0 2409.1 2412.5 2417.7 2419.0 8565.4 8784.1 8835.5 8856.8 8869.2 5276.9 5465.4 5482.0 5487.8 5490.8 3358.7 3363.2 3452.5 3484.1 3492.1 920.5 1014.7 1021.0 1033.4 1046.8 11380.5 11630.1 11675.1 11689.9 11713.6 4545.2 4584.9 4676.3 4737.4 4773.8 9359.1 9373.7 9381.5 9387.0 9390.2 5342.3 5343.4 5347.9 5357.2 5366.4 4452.5 4547.6 4818.5 4987.0 5032.2 3799.4 3801.8 3890.5 3924.1 3929.6 1194.3 1205.6 1209.2 1221.3 1222.7 621.2 758.6 827.6 898.1 901.8 4544.5 5288.3 5505.6 5553.4 5595.6 544.9 571.7 573.3 575.3 703.8 3556.0 3725.5 3786.7 3842.4 3855.7 10444.8 10655.7 10790.0 10892.1 10919.2 10728.6 10733.7 10861.8 10879.2 10901.8 7831.1 8128.7 8214.3 8275.5 8308.8 5074.4 5834.1 5843.9 5983.2 5990.1 9101.6 9821.3 9831.1 9967.3 10081.3 9842.0 9947.6 9960.5 9974.2 10000.2 7333.8 7346.8 7351.1 7521.2 7537.6 8002.3 8016.9 8080.4 8088.2 8102.8 6104.8 7194.9 7307.1 7515.5 7534.8 7166.8 7252.5 7348.9 7406.6 7409.4 6917.6 6941.4 7016.5 7027.8 7038.0 4696.3 4711.2 4742.2 4814.0 4941.3 4777.7 4795.0 4811.7 4890.1 5033.2 07:57:14 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5062.44 Median:5646.86 stddev:1577.84 (27.9%) stddev-sans-first:1541.28 07:57:14 INFO - PROCESS | 1671 | Values: 301.9 311.6 320.0 325.2 329.5 5834.5 5897.8 5950.9 5975.6 6019.2 4337.8 5851.4 5852.8 5856.5 5881.9 4143.9 4170.9 4225.2 4290.5 4353.9 4325.3 4428.5 4431.8 4448.5 4450.0 4401.5 4402.1 4402.8 4427.6 4450.6 4311.4 4405.1 4418.8 4453.6 4461.9 3447.8 3479.5 3546.2 3820.0 3826.9 5527.4 5546.6 5589.9 5613.6 5614.9 4927.8 5104.0 5115.7 5116.7 5135.4 5260.4 5412.4 6020.9 6177.3 6239.9 4252.5 4260.3 4261.3 4270.5 4288.5 5627.5 5641.5 6377.5 6402.8 6573.6 4263.2 4291.5 4297.7 4298.6 4310.8 4354.2 4383.2 4386.3 4388.3 4389.8 4046.5 4639.4 4967.8 4969.6 5092.2 5927.4 6148.4 6221.2 6243.7 6262.3 1284.2 1364.8 1455.1 1457.4 1458.8 904.7 945.6 958.0 969.2 974.2 5490.8 5493.8 5759.9 5787.6 5804.7 5652.2 6357.9 6378.8 6386.2 6450.2 5419.6 5720.0 5771.1 5786.4 5801.8 3196.6 3330.9 3357.6 3377.7 3380.6 6257.1 6396.4 6669.2 6710.0 6849.0 5290.5 5713.9 6609.9 6700.5 6751.6 5277.1 6494.4 6755.5 6797.7 6854.2 6412.4 6430.0 6484.0 6488.2 6552.4 5369.4 6272.3 6295.4 6406.5 6450.3 6407.0 6812.6 6854.8 6860.0 6873.9 4275.9 4340.0 4365.8 4414.6 4459.8 5396.4 5903.0 6154.8 6428.9 6518.3 5224.5 6320.8 6333.5 6337.1 6338.9 5534.4 5611.0 6043.6 6261.2 6294.2 5902.5 6159.8 6168.8 6196.7 6211.5 6295.3 6331.6 6337.9 6343.6 6350.3 5572.1 5804.3 6190.4 6206.8 6227.5 07:57:14 INFO - PROCESS | 1671 | 07:57:14 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:17178.00 Median:61781.19 stddev:23826.03 (38.6%) stddev-sans-first:23860.89 07:57:14 INFO - PROCESS | 1671 | Values: 737.4 749.6 751.0 757.0 769.3 14760.0 15043.8 15203.2 15256.1 15355.0 14155.4 14238.8 14294.3 14299.2 14301.7 714.7 734.4 885.1 902.1 904.7 706.4 724.6 735.8 736.0 868.2 919.5 947.8 950.2 951.0 951.4 903.3 938.0 940.3 940.5 940.5 547.7 677.5 681.6 690.5 693.2 15156.6 15169.1 15182.9 15188.0 15215.0 12550.9 12606.8 12677.8 12700.0 12845.6 9796.4 9951.8 10017.2 10031.2 10623.5 3451.6 3488.3 3517.8 3540.3 3611.4 79444.0 80058.0 80142.0 80460.6 81899.0 9503.2 9540.2 9661.7 9716.9 9837.3 22168.8 22193.4 22201.0 22239.0 22250.4 6440.4 7374.3 7610.7 7649.5 7764.2 4036.4 4072.7 4099.9 4147.2 4149.0 3432.5 3541.7 3542.1 3542.3 3550.8 615.1 651.4 686.3 700.4 709.6 435.8 572.2 589.4 600.9 606.6 6928.5 7598.8 7609.0 7664.0 7814.7 496.3 504.5 521.3 537.2 570.3 3712.4 3750.5 3763.2 3849.1 3932.4 79475.6 82844.0 82878.2 83890.3 84382.0 70853.0 71387.3 71628.0 72118.6 72637.0 64981.7 65175.0 65321.3 66224.3 67742.3 6536.3 7150.3 7252.9 7343.0 7450.3 44151.8 44460.6 44785.1 44866.8 44888.6 57797.9 61172.0 61750.7 61811.7 62906.7 9678.0 9959.9 10073.7 10136.6 10288.3 10667.4 10742.5 10745.4 10761.0 11893.4 10058.4 10153.3 10500.2 10971.3 11112.6 10164.1 10210.1 10235.8 10340.6 10441.3 10365.2 10405.4 10457.6 10478.2 10484.7 8603.6 8619.7 8658.7 8950.9 9199.0 7650.4 7932.9 8073.5 8082.9 8811.4 07:57:14 INFO - PROCESS | 1671 | -------- Summary: end -------- 07:57:14 INFO - PROCESS | 1671 | 07:57:15 INFO - TEST-INFO | 1671: exit 0 07:57:15 INFO - TEST-OK | dromaeo_css | took 1116511ms 07:57:15 INFO - TEST-START | kraken 07:57:15 INFO - operating with platform_type : mac_ 07:57:15 INFO - Initialising browser for kraken test... 07:57:15 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpf9BxQX/profile http://localhost:49276/getInfo.html) 07:57:17 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 07:57:17 INFO - PROCESS | 1676 | colorDepth:24 07:57:17 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 07:57:17 INFO - PROCESS | 1676 | __metrics 07:57:17 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:17 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:57:18 INFO - TEST-INFO | 1676: exit 0 07:57:18 INFO - Browser initialized. 07:57:18 INFO - Running cycle 1/1 for kraken test... 07:57:18 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpf9BxQX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:30 INFO - PROCESS | 1678 | RSS: Main: 237563904 07:57:30 INFO - PROCESS | 1678 | 07:57:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:33 INFO - PROCESS | 1678 | RSS: Main: 285540352 07:57:33 INFO - PROCESS | 1678 | 07:57:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 07:57:37 INFO - PROCESS | 1678 | RSS: Main: 299241472 07:57:37 INFO - PROCESS | 1678 | 07:57:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 07:57:41 INFO - PROCESS | 1678 | RSS: Main: 385536000 07:57:41 INFO - PROCESS | 1678 | 07:57:43 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 07:57:44 INFO - PROCESS | 1678 | RSS: Main: 286371840 07:57:44 INFO - PROCESS | 1678 | 07:57:46 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:46 INFO - PROCESS | 1678 | RSS: Main: 290390016 07:57:46 INFO - PROCESS | 1678 | 07:57:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:50 INFO - PROCESS | 1678 | RSS: Main: 328790016 07:57:50 INFO - PROCESS | 1678 | 07:57:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:53 INFO - PROCESS | 1678 | RSS: Main: 329265152 07:57:53 INFO - PROCESS | 1678 | 07:57:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 07:57:57 INFO - PROCESS | 1678 | RSS: Main: 327122944 07:57:57 INFO - PROCESS | 1678 | 07:57:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:59 INFO - PROCESS | 1678 | RSS: Main: 319807488 07:57:59 INFO - PROCESS | 1678 | 07:58:01 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:01 INFO - PROCESS | 1678 | RSS: Main: 327290880 07:58:01 INFO - PROCESS | 1678 | 07:58:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:04 INFO - PROCESS | 1678 | RSS: Main: 329633792 07:58:04 INFO - PROCESS | 1678 | 07:58:07 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:08 INFO - PROCESS | 1678 | RSS: Main: 334278656 07:58:08 INFO - PROCESS | 1678 | 07:58:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:11 INFO - PROCESS | 1678 | RSS: Main: 332128256 07:58:11 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 07:58:13 INFO - PROCESS | 1678 | RSS: Main: 397070336 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | __start_tp_report 07:58:13 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 07:58:13 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 07:58:13 INFO - PROCESS | 1678 | |i|pagename|runs| 07:58:13 INFO - PROCESS | 1678 | |0;ai-astar;113;111;113;111;111;111;119;110;111;111 07:58:13 INFO - PROCESS | 1678 | |1;audio-beat-detection;158;123;145;172;121;143;139;120;175;117 07:58:13 INFO - PROCESS | 1678 | |2;audio-dft;186;184;195;272;195;185;182;181;186;185 07:58:13 INFO - PROCESS | 1678 | |3;audio-fft;77;73;86;89;58;78;85;119;85;54 07:58:13 INFO - PROCESS | 1678 | |4;audio-oscillator;92;96;131;78;79;82;158;117;112;116 07:58:13 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;90;87;91;88;91;87;89;88;90;91 07:58:13 INFO - PROCESS | 1678 | |6;imaging-darkroom;95;95;96;95;95;95;94;95;94;94 07:58:13 INFO - PROCESS | 1678 | |7;imaging-desaturate;85;86;86;87;87;86;86;85;85;86 07:58:13 INFO - PROCESS | 1678 | |8;json-parse-financial;58;61;58;57;58;59;61;80;59;57 07:58:13 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;66;63;71;75;74;72;69;67;66;67 07:58:13 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;83;82;81;83;80;81;81;83;82 07:58:13 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;140;139;136;134;148;151;135;137;170;142 07:58:13 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;174;167;169;169;172;169;179;170;169;169 07:58:13 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;68;68;69;67;70;69;68;70;68;66 07:58:13 INFO - PROCESS | 1678 | __end_tp_report 07:58:13 INFO - PROCESS | 1678 | __start_cc_report 07:58:13 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,2009 07:58:13 INFO - PROCESS | 1678 | __end_cc_report 07:58:13 INFO - PROCESS | 1678 | __startTimestamp1461164293503__endTimestamp 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | ------- Summary: start ------- 07:58:13 INFO - PROCESS | 1678 | Number of tests: 14 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.00 stddev:2.60 (2.3%) stddev-sans-first:2.74 07:58:13 INFO - PROCESS | 1678 | Values: 113.0 111.0 113.0 111.0 111.0 111.0 119.0 110.0 111.0 111.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:144.00 stddev:21.53 (14.9%) stddev-sans-first:21.97 07:58:13 INFO - PROCESS | 1678 | Values: 158.0 123.0 145.0 172.0 121.0 143.0 139.0 120.0 175.0 117.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:195.10 Median:186.00 stddev:27.44 (14.8%) stddev-sans-first:28.91 07:58:13 INFO - PROCESS | 1678 | Values: 186.0 184.0 195.0 272.0 195.0 185.0 182.0 181.0 186.0 185.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:80.40 Median:81.50 stddev:17.98 (22.1%) stddev-sans-first:19.02 07:58:13 INFO - PROCESS | 1678 | Values: 77.0 73.0 86.0 89.0 58.0 78.0 85.0 119.0 85.0 54.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:78.50 stddev:25.76 (32.8%) stddev-sans-first:26.81 07:58:13 INFO - PROCESS | 1678 | Values: 92.0 96.0 131.0 78.0 79.0 82.0 158.0 117.0 112.0 116.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:90.00 stddev:1.62 (1.8%) stddev-sans-first:1.69 07:58:13 INFO - PROCESS | 1678 | Values: 90.0 87.0 91.0 88.0 91.0 87.0 89.0 88.0 90.0 91.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:58:13 INFO - PROCESS | 1678 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 07:58:13 INFO - PROCESS | 1678 | Values: 85.0 86.0 86.0 87.0 87.0 86.0 86.0 85.0 85.0 86.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:59.00 stddev:6.89 (11.7%) stddev-sans-first:7.24 07:58:13 INFO - PROCESS | 1678 | Values: 58.0 61.0 58.0 57.0 58.0 59.0 61.0 80.0 59.0 57.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:70.00 stddev:3.89 (5.6%) stddev-sans-first:3.97 07:58:13 INFO - PROCESS | 1678 | Values: 66.0 63.0 71.0 75.0 74.0 72.0 69.0 67.0 66.0 67.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:1.10 (1.3%) stddev-sans-first:1.09 07:58:13 INFO - PROCESS | 1678 | Values: 83.0 83.0 82.0 81.0 83.0 80.0 81.0 81.0 83.0 82.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:141.00 stddev:10.92 (7.7%) stddev-sans-first:11.52 07:58:13 INFO - PROCESS | 1678 | Values: 140.0 139.0 136.0 134.0 148.0 151.0 135.0 137.0 170.0 142.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:169.50 stddev:3.50 (2.1%) stddev-sans-first:3.50 07:58:13 INFO - PROCESS | 1678 | Values: 174.0 167.0 169.0 169.0 172.0 169.0 179.0 170.0 169.0 169.0 07:58:13 INFO - PROCESS | 1678 | 07:58:13 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.32 07:58:13 INFO - PROCESS | 1678 | Values: 68.0 68.0 69.0 67.0 70.0 69.0 68.0 70.0 68.0 66.0 07:58:13 INFO - PROCESS | 1678 | -------- Summary: end -------- 07:58:13 INFO - PROCESS | 1678 | 07:58:14 INFO - TEST-INFO | 1678: exit 0 07:58:14 INFO - TEST-OK | kraken | took 58854ms 07:58:14 INFO - SUITE-END | took 1175s 07:58:14 INFO - Completed test suite (00:19:35) 07:58:14 INFO - javascript benchmark 07:58:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3415.231572896098, 3441.156916555443, 3485.198404366994, 3490.144914495949, 3535.1692352297205, 5520.503154716085, 5578.497935185833, 5732.168835518847, 5742.224799652051, 5746.339170995331, 5670.971645141779, 5702.45826646469, 5704.686242256685, 5728.16941543476, 5735.053716136843, 5184.948150518494, 5194.117000109972, 5213.478652134775, 5226.451222621627, 5285.418603953562, 5277.076511610472, 5280.788768449276, 5285.682859028451, 5288.444713305086, 5300.257963885059, 5226.08543504887, 5281.947180528203, 5282.07563676357, 5292.841214763564, 5328.333958255218, 5275.261463395147, 5300.284461597674, 5328.813491527778, 5339.5728341732565, 5339.839804805862, 5110.616703747234, 5146.768395422215, 5212.947870521284, 5238.0, 5263.842084737464, 5574.60977731559, 5584.664920104807, 5654.943450565483, 5692.6299790513895, 5754.769809207669, 6210.534209934228, 6250.656213908233, 6252.937470625327, 6267.561270711052, 6280.87438251237, 6206.782762603287, 6258.78094266703, 6280.905786413162, 6281.214848143982, 6289.0, 5730.656160630376, 5816.214811000503, 5922.940770592239, 5962.284525856925, 5970.462658360769, 6226.937730622726, 6286.622802631857, 6297.307296197415, 6309.936900631027, 6322.430981211713, 6195.4424101831055, 6203.751849925952, 6212.378762123752, 6215.751369945242, 6221.657808820558, 6129.664444256096, 6188.0, 6288.811335659938, 6288.9056664150075, 6295.464885484785, 6185.876282474415, 6234.438900498886, 6248.343923887926, 6249.937500625027, 6254.124422580842, 6104.641056839945, 6269.404406581368, 6283.057541368831, 6287.182666253358, 6292.0, 4199.748015119103, 4882.707037577757, 4904.141775189328, 4950.6782059166035, 4956.876078098005, 4432.645388368923, 4462.732236065846, 4466.486354069259, 4468.798904049326, 4476.26141686618, 5547.694876781735, 5746.540276777848, 5781.71091445426, 5802.993901312122, 5851.531877449794, 6185.226846644169, 6220.222472190976, 6225.906611400742, 6282.371762823681, 6289.496840252768, 5706.885862282814, 5713.342965559014, 5717.028105222123, 5726.312842458931, 5748.48263656273, 5301.9926214019215, 5387.730613469311, 5388.622796404293, 5404.32445944257, 5404.513593776579, 6289.339619339903, 6362.172917520786, 6368.554201205871, 6370.299267080525, 6396.680165991775, 6258.812235632939, 6263.123162757127, 6273.215848018997, 6299.086632438362, 6321.0, 6221.2845522765465, 6306.684665766602, 6322.715477803602, 6329.430351268408, 6383.904241436289, 5555.777768889199, 5906.084556893688, 6145.539084568764, 6199.628022318675, 6203.596766210182, 6094.573379863545, 6254.593451425642, 6261.937380626136, 6271.3728627136925, 6271.592346497463, 6018.879622407615, 6092.116643086816, 6155.768846230682, 6156.0, 6184.690765461799, 6146.4468197860615, 6150.923588372107, 6171.290301615192, 6174.660393678211, 6177.4749146321265, 6041.456268935817, 6042.395760423922, 6056.424639659225, 6069.696515174312, 6100.908486372797, 5806.883862322646, 5983.611065280743, 6036.849078773066, 6097.695115244132, 6159.969200153971, 5973.611715238496, 6089.875495217711, 6098.009036294196, 6119.868162944292, 6142.109394137914], "value": 5728.778435145789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.2270060857801, 520.0872468817228, 527.5199568392763, 530.7611574791343, 536.1180857489429, 22482.0, 29757.10728678138, 29933.55099673504, 37315.25369492608, 38743.80628096862, 40325.59674403255, 41098.79450602743, 41195.79402102993, 41242.7937860311, 41362.37956430649, 9306.39508431953, 9530.666426675069, 9534.189593884528, 9541.0, 9547.23622110233, 7810.0, 8375.329973602098, 8453.535055571941, 8700.347473939448, 9402.952985235064, 8583.227509524142, 11232.943835280812, 11520.193586448951, 11523.481443335028, 11613.593524226653, 11088.722781930435, 11223.32660040392, 11225.719357016058, 11226.438678066146, 11228.214025018253, 6707.396334329885, 11158.051565616932, 11318.547258109666, 11324.716882078013, 11331.603393881174, 38776.61223387758, 39841.0, 39844.0, 39865.60134398677, 39913.201735965406, 3196.3127927495466, 3239.7732158748895, 3450.1374656335915, 3611.368010598135, 3994.660453861425, 26588.867055664792, 26730.198094057014, 26793.19620411391, 26851.597226041624, 26962.191134266002, 2641.0624228398833, 2666.533356662596, 2676.51822671919, 2880.942381152386, 2925.400292939942, 293744.0, 353006.0, 356068.0, 356353.0, 356438.0, 34492.65507344894, 35260.294794103975, 35329.646703532635, 35447.0, 57544.71227643835, 28663.856680716464, 34513.30973380568, 34743.82628086843, 34750.13124671904, 34753.82623086919, 13164.539241126515, 13291.136076155019, 13296.202227866359, 13320.600381988555, 13323.800142997863, 11263.774724505463, 11307.151963602599, 11331.603393881174, 11339.319640821577, 11468.082553395709, 7581.734639287709, 7792.337651299703, 8077.717279895293, 8092.028956525137, 8175.059868115124, 3335.366280406715, 3438.1748380388526, 3438.398280300937, 3438.6045604755273, 3470.670286322795, 853.5604163855619, 951.6050838901779, 979.9755006124904, 1069.9144068474504, 1105.1490352428584, 28043.158705238875, 28691.696245563333, 28878.42243155125, 28995.275118122216, 29007.0, 1061.596593294543, 1067.8024565455416, 1085.7068591480413, 1101.7025403141267, 1126.594426006637, 14967.401303947938, 14977.176255305845, 15270.770938435933, 15396.769048464283, 15452.227388630523, 582786.0, 714947.8273477706, 725292.0, 726323.0, 727395.0, 52193.0, 53613.46386536163, 56067.71966140143, 56542.717286414125, 56925.71537142288, 1300.1808860417875, 1442.7114577084626, 1467.6404280951235, 1486.1454663568275, 1493.5071426429035, 25281.49437011286, 25305.87347063253, 28392.716072839008, 28480.85759571189, 29369.265768355963, 51130.0, 52488.21267681064, 52607.0, 52632.0, 52743.20885186802, 647472.0, 648760.0, 669298.1096606648, 814303.0, 814505.0, 27071.323216919736, 27457.31356716098, 27483.587746183424, 27511.724882750917, 27534.724652753215, 44216.55783442253, 44505.55494445014, 44535.0, 44956.550434495235, 44978.55021449875, 36550.4517432244, 36602.26795464023, 36656.81671591625, 37426.625733742316, 37544.62455375411, 35839.104022399646, 35933.64066359407, 36004.14170989222, 36218.63781362153, 36926.0, 35693.643063569034, 36051.0987225311, 36903.63096369002, 36904.26191476209, 36999.260014799016, 28124.59377031181, 30533.847330763205, 31727.52408713825, 31786.205344866565, 32035.03894883064, 24068.51862962766, 24104.0, 24410.51178976446, 24416.389590259674, 24450.755492445558], "value": 18019.13894991914, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.05820089984957, 394.30798947846534, 397.4554859842016, 397.68582819572504, 405.25433202906663, 19112.184342487442, 19195.712064319046, 20090.799092009074, 20142.89928550357, 20168.39494815156, 18690.158942847604, 19307.517312067204, 20049.899750501263, 20768.0, 20773.79226207741, 5546.195801608765, 5822.068469044964, 5907.7046147692445, 5928.02187639039, 5938.079597662369, 4882.731449770261, 5895.233619629442, 5947.672877991708, 5966.0, 5981.5214782817275, 5848.7660493580415, 5988.490978266853, 6022.969885150568, 6025.638461692312, 6027.578069535134, 5940.435658612425, 6028.7588496460085, 6031.758729650809, 6057.697115144248, 6064.42387973144, 5614.438556144353, 5791.82624521265, 5833.212516310286, 5833.562482813763, 5835.212246346774, 13646.590602281947, 16760.0, 21183.89408052965, 21694.91525423738, 26397.604035939476, 1981.2867367747745, 2029.249177804222, 2065.3597384810755, 2135.7010018597252, 2734.0840818325883, 9819.36174148678, 9952.253580981456, 9959.701208963743, 10181.18550515957, 10303.175745940307, 1689.501597028867, 1719.5271300392492, 1742.4859666398443, 1773.9024353660543, 1775.7602723632403, 86759.56620216921, 109618.45190773995, 110663.0, 112388.43805780918, 116551.0, 11582.189246752814, 11753.118516111326, 11758.470868810924, 11767.646970590897, 11896.940515297541, 14909.478168264059, 15169.924150379178, 15172.544823655307, 15186.620334491727, 15188.924055379874, 8189.918100819034, 8200.05699344571, 8398.496090234605, 8509.064002959669, 8585.699500517452, 8046.9597652012535, 8088.514689118671, 8096.149904259968, 8161.347092232607, 8193.713220037389, 4499.437570303712, 4585.518520555293, 4590.288505281686, 4655.580997710223, 4665.533446655375, 1635.9039443572597, 1780.608266181438, 1830.881732387429, 1908.9809101909082, 1967.9409617711492, 782.5265714242915, 861.8448679237797, 913.3469569258012, 920.6132136238858, 985.2216748768393, 18861.717074243898, 19991.60016799656, 20523.897380513, 20591.279305224245, 20730.378088657366, 948.307735353196, 956.9952150239344, 977.237754551451, 989.8713167288206, 1056.9630062947913, 10788.46057697112, 10986.0, 11002.284851484788, 11043.392613406178, 11060.612878549213, 569634.1518292382, 580306.0, 581586.0, 583053.0, 586775.0, 106476.87046259186, 107385.0, 125726.0, 128798.0, 130894.34552827365, 917.6604656277086, 1017.7099526635021, 1018.3940555369543, 1043.9164866810636, 1044.9373037617615, 13868.0, 17870.285188592312, 18018.91886486815, 18151.12114567177, 18215.633827463258, 43199.70400887978, 46650.76674616605, 48103.75948120237, 49279.260811087144, 49752.75123624359, 69556.6522167386, 70433.0, 70840.0, 70850.64574677094, 72715.63642181967, 8211.055728591049, 8275.420720549504, 8338.624761885609, 8472.57637118154, 8642.22220000178, 11789.233699809485, 12294.139410241198, 12550.1842380245, 12716.36418179106, 12761.298128603015, 10656.0, 10993.065589424989, 11241.718957025812, 11299.943500282447, 11567.0, 10627.09669678086, 10895.128389728961, 11032.779344412906, 11246.66260012201, 11356.545738170711, 11210.887891120985, 11357.204995650225, 11368.886311137114, 11754.177207595729, 11797.646070617895, 6879.8968015480805, 7545.153040837687, 7603.0876294844975, 8196.221358970888, 8759.03650598421, 8930.687425940061, 11059.944700276768, 11264.38045907483, 11349.54601815918, 11436.313821170756], "value": 9350.548438983153, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.395178097527, 1611.0897343001204, 1615.951521454356, 1902.391234804862, 2020.7575090989073, 7968.840623187532, 8620.482771033743, 8878.911210887889, 8897.1102889711, 8897.199252067305, 8521.488710677364, 8718.912810871905, 8759.824803503927, 8778.122187781235, 8795.868061979076, 2401.6637670726113, 2435.2450740270483, 2438.183208625113, 2438.8170887183533, 2438.975610243893, 2393.628987506939, 2426.9393265168337, 2437.098273638756, 2439.4023464251195, 2474.1958863369387, 2425.5391475619576, 2436.3300092474533, 2447.0578827151585, 2449.608062709967, 2455.373879660684, 2402.4714562796157, 2429.744876787938, 2431.0761910474084, 2431.902723891042, 2450.15469662966, 2399.9520009599887, 2409.0965887792077, 2412.4692567635093, 2417.6736140620965, 2419.0444774314224, 8565.357598180099, 8784.12158784123, 8835.514046727427, 8856.822863542757, 8869.2017718405, 5276.92084618731, 5465.398806131322, 5482.013237617227, 5487.75305111267, 5490.780368785244, 3358.697717205463, 3363.209645733251, 3452.4993875887853, 3484.1463841358777, 3492.109512074405, 920.4891285336636, 1014.6550172941236, 1020.9795804083876, 1033.421284080917, 1046.7540128069897, 11380.544778208861, 11630.127740419503, 11675.065994720488, 11689.883101168965, 11713.648590542298, 4545.159145558082, 4584.931226031612, 4676.321933319718, 4737.431508218967, 4773.76131193439, 9359.110884465965, 9373.671921482852, 9381.530923453936, 9386.95306523463, 9390.154886060287, 5342.305500284938, 5343.412224655285, 5347.946520534822, 5357.1696387060065, 5366.382865970385, 4452.48796388413, 4547.590716835501, 4818.542238487338, 4987.0, 5032.169692000852, 3799.4490798834013, 3801.7718936863325, 3890.4942357493346, 3924.117073658404, 3929.6070392961046, 1194.2595590733627, 1205.6081773423673, 1209.2079687804503, 1221.3404761428906, 1222.6698791326291, 621.2451870976785, 758.5624099020685, 827.5820710541138, 898.1108702384593, 901.8016036471965, 4544.545545445429, 5288.312519372457, 5505.642133261325, 5553.361363443175, 5595.63628364155, 544.8910217956425, 571.6655756382563, 573.3435216676965, 575.3211210771331, 703.7712743358429, 3555.982220088883, 3725.5343082114737, 3786.659200671953, 3842.3852183650483, 3855.7108216883285, 10444.843327350096, 10655.680329590125, 10790.0, 10892.074173695166, 10919.235653504178, 10728.624498142528, 10733.677989660322, 10861.83707244392, 10879.238453308193, 10901.83647245292, 7831.138574756772, 8128.674853005932, 8214.26071653554, 8275.462094963928, 8308.83382332362, 5074.391073071255, 5834.066549352084, 5843.94156058434, 5983.192269043623, 5990.063027092765, 9101.590428430603, 9821.263405244777, 9831.066048725359, 9967.302288839712, 10081.344712593658, 9841.950790246003, 9947.602095916081, 9960.501974901372, 9974.152197063331, 10000.24998125129, 7333.816654583678, 7346.77959661211, 7351.081114860643, 7521.210272921265, 7537.585432801248, 8002.319802816825, 8016.8797468036855, 8080.353571714366, 8088.150744171778, 8102.7569172924905, 6104.847378815388, 7194.856102878018, 7307.123145222395, 7515.511491753018, 7534.811629709082, 7166.784996450115, 7252.492325537161, 7348.889766653398, 7406.5926374047785, 7409.37020353276, 6917.619530925847, 6941.444684425132, 7016.5088443808445, 7027.789166325018, 7038.049863268393, 4696.2955556666775, 4711.1519926413575, 4742.241241401359, 4813.975930120327, 4941.308216849716, 4777.665563410528, 4795.0, 4811.711297322172, 4890.119778439915, 5033.169527028], "value": 4479.361388094858, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.9018818883862, 311.5855911637522, 319.9952000719989, 325.2064961493956, 329.51725721817564, 5834.504067154292, 5897.823065308043, 5950.880982380355, 5975.551833612475, 6019.157317975487, 4337.848175313865, 5851.385604511518, 5852.795152169675, 5856.47291743743, 5881.941180588204, 4143.8964025899295, 4170.937435938456, 4225.218334608092, 4290.4851417829905, 4353.869383918472, 4325.307950727868, 4428.490723566782, 4431.778411079433, 4448.510663826976, 4449.953021610063, 4401.493828209765, 4402.141582391435, 4402.7578483183415, 4427.623651989585, 4450.62169715573, 4311.396404503356, 4405.096955124224, 4418.756968366739, 4453.554644535553, 4461.866144015685, 3447.8103704296254, 3479.5302634144573, 3546.1666508370513, 3820.0, 3826.8660596879254, 5527.39198688144, 5546.61656389602, 5589.860253493654, 5613.642270246506, 5614.943850561483, 4927.778249978724, 5104.0, 5115.718635475047, 5116.667416617908, 5135.3837539495125, 5260.447652996457, 5412.377576578665, 6020.886136064842, 6177.289611694668, 6239.937600624026, 4252.510961239466, 4260.2970509866145, 4261.296886013804, 4270.530241673413, 4288.534092896597, 5627.465390787868, 5641.548676105943, 6377.471282331784, 6402.807915762534, 6573.58667886402, 4263.168682107022, 4291.485021797342, 4297.656187504992, 4298.570142985739, 4310.827566897352, 4354.172707185625, 4383.167198232326, 4386.298192289219, 4388.341748737651, 4389.780510974439, 4046.5144182698264, 4639.37368455261, 4967.776450059684, 4969.602431805447, 5092.166819944817, 5927.436893495111, 6148.385161483816, 6221.191245138103, 6243.689834761077, 6262.279837818618, 1284.1973766396002, 1364.8089267502558, 1455.1196526101767, 1457.3951809998944, 1458.824941007086, 904.6833608237064, 945.5603144537823, 957.9558281473228, 969.1665167955553, 974.2366316966313, 5490.780368785204, 5493.752781124859, 5759.942400576025, 5787.623804452697, 5804.65172089676, 5652.18043383707, 6357.904631430532, 6378.808635740936, 6386.221993432871, 6450.161479007793, 5419.6477228980775, 5719.969410859085, 5771.105478650816, 5786.3961217452315, 5801.767929282782, 3196.6483686794436, 3330.8834190803204, 3357.6306606273292, 3377.7297816174646, 3380.6281309055985, 6257.061440783918, 6396.392342727433, 6669.199696036507, 6710.0, 6849.0, 5290.513458674417, 5713.857153571111, 6609.900851487231, 6700.530962832652, 6751.594904305757, 5277.050130976461, 6494.415502604788, 6755.459563235027, 6797.6601169941305, 6854.2117656470145, 6412.447162514481, 6429.9678501607195, 6484.0, 6488.156539649815, 6552.443042341454, 5369.436209198134, 6272.341404152681, 6295.370462953668, 6406.519511036598, 6450.258220304725, 6407.006913928349, 6812.591244525344, 6854.8286292841085, 6859.965700171467, 6873.896891546531, 4275.914481710286, 4340.0, 4365.821228268286, 4414.6247568957, 4459.843905463423, 5396.352437707344, 5902.970485147718, 6154.815355539341, 6428.87494688437, 6518.274251167865, 5224.477552244745, 6320.810375688737, 6333.493320534439, 6337.081123237197, 6338.8732225354315, 5534.363548192009, 5611.0, 6043.576949613661, 6261.24865016201, 6294.181756371642, 5902.468777810018, 6159.784407545714, 6168.840905682975, 6196.659183744938, 6211.503079753518, 6295.3389894060465, 6331.599538320823, 6337.904931426125, 6343.5876668016435, 6350.301122023029, 5572.0746608029485, 5804.332501762183, 6190.442860142609, 6206.782762603287, 6227.532935029801], "value": 4545.2215884196985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3806002957515, 749.5952185819658, 751.0199190056974, 756.9621518924052, 769.3114662377171, 14760.0, 15043.849561504381, 15203.239838008098, 15256.0846349219, 15355.0, 14155.43378264868, 14238.786418203736, 14294.285285735697, 14299.213543255142, 14301.713965720679, 714.6819665248967, 734.4491631276543, 885.132570081319, 902.0618556701056, 904.7195369435464, 706.4172058052128, 724.6376811594203, 735.8344372516194, 735.9916913828063, 868.1752335281508, 919.4804935211617, 947.7772723409993, 950.2160717408132, 950.9667161649344, 951.3530799056673, 903.3044555692113, 937.9718608441724, 940.2712897504421, 940.5203346293371, 940.5438362394199, 547.654977364262, 677.5054210426367, 681.5569879578264, 690.5131882023212, 693.2028167607292, 15156.621084472976, 15169.089854608648, 15182.924085379502, 15188.0, 15215.0, 12550.874491255061, 12606.81089783654, 12677.809832852514, 12700.0, 12845.614631561068, 9796.412215267106, 9951.800963980751, 10017.198624110053, 10031.247656425725, 10623.468826558641, 3451.637578054293, 3488.2674638325984, 3517.8416971236356, 3540.345036168317, 3611.3860643690637, 79444.0, 80058.0, 80142.0, 80460.59769701114, 81899.0, 9503.192228660502, 9540.236781057638, 9661.661841835503, 9716.9028309716, 9837.324965953403, 22168.778312216993, 22193.44516387103, 22201.0, 22238.99924503401, 22250.443738906655, 6440.355964403616, 7374.33630973215, 7610.695572177051, 7649.502782319243, 7764.22357764219, 4036.394540818842, 4072.735272207297, 4099.9180016400105, 4147.232761939051, 4148.9834990427535, 3432.4508078707286, 3541.734369922266, 3542.0613537412605, 3542.291541691672, 3550.7869527827897, 615.0620304036291, 651.3649192037725, 686.3445409633788, 700.399099063501, 709.6274455910689, 435.8474533913105, 572.1789232451446, 589.3782059926733, 600.9158717779515, 606.6057062909144, 6928.515003949675, 7598.8100297493, 7609.0, 7663.965364675698, 7814.726484573012, 496.2680444154904, 504.5257457989478, 521.3274875410677, 537.2076187623303, 570.3298624116646, 3712.3688972874675, 3750.474933509311, 3763.2473505298503, 3849.0954625663508, 3932.3511620582854, 79475.60262198652, 82844.0, 82878.17121828825, 83890.32219355578, 84382.0, 70853.0, 71387.2861271391, 71628.0, 72118.63940680263, 72637.0, 64981.67509162424, 65175.0, 65321.34678653248, 66224.33775662375, 67742.3225767736, 6536.281009088902, 7150.284971502808, 7252.927470725436, 7343.045404097433, 7450.292222238879, 44151.77924110359, 44460.55539444564, 44785.10429791321, 44866.77566612277, 44888.55111448975, 57797.864415197415, 61172.0, 61750.69124654348, 61811.690941545006, 62906.741865163356, 9678.0, 9959.900400995897, 10073.69778906634, 10136.645217417356, 10288.2798204125, 10667.41329226869, 10742.462876855969, 10745.355278683304, 10761.0, 11893.405329733305, 10058.446785426871, 10153.289269751342, 10500.212484063879, 10971.341719496855, 11112.555497780322, 10164.136048435967, 10210.132138768287, 10235.795284094425, 10340.586376544854, 10441.321314114559, 10365.222608304559, 10405.375677459377, 10457.63398281087, 10478.214133940137, 10484.737881553023, 8603.612837422455, 8619.655213791379, 8658.740237792876, 8950.865737013819, 9199.0, 7650.387968962358, 7932.920670793218, 8073.515589064675, 8082.919170808452, 8811.383203175716], "value": 6580.012396383177, "unit": "score"}], "name": "dromaeo_css", "value": 7111.232975622882, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 111.0, 111.0, 111.0, 119.0, 110.0, 111.0, 111.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 145.0, 172.0, 121.0, 143.0, 139.0, 120.0, 175.0, 117.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 195.0, 272.0, 195.0, 185.0, 182.0, 181.0, 186.0, 185.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 86.0, 89.0, 58.0, 78.0, 85.0, 119.0, 85.0, 54.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 131.0, 78.0, 79.0, 82.0, 158.0, 117.0, 112.0, 116.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 88.0, 91.0, 87.0, 89.0, 88.0, 90.0, 91.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 87.0, 87.0, 86.0, 86.0, 85.0, 85.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 58.0, 57.0, 58.0, 59.0, 61.0, 80.0, 59.0, 57.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 71.0, 75.0, 74.0, 72.0, 69.0, 67.0, 66.0, 67.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 81.0, 83.0, 80.0, 81.0, 81.0, 83.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 136.0, 134.0, 148.0, 151.0, 135.0, 137.0, 170.0, 142.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 167.0, 169.0, 169.0, 172.0, 169.0, 179.0, 170.0, 169.0, 169.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 70.0, 69.0, 68.0, 70.0, 68.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1498.8, "alertThreshold": 2.0}]} 07:58:14 INFO - Return code: 0 07:58:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:58:14 ERROR - # TBPL SUCCESS # 07:58:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:58:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:58:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:58:14 INFO - 2016-04-20 07:58:14.806 screenresolution[1682:9954] starting screenresolution argv=screenresolution get 07:58:14 INFO - 2016-04-20 07:58:14.809 screenresolution[1682:9954] Display 0: 1600x1200x32@60 07:58:14 INFO - 2016-04-20 07:58:14.814 screenresolution[1683:9957] starting screenresolution argv=screenresolution list 07:58:14 INFO - Available Modes on Display 0 07:58:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:58:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:58:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:58:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:58:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:58:15 INFO - Intel Iris: 07:58:15 INFO - Chipset Model: Intel Iris 07:58:15 INFO - Type: GPU 07:58:15 INFO - Bus: Built-In 07:58:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:58:15 INFO - Vendor: Intel (0x8086) 07:58:15 INFO - Device ID: 0x0a2e 07:58:15 INFO - Revision ID: 0x0009 07:58:15 INFO - Displays: 07:58:15 INFO - Display: 07:58:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:58:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:58:15 INFO - Display Serial Number: 1600x1200 60 07:58:15 INFO - Main Display: Yes 07:58:15 INFO - Mirror: Off 07:58:15 INFO - Online: Yes 07:58:15 INFO - Rotation: Supported 07:58:15 INFO - Return code: 0 07:58:15 INFO - Running post-action listener: _resource_record_post_action 07:58:15 INFO - Running post-run listener: _resource_record_post_run 07:58:16 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 32374272; Write bytes: 695434752; Read time: 322; Write time: 1844 07:58:16 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 394582528; Write bytes: 390019072; Read time: 29645; Write time: 760 07:58:16 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30580224; Write bytes: 296154624; Read time: 302; Write time: 1032 07:58:16 INFO - Running post-run listener: _upload_blobber_files 07:58:16 INFO - Blob upload gear active. 07:58:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:16 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:58:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:17 INFO - (blobuploader) - INFO - Done attempting. 07:58:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:58:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:18 INFO - (blobuploader) - INFO - Done attempting. 07:58:18 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:18 INFO - Return code: 0 07:58:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cef6f08d8a8f7b3de9e59bf714d482144a097c15ae637244025ace92c3311eb7e8958e24b9a9cc9884d087a8bfd265b88c8df8f666b70d4fd54a515fd420e89f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd38e9c0418a8b3ba3e38de965a7b3282bc0e1cfe025e3b736fa1b856473fc95dbae15611c357806aa313d541b0e7bf6deedfddf296185ab385b7dd8e8dca2df"} 07:58:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:18 INFO - Contents: 07:58:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cef6f08d8a8f7b3de9e59bf714d482144a097c15ae637244025ace92c3311eb7e8958e24b9a9cc9884d087a8bfd265b88c8df8f666b70d4fd54a515fd420e89f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd38e9c0418a8b3ba3e38de965a7b3282bc0e1cfe025e3b736fa1b856473fc95dbae15611c357806aa313d541b0e7bf6deedfddf296185ab385b7dd8e8dca2df"} 07:58:18 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:18 INFO - Copying logs to upload dir... 07:58:18 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.254681 ========= master_lag: 2.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-20 07:58:21.091649) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 07:58:21.095374) ========= 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.z21FAiNMUc/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.xE1GX4Nflg/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cef6f08d8a8f7b3de9e59bf714d482144a097c15ae637244025ace92c3311eb7e8958e24b9a9cc9884d087a8bfd265b88c8df8f666b70d4fd54a515fd420e89f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd38e9c0418a8b3ba3e38de965a7b3282bc0e1cfe025e3b736fa1b856473fc95dbae15611c357806aa313d541b0e7bf6deedfddf296185ab385b7dd8e8dca2df"} build_url:https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011768 build_url: 'https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cef6f08d8a8f7b3de9e59bf714d482144a097c15ae637244025ace92c3311eb7e8958e24b9a9cc9884d087a8bfd265b88c8df8f666b70d4fd54a515fd420e89f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd38e9c0418a8b3ba3e38de965a7b3282bc0e1cfe025e3b736fa1b856473fc95dbae15611c357806aa313d541b0e7bf6deedfddf296185ab385b7dd8e8dca2df"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 07:58:21.238828) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:58:21.239161) ========= 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.z21FAiNMUc/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.xE1GX4Nflg/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005303 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 07:58:21.260221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 07:58:21.260792) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 07:58:21.261482) ========= ========= Total master_lag: 9.26 =========