builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0095 starttime: 1461166700.29 results: success (0) buildid: 20160420053850 builduid: db978b6c5222466a89fb1ea0fc60f9d5 revision: 19b8851d8d4c19997ecc73960f4de8d90c981c28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:20.288896) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:20.289323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:20.289611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:20.328337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:20.328838) ========= 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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:38:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-04-20 08:38:20 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159307 ========= master_lag: 0.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:20.939285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:20.939637) ========= 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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.028423 ========= master_lag: 0.35 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:21.319605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-20 08:38:21.320021) ========= 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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:38:21,571 truncating revision to first 12 chars 2016-04-20 08:38:21,571 Setting DEBUG logging. 2016-04-20 08:38:21,571 attempt 1/10 2016-04-20 08:38:21,571 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 08:38:22,696 unpacking tar archive at: fx-team-19b8851d8d4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.374212 ========= master_lag: 3.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-20 08:38:26.223637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:26.226950) ========= script_repo_revision: 19b8851d8d4c19997ecc73960f4de8d90c981c28 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:26.227384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:26.227658) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 08:38:26.584528) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-20 08:38:26.584811) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:38:26 INFO - MultiFileLogger online at 20160420 08:38:26 in /builds/slave/test 08:38:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:38:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:26 INFO - {'append_to_log': False, 08:38:26 INFO - 'base_work_dir': '/builds/slave/test', 08:38:26 INFO - 'blob_upload_branch': 'Fx-Team', 08:38:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:26 INFO - 'branch': 'Fx-Team', 08:38:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:26 INFO - 'config_files': ('talos/mac_config.py',), 08:38:26 INFO - 'default_actions': ('clobber', 08:38:26 INFO - 'read-buildbot-config', 08:38:26 INFO - 'download-and-extract', 08:38:26 INFO - 'populate-webroot', 08:38:26 INFO - 'create-virtualenv', 08:38:26 INFO - 'install', 08:38:26 INFO - 'run-tests'), 08:38:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:26 INFO - 'download_minidump_stackwalk': True, 08:38:26 INFO - 'download_symbols': 'ondemand', 08:38:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:26 INFO - 'installer_path': 'installer.exe', 08:38:26 INFO - 'log_level': 'info', 08:38:26 INFO - 'log_name': 'talos', 08:38:26 INFO - 'log_to_console': True, 08:38:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:38:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:38:26 INFO - 'opt_config_files': (), 08:38:26 INFO - 'pip_index': False, 08:38:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:26 INFO - 'cmd': ('bash', 08:38:26 INFO - '-c', 08:38:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:26 INFO - 'enabled': True, 08:38:26 INFO - 'halt_on_failure': False, 08:38:26 INFO - 'name': 'check_screen_resolution'},), 08:38:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:26 INFO - 'cmd': ('bash', 08:38:26 INFO - '-c', 08:38:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:26 INFO - 'enabled': True, 08:38:26 INFO - 'halt_on_failure': False, 08:38:26 INFO - 'name': 'check_screen_resolution'},), 08:38:26 INFO - 'run_cmd_checks_enabled': True, 08:38:26 INFO - 'sps_profile': False, 08:38:26 INFO - 'sps_profile_interval': 0, 08:38:26 INFO - 'suite': 'dromaeojs-e10s', 08:38:26 INFO - 'system_bits': '32', 08:38:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:26 INFO - 'title': 't-yosemite-r7-0095', 08:38:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:26 INFO - 'use_talos_json': True, 08:38:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:26 INFO - 'work_dir': 'build'} 08:38:26 INFO - ##### 08:38:26 INFO - ##### Running clobber step. 08:38:26 INFO - ##### 08:38:26 INFO - Running pre-action listener: _resource_record_pre_action 08:38:26 INFO - Running main action method: clobber 08:38:26 INFO - rmtree: /builds/slave/test/build 08:38:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:28 INFO - Running post-action listener: _resource_record_post_action 08:38:28 INFO - ##### 08:38:28 INFO - ##### Running read-buildbot-config step. 08:38:28 INFO - ##### 08:38:28 INFO - Running pre-action listener: _resource_record_pre_action 08:38:28 INFO - Running main action method: read_buildbot_config 08:38:28 INFO - Using buildbot properties: 08:38:28 INFO - { 08:38:28 INFO - "project": "", 08:38:28 INFO - "product": "firefox", 08:38:28 INFO - "script_repo_revision": "production", 08:38:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:38:28 INFO - "repository": "", 08:38:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:38:28 INFO - "buildid": "20160420053850", 08:38:28 INFO - "pgo_build": "False", 08:38:28 INFO - "basedir": "/builds/slave/test", 08:38:28 INFO - "buildnumber": 627, 08:38:28 INFO - "slavename": "t-yosemite-r7-0095", 08:38:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:38:28 INFO - "platform": "yosemite_r7", 08:38:28 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:38:28 INFO - "branch": "fx-team", 08:38:28 INFO - "repo_path": "integration/fx-team", 08:38:28 INFO - "revision": "19b8851d8d4c19997ecc73960f4de8d90c981c28", 08:38:28 INFO - "stage_platform": "macosx64", 08:38:28 INFO - "builduid": "db978b6c5222466a89fb1ea0fc60f9d5", 08:38:28 INFO - "slavebuilddir": "test" 08:38:28 INFO - } 08:38:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:38:28 INFO - Running post-action listener: _resource_record_post_action 08:38:28 INFO - ##### 08:38:28 INFO - ##### Running download-and-extract step. 08:38:28 INFO - ##### 08:38:28 INFO - Running pre-action listener: _resource_record_pre_action 08:38:28 INFO - Running main action method: download_and_extract 08:38:28 INFO - mkdir: /builds/slave/test/build/tests 08:38:28 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')]} 08:38:28 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 08:38:28 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 08:38:28 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 08:38:28 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 08:38:28 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 08:38:29 INFO - Downloaded 1199 bytes. 08:38:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:38:29 INFO - Using the following test package requirements: 08:38:29 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:38:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:38:29 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:38:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:38:29 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:38:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:38:29 INFO - u'jsshell-mac.zip'], 08:38:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:38:29 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:38:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:38:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:38:29 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:38:29 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:38:29 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:38:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:38:29 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:38:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:38:29 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:38:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:38:29 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')]} 08:38:29 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 08:38:29 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 08:38:29 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 08:38:29 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 08:38:29 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 08:38:30 INFO - Downloaded 18096150 bytes. 08:38:30 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'] 08:38:30 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 08:38:34 INFO - Return code: 0 08:38:34 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 08:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:34 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 08:38:34 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 08:38:34 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 08:38:34 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 08:38:34 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 08:38:35 INFO - Downloaded 18096150 bytes. 08:38:35 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'] 08:38:35 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 08:38:39 INFO - Return code: 0 08:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:39 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 08:38:39 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 08:38:39 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 08:38:39 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 08:38:39 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 08:38:40 INFO - Downloaded 10845952 bytes. 08:38:40 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'] 08:38:40 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 08:38:40 INFO - Return code: 0 08:38: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')]} 08:38:40 INFO - https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:38:40 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 08:38:40 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 08:38:40 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 08:38:40 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 08:38:43 INFO - Downloaded 110041716 bytes. 08:38:43 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 08:38:43 INFO - mkdir: /builds/slave/test/properties 08:38:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:38:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:38:43 INFO - Contents: 08:38:43 INFO - build_url:https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:38:44 INFO - Running post-action listener: _resource_record_post_action 08:38:44 INFO - Running post-action listener: set_extra_try_arguments 08:38:44 INFO - ##### 08:38:44 INFO - ##### Running populate-webroot step. 08:38:44 INFO - ##### 08:38:44 INFO - Running pre-action listener: _resource_record_pre_action 08:38:44 INFO - Running main action method: populate_webroot 08:38:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:38:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:38:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:38:44 INFO - '--tppagecycles', 08:38:44 INFO - '7'], 08:38:44 INFO - 'tests': ['tsvgm']}}, 08:38:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:38:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:38:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:38:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:38:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:44 INFO - 'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:44 INFO - 'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['damp', 'tps']}, 08:38:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:44 INFO - 'tests': ['damp', 'tps']}, 08:38:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['dromaeo_dom']}, 08:38:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:38:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['a11yr', 08:38:44 INFO - 'ts_paint', 08:38:44 INFO - 'tpaint', 08:38:44 INFO - 'sessionrestore', 08:38:44 INFO - 'sessionrestore_no_auto_restore', 08:38:44 INFO - 'tabpaint']}, 08:38:44 INFO - 'other-e10s': {'tests': ['a11yr', 08:38:44 INFO - 'ts_paint', 08:38:44 INFO - 'tpaint', 08:38:44 INFO - 'sessionrestore', 08:38:44 INFO - 'sessionrestore_no_auto_restore', 08:38:44 INFO - 'tabpaint']}, 08:38:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:38:44 INFO - 'ts_paint', 08:38:44 INFO - 'tpaint', 08:38:44 INFO - 'sessionrestore', 08:38:44 INFO - 'sessionrestore_no_auto_restore', 08:38:44 INFO - 'tabpaint']}, 08:38:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:38:44 INFO - 'ts_paint', 08:38:44 INFO - 'tpaint', 08:38:44 INFO - 'sessionrestore', 08:38:44 INFO - 'sessionrestore_no_auto_restore', 08:38:44 INFO - 'tabpaint']}, 08:38:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['a11yr', 08:38:44 INFO - 'ts_paint', 08:38:44 INFO - 'tpaint', 08:38:44 INFO - 'sessionrestore', 08:38:44 INFO - 'sessionrestore_no_auto_restore', 08:38:44 INFO - 'tabpaint']}, 08:38:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['a11yr', 08:38:44 INFO - 'ts_paint', 08:38:44 INFO - 'tpaint', 08:38:44 INFO - 'sessionrestore', 08:38:44 INFO - 'sessionrestore_no_auto_restore', 08:38:44 INFO - 'tabpaint']}, 08:38:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['tsvgx', 08:38:44 INFO - 'tsvgr_opacity', 08:38:44 INFO - 'tart', 08:38:44 INFO - 'tscrollx', 08:38:44 INFO - 'cart']}, 08:38:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:38:44 INFO - 'tsvgr_opacity', 08:38:44 INFO - 'tart', 08:38:44 INFO - 'tscrollx', 08:38:44 INFO - 'cart']}, 08:38:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:44 INFO - 'talos_options': ['--disable-e10s'], 08:38:44 INFO - 'tests': ['tp5o']}, 08:38:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:44 INFO - 'tests': ['tp5o']}, 08:38:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:44 INFO - 'talos_options': ['--disable-e10s', 08:38:44 INFO - '--xperf_path', 08:38:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:44 INFO - 'tests': ['tp5n']}, 08:38:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:44 INFO - 'talos_options': ['--xperf_path', 08:38:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:44 INFO - 'tests': ['tp5n']}}, 08:38:44 INFO - 'talos.zip': {'path': '', 08:38:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:38:44 INFO - Running post-action listener: _resource_record_post_action 08:38:44 INFO - ##### 08:38:44 INFO - ##### Running create-virtualenv step. 08:38:44 INFO - ##### 08:38:44 INFO - Running pre-action listener: _resource_record_pre_action 08:38:44 INFO - Running main action method: create_virtualenv 08:38:44 INFO - Creating virtualenv /builds/slave/test/build/venv 08:38:44 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 08:38:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:38:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:38:44 INFO - Using real prefix '/tools/python27' 08:38:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:38:45 INFO - Installing distribute.............................................................................................................................................................................................done. 08:38:48 INFO - Installing pip.................done. 08:38:48 INFO - Return code: 0 08:38:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:38:48 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')]} 08:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:48 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')]} 08:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:48 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 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:38:48 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 08:38:48 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 08:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:48 INFO - 'HOME': '/Users/cltbld', 08:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:48 INFO - 'LOGNAME': 'cltbld', 08:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:48 INFO - 'MOZ_NO_REMOTE': '1', 08:38:48 INFO - 'NO_EM_RESTART': '1', 08:38:48 INFO - 'PAGER': '/bin/cat', 08:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:48 INFO - 'PWD': '/builds/slave/test', 08:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:48 INFO - 'SHELL': '/bin/bash', 08:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:38:48 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:48 INFO - 'USER': 'cltbld', 08:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:48 INFO - 'XPC_FLAGS': '0x0', 08:38:48 INFO - 'XPC_SERVICE_NAME': '0', 08:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:48 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 08:38:48 INFO - Cleaning up... 08:38:48 INFO - Return code: 0 08:38:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:38:48 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')]} 08:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:48 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')]} 08:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:48 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 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:38:48 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 08:38:48 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 08:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:48 INFO - 'HOME': '/Users/cltbld', 08:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:48 INFO - 'LOGNAME': 'cltbld', 08:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:48 INFO - 'MOZ_NO_REMOTE': '1', 08:38:48 INFO - 'NO_EM_RESTART': '1', 08:38:48 INFO - 'PAGER': '/bin/cat', 08:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:48 INFO - 'PWD': '/builds/slave/test', 08:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:48 INFO - 'SHELL': '/bin/bash', 08:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:38:48 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:48 INFO - 'USER': 'cltbld', 08:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:48 INFO - 'XPC_FLAGS': '0x0', 08:38:48 INFO - 'XPC_SERVICE_NAME': '0', 08:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:48 INFO - Downloading/unpacking psutil>=0.7.1 08:38:48 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 08:38:48 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 08:38:48 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 08:38:48 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 08:38:48 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 08:38:48 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 08:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:38:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:51 INFO - Installing collected packages: psutil 08:38:51 INFO - Running setup.py install for psutil 08:38:51 INFO - building 'psutil._psutil_osx' extension 08:38:51 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 08:38:52 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 08:38:52 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 08:38:52 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 08:38:52 INFO - building 'psutil._psutil_posix' extension 08:38:52 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 08:38:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:38:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:38:52 INFO - ^ 08:38:52 INFO - 1 warning generated. 08:38:52 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 08:38:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:52 INFO - Successfully installed psutil 08:38:52 INFO - Cleaning up... 08:38:53 INFO - Return code: 0 08:38:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:53 INFO - 'HOME': '/Users/cltbld', 08:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:53 INFO - 'LOGNAME': 'cltbld', 08:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:53 INFO - 'MOZ_NO_REMOTE': '1', 08:38:53 INFO - 'NO_EM_RESTART': '1', 08:38:53 INFO - 'PAGER': '/bin/cat', 08:38:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:53 INFO - 'PWD': '/builds/slave/test', 08:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:53 INFO - 'SHELL': '/bin/bash', 08:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:38:53 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:53 INFO - 'USER': 'cltbld', 08:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:53 INFO - 'XPC_FLAGS': '0x0', 08:38:53 INFO - 'XPC_SERVICE_NAME': '0', 08:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:38:55 INFO - Installing collected packages: mozsystemmonitor 08:38:55 INFO - Running setup.py install for mozsystemmonitor 08:38:55 INFO - Successfully installed mozsystemmonitor 08:38:55 INFO - Cleaning up... 08:38:55 INFO - Return code: 0 08:38:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38: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')]} 08:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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')]} 08:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38: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', '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 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:38: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 blobuploader==1.2.4 08:38:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:38:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:38:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:38:55 INFO - 'HOME': '/Users/cltbld', 08:38:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:38:55 INFO - 'LOGNAME': 'cltbld', 08:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:55 INFO - 'MOZ_NO_REMOTE': '1', 08:38:55 INFO - 'NO_EM_RESTART': '1', 08:38:55 INFO - 'PAGER': '/bin/cat', 08:38:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:55 INFO - 'PWD': '/builds/slave/test', 08:38:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:38:55 INFO - 'SHELL': '/bin/bash', 08:38:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:38:55 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:38:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:38:55 INFO - 'USER': 'cltbld', 08:38:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:38:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:55 INFO - 'XPC_FLAGS': '0x0', 08:38:55 INFO - 'XPC_SERVICE_NAME': '0', 08:38:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:58 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38: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 08:38: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 08:38: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 08:38: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 08:38: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 08:38: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 08:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:59 INFO - Downloading docopt-0.6.1.tar.gz 08:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:59 INFO - Running setup.py install for blobuploader 08:38:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:00 INFO - Running setup.py install for requests 08:39:00 INFO - Running setup.py install for docopt 08:39:00 INFO - Successfully installed blobuploader requests docopt 08:39:00 INFO - Cleaning up... 08:39:00 INFO - Return code: 0 08:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:00 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')]} 08:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:01 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 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:39:01 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 08:39:01 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 08:39:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:39:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:01 INFO - 'HOME': '/Users/cltbld', 08:39:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:01 INFO - 'LOGNAME': 'cltbld', 08:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:01 INFO - 'MOZ_NO_REMOTE': '1', 08:39:01 INFO - 'NO_EM_RESTART': '1', 08:39:01 INFO - 'PAGER': '/bin/cat', 08:39:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:01 INFO - 'PWD': '/builds/slave/test', 08:39:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:01 INFO - 'SHELL': '/bin/bash', 08:39:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:39:01 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:39:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:01 INFO - 'USER': 'cltbld', 08:39:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:01 INFO - 'XPC_FLAGS': '0x0', 08:39:01 INFO - 'XPC_SERVICE_NAME': '0', 08:39:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ZbNTtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-XKkCjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QrNHGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Bg68j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-TKVMdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-GcOmJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-bfwBcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-36U965-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-1DNVwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-0gUN2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-rBkcXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-p06yah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-1oigBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-PCmnAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-e6woR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:02 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-BTekph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:03 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-xqiaeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:03 INFO - Running setup.py install for manifestparser 08:39:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Running setup.py install for mozcrash 08:39:03 INFO - Running setup.py install for mozdebug 08:39:03 INFO - Running setup.py install for mozdevice 08:39:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:03 INFO - Running setup.py install for mozfile 08:39:03 INFO - Running setup.py install for mozhttpd 08:39:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:04 INFO - Running setup.py install for mozinfo 08:39:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:04 INFO - Running setup.py install for mozInstall 08:39:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:04 INFO - Running setup.py install for mozleak 08:39:04 INFO - Running setup.py install for mozlog 08:39:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:04 INFO - Running setup.py install for moznetwork 08:39:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:04 INFO - Running setup.py install for mozprocess 08:39:04 INFO - Running setup.py install for mozprofile 08:39:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:05 INFO - Running setup.py install for mozrunner 08:39:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:05 INFO - Running setup.py install for mozscreenshot 08:39:05 INFO - Running setup.py install for moztest 08:39:05 INFO - Running setup.py install for mozversion 08:39:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:05 INFO - Cleaning up... 08:39:05 INFO - Return code: 0 08:39:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:05 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 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:39:05 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 08:39:05 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 08:39:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:39:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:05 INFO - 'HOME': '/Users/cltbld', 08:39:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:05 INFO - 'LOGNAME': 'cltbld', 08:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:05 INFO - 'MOZ_NO_REMOTE': '1', 08:39:05 INFO - 'NO_EM_RESTART': '1', 08:39:05 INFO - 'PAGER': '/bin/cat', 08:39:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:05 INFO - 'PWD': '/builds/slave/test', 08:39:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:05 INFO - 'SHELL': '/bin/bash', 08:39:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:39:05 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:39:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:05 INFO - 'USER': 'cltbld', 08:39:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:05 INFO - 'XPC_FLAGS': '0x0', 08:39:05 INFO - 'XPC_SERVICE_NAME': '0', 08:39:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-U3axYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-UJvE4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-cEsCq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-smYUmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-81W6HS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-mggudr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-KU4TfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-5U_73L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-o8RIGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:06 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)) 08:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-1qZi7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:07 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)) 08:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:07 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-jTKi1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:07 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)) 08:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:07 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-YwG7hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:07 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)) 08:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:07 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Y4qzIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:07 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)) 08:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:07 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-65twAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:07 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)) 08:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:07 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-I5HAmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:07 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)) 08:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:07 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-FXjDf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:07 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)) 08:39:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:07 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-8Rp2LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 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)) 08:39:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:07 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 08:39:07 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 08:39:07 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 08:39:07 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 08:39:07 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 08:39:07 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 08:39:10 INFO - Downloading blessings-1.6.tar.gz 08:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:10 INFO - Installing collected packages: blessings 08:39:10 INFO - Running setup.py install for blessings 08:39:10 INFO - Successfully installed blessings 08:39:10 INFO - Cleaning up... 08:39:10 INFO - Return code: 0 08:39:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:11 INFO - Reading from file tmpfile_stdout 08:39:11 INFO - Current package versions: 08:39:11 INFO - blessings == 1.6 08:39:11 INFO - blobuploader == 1.2.4 08:39:11 INFO - docopt == 0.6.1 08:39:11 INFO - manifestparser == 1.1 08:39:11 INFO - mozInstall == 1.12 08:39:11 INFO - mozcrash == 0.17 08:39:11 INFO - mozdebug == 0.1 08:39:11 INFO - mozdevice == 0.48 08:39:11 INFO - mozfile == 1.2 08:39:11 INFO - mozhttpd == 0.7 08:39:11 INFO - mozinfo == 0.9 08:39:11 INFO - mozleak == 0.1 08:39:11 INFO - mozlog == 3.1 08:39:11 INFO - moznetwork == 0.27 08:39:11 INFO - mozprocess == 0.22 08:39:11 INFO - mozprofile == 0.28 08:39:11 INFO - mozrunner == 6.11 08:39:11 INFO - mozscreenshot == 0.1 08:39:11 INFO - mozsystemmonitor == 0.0 08:39:11 INFO - moztest == 0.7 08:39:11 INFO - mozversion == 1.4 08:39:11 INFO - psutil == 3.1.1 08:39:11 INFO - requests == 1.2.3 08:39:11 INFO - wsgiref == 0.1.2 08:39:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:11 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 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:39:11 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 08:39:11 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 08:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:11 INFO - 'HOME': '/Users/cltbld', 08:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:11 INFO - 'LOGNAME': 'cltbld', 08:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:11 INFO - 'MOZ_NO_REMOTE': '1', 08:39:11 INFO - 'NO_EM_RESTART': '1', 08:39:11 INFO - 'PAGER': '/bin/cat', 08:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:11 INFO - 'PWD': '/builds/slave/test', 08:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:11 INFO - 'SHELL': '/bin/bash', 08:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:39:11 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:11 INFO - 'USER': 'cltbld', 08:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:11 INFO - 'XPC_FLAGS': '0x0', 08:39:11 INFO - 'XPC_SERVICE_NAME': '0', 08:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 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)) 08:39:11 INFO - Cleaning up... 08:39:11 INFO - Return code: 0 08:39:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:11 INFO - 'HOME': '/Users/cltbld', 08:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:11 INFO - 'LOGNAME': 'cltbld', 08:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:11 INFO - 'MOZ_NO_REMOTE': '1', 08:39:11 INFO - 'NO_EM_RESTART': '1', 08:39:11 INFO - 'PAGER': '/bin/cat', 08:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:11 INFO - 'PWD': '/builds/slave/test', 08:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:11 INFO - 'SHELL': '/bin/bash', 08:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:39:11 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:11 INFO - 'USER': 'cltbld', 08:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:11 INFO - 'XPC_FLAGS': '0x0', 08:39:11 INFO - 'XPC_SERVICE_NAME': '0', 08:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:11 INFO - Downloading/unpacking jsonschema 08:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:14 INFO - warning: no files found matching '*.txt' 08:39:14 INFO - no previously-included directories found matching 'build' 08:39:14 INFO - no previously-included directories found matching 'dist' 08:39:14 INFO - no previously-included directories found matching '.git*' 08:39:14 INFO - Installing collected packages: jsonschema, functools32 08:39:14 INFO - Running setup.py install for functools32 08:39:14 INFO - warning: no files found matching '*.txt' 08:39:14 INFO - no previously-included directories found matching 'build' 08:39:14 INFO - no previously-included directories found matching 'dist' 08:39:14 INFO - no previously-included directories found matching '.git*' 08:39:14 INFO - Successfully installed jsonschema functools32 08:39:14 INFO - Cleaning up... 08:39:14 INFO - Return code: 0 08:39:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108fb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93d3d54690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, '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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 08:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:14 INFO - 'HOME': '/Users/cltbld', 08:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:14 INFO - 'LOGNAME': 'cltbld', 08:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:14 INFO - 'MOZ_NO_REMOTE': '1', 08:39:14 INFO - 'NO_EM_RESTART': '1', 08:39:14 INFO - 'PAGER': '/bin/cat', 08:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:14 INFO - 'PWD': '/builds/slave/test', 08:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:14 INFO - 'SHELL': '/bin/bash', 08:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:39:14 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:14 INFO - 'USER': 'cltbld', 08:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:14 INFO - 'XPC_FLAGS': '0x0', 08:39:14 INFO - 'XPC_SERVICE_NAME': '0', 08:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:15 INFO - Downloading/unpacking flake8 08:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:39:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:39:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:39:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:39:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:39:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:39:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:39:18 INFO - no previously-included directories found matching 'docs/_build' 08:39:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:39:18 INFO - Running setup.py install for pep8 08:39:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:39:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:39:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:39:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:39:18 INFO - no previously-included directories found matching 'docs/_build' 08:39:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:39:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:39:19 INFO - Cleaning up... 08:39:19 INFO - Return code: 0 08:39:19 INFO - Running post-action listener: _resource_record_post_action 08:39:19 INFO - Running post-action listener: _start_resource_monitoring 08:39:19 INFO - Starting resource monitoring. 08:39:19 INFO - ##### 08:39:19 INFO - ##### Running install step. 08:39:19 INFO - ##### 08:39:19 INFO - Running pre-action listener: _resource_record_pre_action 08:39:19 INFO - Running main action method: install 08:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:19 INFO - Reading from file tmpfile_stdout 08:39:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:19 INFO - Reading from file tmpfile_stdout 08:39:19 INFO - Output received: 08:39:19 INFO - Usage: mozinstall [options] installer 08:39:19 INFO - Options: 08:39:19 INFO - -h, --help show this help message and exit 08:39:19 INFO - -d DEST, --destination=DEST 08:39:19 INFO - Directory to install application into. [default: 08:39:19 INFO - "/builds/slave/test"] 08:39:19 INFO - --app=APP Application being installed. [default: firefox] 08:39:19 INFO - mkdir: /builds/slave/test/build/application 08:39:19 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'] 08:39:19 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 08:39:53 INFO - Reading from file tmpfile_stdout 08:39:53 INFO - Output received: 08:39:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:39:53 INFO - Running post-action listener: _resource_record_post_action 08:39:53 INFO - ##### 08:39:53 INFO - ##### Running run-tests step. 08:39:53 INFO - ##### 08:39:53 INFO - Running pre-action listener: _resource_record_pre_action 08:39:53 INFO - Running main action method: run_tests 08:39:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:39:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:39:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:39:53 INFO - 2016-04-20 08:39:53.489 screenresolution[1641:7543] starting screenresolution argv=screenresolution get 08:39:53 INFO - 2016-04-20 08:39:53.492 screenresolution[1641:7543] Display 0: 1600x1200x32@60 08:39:53 INFO - 2016-04-20 08:39:53.497 screenresolution[1642:7545] starting screenresolution argv=screenresolution list 08:39:53 INFO - Available Modes on Display 0 08:39:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:39:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:39:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:39:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:39:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:39:53 INFO - Intel Iris: 08:39:53 INFO - Chipset Model: Intel Iris 08:39:53 INFO - Type: GPU 08:39:53 INFO - Bus: Built-In 08:39:53 INFO - VRAM (Dynamic, Max): 1536 MB 08:39:53 INFO - Vendor: Intel (0x8086) 08:39:53 INFO - Device ID: 0x0a2e 08:39:53 INFO - Revision ID: 0x0009 08:39:53 INFO - Displays: 08:39:53 INFO - Display: 08:39:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:39:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:39:53 INFO - Display Serial Number: 1600x1200 60 08:39:53 INFO - Main Display: Yes 08:39:53 INFO - Mirror: Off 08:39:53 INFO - Online: Yes 08:39:53 INFO - Rotation: Supported 08:39:53 INFO - Return code: 0 08:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:53 INFO - Python 2.7.3 08:39:53 INFO - Return code: 0 08:39:53 INFO - grabbing minidump binary from tooltool 08:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:39:53 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 0x108e51e00>, '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 0x108cbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e4cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:53 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 08:39:53 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 08:39:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:53 INFO - Return code: 0 08:39:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:39:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:39:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:39:55 INFO - Return code: 0 08:39:55 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-e10s', '--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-0095', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:39:55 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-e10s --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-0095 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyFiVN6mSO/Render', 08:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:55 INFO - 'HOME': '/Users/cltbld', 08:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:55 INFO - 'LOGNAME': 'cltbld', 08:39:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:55 INFO - 'MOZ_NO_REMOTE': '1', 08:39:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:55 INFO - 'NO_EM_RESTART': '1', 08:39:55 INFO - 'PAGER': '/bin/cat', 08:39:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:55 INFO - 'PWD': '/builds/slave/test', 08:39:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:55 INFO - 'SHELL': '/bin/bash', 08:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1BVe6GPW3e/Listeners', 08:39:55 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 08:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:55 INFO - 'USER': 'cltbld', 08:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:55 INFO - 'XPC_FLAGS': '0x0', 08:39:55 INFO - 'XPC_SERVICE_NAME': '0', 08:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--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-0095', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:39:55 INFO - mozversion application_buildid: 20160420053850 08:39:55 INFO - mozversion application_changeset: 19b8851d8d4c19997ecc73960f4de8d90c981c28 08:39:55 INFO - mozversion application_display_name: Nightly 08:39:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:55 INFO - mozversion application_name: Firefox 08:39:55 INFO - mozversion application_remotingname: firefox 08:39:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:39:55 INFO - mozversion application_vendor: Mozilla 08:39:55 INFO - mozversion application_version: 48.0a1 08:39:55 INFO - mozversion platform_buildid: 20160420053850 08:39:55 INFO - mozversion platform_changeset: 19b8851d8d4c19997ecc73960f4de8d90c981c28 08:39:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:39:55 INFO - mozversion platform_version: 48.0a1 08:39:55 INFO - using testdate: 1461166795 08:39:55 INFO - actual date: 1461166795 08:39:55 INFO - starting webserver on 'localhost:49272' 08:39:55 INFO - SUITE-START | Running 2 tests 08:39:55 INFO - TEST-START | dromaeo_css 08:39:55 INFO - operating with platform_type : mac_ 08:39:55 INFO - Initialising browser for dromaeo_css test... 08:39:55 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp2exaoi/profile http://localhost:49272/getInfo.html) 08:39:58 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 08:39:58 INFO - PROCESS | 1660 | colorDepth:24 08:39:58 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 08:39:58 INFO - PROCESS | 1660 | __metrics 08:39:58 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:39:58 INFO - TEST-INFO | 1660: exit 0 08:39:58 INFO - Browser initialized. 08:39:58 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:58 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp2exaoi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:10 INFO - PROCESS | 1663 | RSS: Main: 247812096 08:40:10 INFO - PROCESS | 1663 | 08:41:00 INFO - PROCESS | 1663 | 1461166860388 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] 08:43:12 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 08:43:13 INFO - PROCESS | 1663 | RSS: Main: 259682304 08:43:13 INFO - PROCESS | 1663 | 08:46:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 08:46:16 INFO - PROCESS | 1663 | RSS: Main: 271835136 08:46:16 INFO - PROCESS | 1663 | 08:49:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 08:49:18 INFO - PROCESS | 1663 | RSS: Main: 273813504 08:49:18 INFO - PROCESS | 1663 | 08:52:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 08:52:21 INFO - PROCESS | 1663 | RSS: Main: 275415040 08:52:21 INFO - PROCESS | 1663 | 08:55:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 08:55:24 INFO - PROCESS | 1663 | RSS: Main: 278241280 08:55:24 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 08:58:27 INFO - PROCESS | 1663 | RSS: Main: 279318528 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | __start_tp_report 08:58:27 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 08:58:27 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 08:58:27 INFO - PROCESS | 1663 | |i|pagename|runs| 08:58:27 INFO - PROCESS | 1663 | |0;dojo.html;3470.600880898696;3498.370293347198;3499.545059142312;3514.9121271968183;3580.4808302796096;5749.597528173024;5795.681237531945;5819.883602327951;5845.64926104434;5855.326637436696;5704;5894.528437724983;5962.582619216657;5985.610935289204;5991.760329586811;5277.656952298107;5313.495217954298;5333.813316533922;5366.4633536646215;5403.729813509329;5270.077736396134;5456.017916774979;5467.0705979983295;5503.972480137593;5522.641028333165;5047;5230.398504172031;5354.143337066051;5376.677399356012;5428.104362780156;3998.3602623580377;4860.05228980349;4905.852824415273;5271.262023316739;5296.232046353296;3996.800159991989;5161.9159976405;5279.841604751825;5281.313429254211;5283.815066472655;5619.80330688424;5739.16782066598;5748.252727145445;5843.883122337529;5893.911591326134;6183.87632247357;6201.782937597208;6205.252971526077;6231.501479881598;6261.46777523911;5546.4453554644615;6240.812775616739;6306.905396419012;6322.272938612073;6349;5836.270466191726;5983.491403230731;6074.240719910012;6076;6092.75628974836;6332.556721029484;6360.427561519393;6425.132607097982;6429.292777794439;6453.225612926479;6105.96947015271;6233.657148856766;6251.218597675291;6286.18279623646;6287.056941458818;6172.135900973867;6209.65846878417;6249.812505624838;6250.6874656267;6309.400606942333;6192.504599632019;6220.688965551795;6266.780662676784;6280.152179455715;6296.527760417987;6172.629642221481;6180.3201647818705;6229.252489701174;6232.75068997235;6264.404881536247;4916.336294600254;5015.423226328946;5048.72232027242;5049.722265275372;5109.948900511022;4487.887802804956;4496.752678602708;4507;4535.319702044654;4540.614047805973;5893.410658934073;6023.367546407651;6053.848653783691;6064.787732429344;6076.815021070849;5277.472252774769;6258.655773932477;6318;6340.714667839959;6358.237011558643;5830.271216097988;5959.523238141025;5977.372375900555;5996.070609055603;6093.146959425684;4519.435070616173;5435.483629055233;5484.506394424521;5513.2005859150195;5532.695701736443;6415.67921603918;6500.154979852589;6500.772472963424;6519.641419721961;6528.902066469007;6327.683615819098;6331.9050214247745;6333.809985700436;6341.682915854281;6346.746130154742;6272.529560283088;6465;6510.934890651222;6530.640814755234;6578.0790689304495;6191.597546159485;6216.502679785697;6232.937670623417;6235.282942461675;6264.937350626436;6207.410296021871;6313.873722525615;6358.554901156875;6358.745650174126;6389.9680501597195;6046.939530604814;6050.273967123973;6139.952147134979;6140.692965351804;6157.4458298753325;6098.67428752872;6128.908066379097;6143.32423433413;6159.322474527708;6162.506999439945;5388.730563471732;6070;6083.908741368971;6092.969535152296;6121.112438696275;6114.844865410725;6117.388261173847;6135.44703110649;6206.596571222856;6206.751729930933;6107.969460152671;6168.25980882297;6180.47465965398;6200.7519699213335;6208.4722798562625 08:58:27 INFO - PROCESS | 1663 | |1;ext.html;507.7765783055453;518.5436815602269;519.2652396858446;527.209186220669;543.7987944460549;36917;37663.24673506528;37898;37902;37997.81001094991;38488.61511384886;38998.635047773336;39042.60957390432;39052;39196.60803391965;7938.40461965352;9313.068693130666;9344.672936447225;9439.292053096011;9493.715188544355;9332.020137885525;9457.290703197254;9465.526723663823;9538.523073846314;9565.56954937026;9462.716118516455;9482.573284202228;9530.14228719415;9582.329236953416;9582.856257156149;9463.952680236589;9492.620295188184;9536.713898583053;9536.761580960461;9548.140667339972;9374.296927730447;9422.246220302359;9499.90500095004;9506.144446999802;9513;25498;30009.099727008226;34165.48751768725;37793;37857.621423785684;2641.6169655400054;2905.8111222770663;2953.9852300738576;3023.6242509658055;3100.860461279225;25729.48541029169;26540;27226;27268.590971135447;27631.03291384812;2648.351153967271;2664.826786258887;2690.8520031398266;2719.551274039801;2720.6735191777116;378643.10678446706;381443;382907.17092828994;386002;387414;31166;33990.32019359599;34264.972050838514;35135.82432087823;36113.63886361103;29193.7080629191;34427.13932151666;35264.471032934525;35300.47049294263;35641.64358356435;14503.202323872078;14521.273936303354;14718.632034199016;14729.484468043567;14760.335784889705;11863.169578129447;11946.924776770133;12449.875501245053;12551.246925184518;12568.8688018077;7908.446408751447;7934.960325198453;7969.203079692101;8096.473729207582;8219;3378.45944648855;3390.983045084759;3426.5031570422148;3426.5374174486624;3427.485877118402;912.8370197266504;949.0367277213634;972.9221662267144;1037.5642230263309;1042.1923009667569;29158;29330.973415930766;29400.7059929398;30022.24944376408;30420;1061.6337363609543;1066.2003497376968;1109.5284504085732;1133.552246862501;1151.758130792543;13910.095843770123;14990.550283491513;15141.470048548468;15215.695686086216;15470.381184752483;466176;632281;638476;641952.5804741986;643547;57979.71010144922;58745.412545873995;58887.41112588905;59065.818683626945;59656;1115.5370521233597;1247.602684992814;1296.7925131979027;1462.978055329171;1472.425753955958;29077.418451630427;29113.7088629111;29316.267093322836;29639.851800740857;29750.95871644482;50609;51230.74384628053;51252;51296;51439;561704;580724;581244;581620;583062;25853.870730646227;26238.60642090332;26262.73737262603;26372.472550549264;26703.332416689736;44846.77576612096;44862;45402;45888.54111458843;46879.53120468752;37136;37203.44194837025;37266.441003384425;37972.05069873275;38251.85244442671;36857.63142368542;37036.62963370332;37300;37543.061423463536;37844;36404.45393319155;37376.62623373731;37787.43318850274;38067.04832379213;38125.85622431331;25878.353041174123;27611;28054.018109366076;28970.42059158847;31561.36877262396;23253.953572088958;24308.635370469103;24389.39026524351;24552.38619034467;24786.25641230766 08:58:27 INFO - PROCESS | 1663 | |2;jquery.html;345.46797931185966;388.1731911029507;396.8670495384046;409.1163087730501;416.3858308994236;19279.807201927975;20619.360254219522;20924.372268831958;21292.14831406744;21306.93465326735;17834;19312.806871931312;20642.690359644617;21118.577628447423;21995.23016694416;5739.139129130622;5874.206982057411;6124.356942521038;6128.816135515942;6168.84577885552;6026.4368217886495;6077.301110372319;6087.391260873921;6140;6155.815325540241;5184.196449550326;5872.853178670524;6074.301455332649;6118.938810611904;6130.969345153268;5693.28833895763;5777.508911742507;5920.437558431963;5999.670018149022;6087.360827113156;5245.291885595434;5250.133727934886;5296.390915044781;5299.099153143936;5338;25955.610665840028;26672.86663566689;26758.732412675818;26856.731432685618;27061.72938270612;2075.6575165097743;2116.5555233401005;2192.572448372568;2200.9779902200935;2877.7697784177217;14855.70288594222;14900.329485173193;14928.02967807089;15035.097894126387;15172.9378943474;1701.2344444999676;1749.95625109372;1767.4344209852852;1769.4780039888265;1817.818218178185;110107;113315.43342283319;115703.42148289205;116251;116571;9564.473953932462;11001.119910407308;11439.59961401347;11848.822267665992;11849.881501185051;14126.717465650629;14450.277486125651;14591.708165836837;14600.97793154469;14674;8610.311175105977;8696.956515217384;8730.476171429735;8752.081031491729;8848.955755221312;8567.828643427096;8573.356998225157;8578.699745508877;8678.73963781075;8713.738587842376;6837.555558888656;6855.5543889647015;6871.4502839772695;6886.51794374389;6956.860862782716;1887.2545344589084;1907.4373059947072;1912.129980858706;1928.7685477742762;1934.7001214811726;872.1801506583791;957.9377340472847;965.6818442825493;1023.7082431506984;1032.1587905856702;19716.70424943627;20958.580828383347;21478.355649330544;21797.89101054516;21856.23503177413;981.8478135888948;1010.9747256318503;1034.3121823987115;1082.3289560472558;1088.7060493666665;9441.527923603793;11420.20058595907;11613.245139065933;11676;11684.766304673858;591505;615084;628060;641269;654648;104624;124440;131191.68808311794;132248;139316;998.1715176403712;1024.078329503438;1024.472396715692;1045.7333379988054;1050.1651187306263;14975.925120374328;18791.49668026527;18819;18819.24723011119;19033.333833315766;47852.76073619749;47916.5208347926;52045.47954520558;53146.302571258035;53306.73346633242;65528.3617909537;65624;72316.9152462724;74295;76079;5293.973530132479;5593.776248949996;7827.882581761392;8102.83794324122;8103.635336409758;10345.327553708985;12186.756264874475;12357;12553.372331383576;12796.488140474277;10728.73178170552;10760.730981725519;10793.73015674583;11096.389698566334;11529.674087480047;10663.653996120842;10846.728831779268;10888.29226100301;10895.782084358427;11045.226834121535;11050.447477626247;11228.82097379796;11291.491882865455;11422.029127524254;11438.542458301576;7943.761687149395;7964.084130325086;8170.836583268182;8209.917900821154;8303.4602750821;10114.393136411838;10900.890991090304;10963.616273430393;11308.378039207593;11308.49111789955 08:58:27 INFO - PROCESS | 1663 | |3;mootools.html;1597.2253457073318;1626.9674606507867;1862.6181632765285;1925.6630089734301;1937.651222779899;6518.51111166662;7359.7856353701645;8109.148539403366;8179.836403271931;8479.872801907977;8473.87289190661;8538.316934645229;8621.568921553928;8657.523836189008;8660.696875609356;2116.449723072005;2395.73646898841;2423.9151629692965;2431.732509423962;2450.7181674107437;2427.8543287402813;2439.0853429963763;2458.2010846474877;2461.027893981876;2476.7523247675176;2431.9270421887372;2435.5372479228977;2449.889754961022;2456.8771561421945;2458.483718419134;2397.9640305395433;2410.7227668818045;2415.3599296186526;2420.6006009008493;2452.1853828167027;2360.905563777447;2395.3652282145244;2417.347316224627;2418.6372044193336;2422.7213870404953;8729.388942774009;8797.7800554986;8799.164079412445;8805.25155361795;8834.160754728355;5199.584033277329;5362.383325917531;5367.302250707383;5393.19102134679;5401.243825864382;3205.2147223930288;3276.0499455157974;3287.161773747703;3483.825808709554;3517.7537572369943;1013.7009582173276;1029.7991891581144;1034.1933292032227;1037.8858325584179;1043.8121138195122;11307.982281594695;11469.88530114705;11520.963113319758;11529.192956493049;11538.884611153864;4726.62187025044;4765.428148622187;4846.7991300616695;4856.95143048572;4921.237208232729;9866.210703143732;9891.159251463563;9895.010498950047;9899.356541824902;9932.25508086882;5265.736713164327;5272.393674727456;5353.063213937546;5360.839174824683;5389.730513474311;4364.127174565099;4760.357351757469;4896.632752543503;4903.239997800347;4904.8038078477175;3957.050307926077;3995.580464051291;4044.292248856438;4081.6938729594804;4134.462519872397;1345.3676771917378;1371.9862801371858;1373.7733274009877;1382.9239391833546;1391.1305434103685;712.6365553567614;806.3428305930765;861.3109512390188;915.3501014279802;924.5361112634887;5494.2582751328055;5909.409059094142;5909.468147866713;5969.164316995624;6041.486473649789;896.7713233125511;916.6575728415309;962.8940816510178;966.4104896013426;1006.8791744990648;3140.98429507851;3208.855601497938;3613.1870329175727;3815.523059617548;3868.5357757069332;10207.897921020844;10438.21713371485;10535.525901334458;10653.934606539284;10725.946370268099;9578;10019.499025048719;10466.476676166161;10604.363738175734;10620.415877126678;8002.199780022068;8031.598420078973;8178.713745019015;8217.383696222687;8307.460015098999;5040.344755181803;5278.70967096798;5667.4615911488345;5701.828945131652;5759.193712880116;9916.107550320507;9954.651587194414;10017.749556261151;10021.649242276486;10052.69841904744;7881.684732610861;10179.592816287266;10184.694459166238;10196.643117490852;10206.642767503101;5943.197668314722;6389.648569328731;6761.323867613396;6967.686454109678;7013.368796808311;6870;8209.466384685215;8305.252527272574;8308.792280192802;8322.084570697098;6425.421712045938;7248.673809678683;7436.293552112541;7516.060492438445;7548.3961283098315;6996.19543752475;7144.857102858018;7153.177384600629;7311.744088956861;7429.4799364044;6732.293109223461;6760.425363843931;6789.049533065474;6846.7945961621235;6854.588724676535;4645.907081858411;4685.531446855287;4711.269753188261;4741.288806679026;4874.926876096791;4674.854660608173;4698.342232087579;4727.17274476972;4746.976265118652;4874.7562621868055 08:58:27 INFO - PROCESS | 1663 | |4;prototype.html;318.70838183062494;323.9692229238223;323.99676003239966;329.0966297513328;336.2115838359047;5313.203019547065;6053.697315134248;6269.780557680482;6325.810225693236;6385.425311721944;5365.892682146355;6202.751889924409;6243.188385509878;6259.374062593738;6316.399942005513;3792.374258247386;4368.475782906048;4532.9093418131615;4604.769761511911;4684.578387945085;4285.44289242398;4662.650301227404;4662.97668511657;4695.859124226278;4705.623550115983;3975.60243975603;4515.63874890008;4659.301104834268;4694.248920172773;4713.952860471403;4285.314349704048;4348.217320882256;4544.182047231497;4544.931826022612;4561.840335588238;3185.2355434695737;3346.0554711853415;3796.6901419010396;3829.349010668193;3913.6869050475893;5331.280277162572;5581.609287349887;5910.852228694317;5914.585978981473;5987.221661184061;5162.767675454614;5225.190095535198;5269.235960785664;5313.335833020872;5326.414094449608;5895.439933206381;6577.80266592003;6578.375054369827;6582.440492558138;6594.868102637968;3751.4372844073337;4134.255833949888;4304.569543045702;4320.65434765218;4322.098276758216;5459.945400545984;6902.6203558804245;6917.78630838132;6958.408535274508;6976.860462790766;3538.876139335111;4285.5071666758095;4356.4336636237085;4379.0366119453665;4383.364412160283;3194.109331055399;4156.31669173985;4314.633256173261;4424.247877860771;4439.467263928349;4546.340780586863;5235;5291.206319052096;5299.205119232069;5320.228566857784;6072.666003369769;6342.968285158637;6665.333466653296;6709.563878347892;6725.8654826903185;1333.1601091312411;1403.3334166271143;1517.1579773225965;1528.4497580870877;1544.8686861616663;682.2256738601624;827.4084029918637;869.626060793852;897.9506127163069;971.455984648599;4628;5504.81646446016;5849.327327357323;5880.705964701833;5994.940050599438;6761.425278851353;6795.354441328066;6832.350926661959;6837.794866154023;6846.554973926679;5330.440303768126;5708.771649134072;5889.617174883619;6155.199824022938;6198.783042593487;3014.7588192944513;3536.5048893154462;3579.1410061585034;3594.137407022296;3598.1544337080763;5812.331581868139;6789.490788190807;6979.127609048869;7027.227005029443;7083.92916070843;6369.777057802955;6883.174019117638;6892.586444813327;6978.441724662015;7011.964940175369;6749.358810912955;7069.328413800681;7074;7082.291770822876;7105.680244388912;5826.621269617462;5856.590038697421;6707.832304192434;6802.693878775566;6805.557638753465;5239.345081864767;6408.29508754046;6684.83287917806;6719.798406047827;6784.3554862288;6201.658908760061;6980.860382792214;7097.054722290398;7110.94229481328;7114.964425177841;4401.537838526909;4404.207242696345;4414.271645178638;4422.889427764203;4435.911281774411;6482.752424543508;6586.50601204902;6703.530752847254;6734.528582999339;6744.696488657924;5532.391436942014;5788.768449261982;6360.681965901779;6531.183602049744;6546.509011824228;5293.7353132344;6183.938160618336;6460.224773027267;6490.156279683611;6512.185976752906;5571.66570005801;5954.89834380641;6374.728931615921;6530.216374035146;6530.8367290818105;5570.86072848182;6174.598651087845;6273.964795808823;6583.835404114935;6656.800295991128;6286.622802631674;6302.464290535356;6560.212774467094;6560.343965603402;6592.76925307612 08:58:27 INFO - PROCESS | 1663 | |5;yui.html;628.6479571439996;721.1778572427434;735.1692587376265;751.0949306086167;764.6597264217419;14641.41434342625;14809.851901480995;15145.621359465991;15182.316795744191;15270.694586108286;14026.158430494177;14039.859601403983;14050.64873378166;14057;14078.92960535196;713.0445203427406;885.0353115104534;893.70954439807;894.0969620683125;900.5722281916087;768.6041688530383;903.259327351572;909.6816114359988;911.9589618467152;916.9220616247627;858.433433933604;934.9719508414724;961.8653388525612;964.8215080210149;966.4491239993207;953.9904600953971;959.2757468111531;959.3859929645033;960.8318544254762;962.8507581324906;683.702589373624;697.2713514377488;698.7868700046483;706.7950294414613;707.8018154916632;15370.385184592604;15515.922420387938;15520.5343839685;15528;15533.689326213525;12840;12869.67825804353;12893.226406415644;12995.220286782729;13083.870711326168;9861.161801246903;10021.849672254923;10046.246531510093;10165.89834101657;10405.739856503647;3496.4930085137767;3503.807290599016;3512.578490581121;3570.4465807799834;3578.159132603836;83801.3239735202;86239.56880215621;90143.54928225382;90476;90809.09190908073;9430.95284523573;9515.048495150568;9592.856107158399;9633.807323853483;9767;21861.562768744538;22509;22873.88563057174;22889.31332060041;22893;7477.887831682529;7631.3131818136635;7743.92256077432;7828.452008359474;7874.527528348317;4126.236646220459;4192.350185721218;4197.811098500575;4199.664026877843;4202.285611446062;3568.8215589220436;3595.2989167112164;3615.475756015363;3656.579493358298;3670.5595328560744;558.7066789935235;648.3516483516484;663.5786275714955;665.3944910131756;666.5434177588368;506.54917123759884;524.0854708533633;542.7245971965928;589.3163929841363;600.3966014155745;7810;7826.686932522635;8027.598620068973;8096.595170241464;8336.957880264967;556.5213916032209;563.9915401268984;568.788480536463;573.5521034378452;578.82635209437;3776.6387914755887;3783.3379158647126;3785.2618739346112;3858.9228215435533;3871.6515513603913;88637.55681221552;88655;89774;90062.54343293991;90069.54965225131;80279;81023;81241;82004;83726.16273837183;72584;73621;73626;74029;74569.99999999891;7386.335229829341;7469.58917259556;7590.8102297443;7599.126100498514;7756.379489640703;43785.90535236645;43919.12161756811;44056.559434405244;44853.77573112114;45408;36924.26151477009;57953.710231448575;61357.38642613517;63412.09763707096;65652;8687.1231621766;10868.130549555859;10924.890751092387;10958.452077396258;11385.373804440835;9856.457894815854;12151.513939442324;12335.50657973671;12477.75044499123;12791;11354.829677555008;11820;11859.347735874264;11875.406229688653;11906.10704197206;9628.855567166638;11215.55137794479;11535.76928461443;11602.535898563963;11779.352135632622;10376.325538839952;10396.272260941661;10416.947915260374;10439.060484556123;11234.213605047895;9424.246060315296;9490.572924218288;9696.75758106053;9716.854247186156;10588.629397971034;9285.795829631346;9690.709278721368;9706.805863882542;9789.706308810748;9932.155766759906 08:58:27 INFO - PROCESS | 1663 | __end_tp_report 08:58:27 INFO - PROCESS | 1663 | __start_cc_report 08:58:27 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,409 08:58:27 INFO - PROCESS | 1663 | __end_cc_report 08:58:27 INFO - PROCESS | 1663 | __startTimestamp1461167907385__endTimestamp 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | ------- Summary: start ------- 08:58:27 INFO - PROCESS | 1663 | Number of tests: 6 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5817.73 Median:6093.15 stddev:670.58 (11.0%) stddev-sans-first:646.86 08:58:27 INFO - PROCESS | 1663 | Values: 3470.6 3498.4 3499.5 3514.9 3580.5 5749.6 5795.7 5819.9 5845.6 5855.3 5704.0 5894.5 5962.6 5985.6 5991.8 5277.7 5313.5 5333.8 5366.5 5403.7 5270.1 5456.0 5467.1 5504.0 5522.6 5047.0 5230.4 5354.1 5376.7 5428.1 3998.4 4860.1 4905.9 5271.3 5296.2 3996.8 5161.9 5279.8 5281.3 5283.8 5619.8 5739.2 5748.3 5843.9 5893.9 6183.9 6201.8 6205.3 6231.5 6261.5 5546.4 6240.8 6306.9 6322.3 6349.0 5836.3 5983.5 6074.2 6076.0 6092.8 6332.6 6360.4 6425.1 6429.3 6453.2 6106.0 6233.7 6251.2 6286.2 6287.1 6172.1 6209.7 6249.8 6250.7 6309.4 6192.5 6220.7 6266.8 6280.2 6296.5 6172.6 6180.3 6229.3 6232.8 6264.4 4916.3 5015.4 5048.7 5049.7 5109.9 4487.9 4496.8 4507.0 4535.3 4540.6 5893.4 6023.4 6053.8 6064.8 6076.8 5277.5 6258.7 6318.0 6340.7 6358.2 5830.3 5959.5 5977.4 5996.1 6093.1 4519.4 5435.5 5484.5 5513.2 5532.7 6415.7 6500.2 6500.8 6519.6 6528.9 6327.7 6331.9 6333.8 6341.7 6346.7 6272.5 6465.0 6510.9 6530.6 6578.1 6191.6 6216.5 6232.9 6235.3 6264.9 6207.4 6313.9 6358.6 6358.7 6390.0 6046.9 6050.3 6140.0 6140.7 6157.4 6098.7 6128.9 6143.3 6159.3 6162.5 5388.7 6070.0 6083.9 6093.0 6121.1 6114.8 6117.4 6135.4 6206.6 6206.8 6108.0 6168.3 6180.5 6200.8 6208.5 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:63502.61 Median:37234.94 stddev:142812.31 (383.5%) stddev-sans-first:143134.62 08:58:27 INFO - PROCESS | 1663 | Values: 507.8 518.5 519.3 527.2 543.8 36917.0 37663.2 37898.0 37902.0 37997.8 38488.6 38998.6 39042.6 39052.0 39196.6 7938.4 9313.1 9344.7 9439.3 9493.7 9332.0 9457.3 9465.5 9538.5 9565.6 9462.7 9482.6 9530.1 9582.3 9582.9 9464.0 9492.6 9536.7 9536.8 9548.1 9374.3 9422.2 9499.9 9506.1 9513.0 25498.0 30009.1 34165.5 37793.0 37857.6 2641.6 2905.8 2954.0 3023.6 3100.9 25729.5 26540.0 27226.0 27268.6 27631.0 2648.4 2664.8 2690.9 2719.6 2720.7 378643.1 381443.0 382907.2 386002.0 387414.0 31166.0 33990.3 34265.0 35135.8 36113.6 29193.7 34427.1 35264.5 35300.5 35641.6 14503.2 14521.3 14718.6 14729.5 14760.3 11863.2 11946.9 12449.9 12551.2 12568.9 7908.4 7935.0 7969.2 8096.5 8219.0 3378.5 3391.0 3426.5 3426.5 3427.5 912.8 949.0 972.9 1037.6 1042.2 29158.0 29331.0 29400.7 30022.2 30420.0 1061.6 1066.2 1109.5 1133.6 1151.8 13910.1 14990.6 15141.5 15215.7 15470.4 466176.0 632281.0 638476.0 641952.6 643547.0 57979.7 58745.4 58887.4 59065.8 59656.0 1115.5 1247.6 1296.8 1463.0 1472.4 29077.4 29113.7 29316.3 29639.9 29751.0 50609.0 51230.7 51252.0 51296.0 51439.0 561704.0 580724.0 581244.0 581620.0 583062.0 25853.9 26238.6 26262.7 26372.5 26703.3 44846.8 44862.0 45402.0 45888.5 46879.5 37136.0 37203.4 37266.4 37972.1 38251.9 36857.6 37036.6 37300.0 37543.1 37844.0 36404.5 37376.6 37787.4 38067.0 38125.9 25878.4 27611.0 28054.0 28970.4 31561.4 23254.0 24308.6 24389.4 24552.4 24786.3 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35584.36 Median:21392.65 stddev:104087.99 (486.6%) stddev-sans-first:104346.36 08:58:27 INFO - PROCESS | 1663 | Values: 345.5 388.2 396.9 409.1 416.4 19279.8 20619.4 20924.4 21292.1 21306.9 17834.0 19312.8 20642.7 21118.6 21995.2 5739.1 5874.2 6124.4 6128.8 6168.8 6026.4 6077.3 6087.4 6140.0 6155.8 5184.2 5872.9 6074.3 6118.9 6131.0 5693.3 5777.5 5920.4 5999.7 6087.4 5245.3 5250.1 5296.4 5299.1 5338.0 25955.6 26672.9 26758.7 26856.7 27061.7 2075.7 2116.6 2192.6 2201.0 2877.8 14855.7 14900.3 14928.0 15035.1 15172.9 1701.2 1750.0 1767.4 1769.5 1817.8 110107.0 113315.4 115703.4 116251.0 116571.0 9564.5 11001.1 11439.6 11848.8 11849.9 14126.7 14450.3 14591.7 14601.0 14674.0 8610.3 8697.0 8730.5 8752.1 8849.0 8567.8 8573.4 8578.7 8678.7 8713.7 6837.6 6855.6 6871.5 6886.5 6956.9 1887.3 1907.4 1912.1 1928.8 1934.7 872.2 957.9 965.7 1023.7 1032.2 19716.7 20958.6 21478.4 21797.9 21856.2 981.8 1011.0 1034.3 1082.3 1088.7 9441.5 11420.2 11613.2 11676.0 11684.8 591505.0 615084.0 628060.0 641269.0 654648.0 104624.0 124440.0 131191.7 132248.0 139316.0 998.2 1024.1 1024.5 1045.7 1050.2 14975.9 18791.5 18819.0 18819.2 19033.3 47852.8 47916.5 52045.5 53146.3 53306.7 65528.4 65624.0 72316.9 74295.0 76079.0 5294.0 5593.8 7827.9 8102.8 8103.6 10345.3 12186.8 12357.0 12553.4 12796.5 10728.7 10760.7 10793.7 11096.4 11529.7 10663.7 10846.7 10888.3 10895.8 11045.2 11050.4 11228.8 11291.5 11422.0 11438.5 7943.8 7964.1 8170.8 8209.9 8303.5 10114.4 10900.9 10963.6 11308.4 11308.5 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5585.36 Median:4865.85 stddev:3101.21 (63.7%) stddev-sans-first:3095.43 08:58:27 INFO - PROCESS | 1663 | Values: 1597.2 1627.0 1862.6 1925.7 1937.7 6518.5 7359.8 8109.1 8179.8 8479.9 8473.9 8538.3 8621.6 8657.5 8660.7 2116.4 2395.7 2423.9 2431.7 2450.7 2427.9 2439.1 2458.2 2461.0 2476.8 2431.9 2435.5 2449.9 2456.9 2458.5 2398.0 2410.7 2415.4 2420.6 2452.2 2360.9 2395.4 2417.3 2418.6 2422.7 8729.4 8797.8 8799.2 8805.3 8834.2 5199.6 5362.4 5367.3 5393.2 5401.2 3205.2 3276.0 3287.2 3483.8 3517.8 1013.7 1029.8 1034.2 1037.9 1043.8 11308.0 11469.9 11521.0 11529.2 11538.9 4726.6 4765.4 4846.8 4857.0 4921.2 9866.2 9891.2 9895.0 9899.4 9932.3 5265.7 5272.4 5353.1 5360.8 5389.7 4364.1 4760.4 4896.6 4903.2 4904.8 3957.1 3995.6 4044.3 4081.7 4134.5 1345.4 1372.0 1373.8 1382.9 1391.1 712.6 806.3 861.3 915.4 924.5 5494.3 5909.4 5909.5 5969.2 6041.5 896.8 916.7 962.9 966.4 1006.9 3141.0 3208.9 3613.2 3815.5 3868.5 10207.9 10438.2 10535.5 10653.9 10725.9 9578.0 10019.5 10466.5 10604.4 10620.4 8002.2 8031.6 8178.7 8217.4 8307.5 5040.3 5278.7 5667.5 5701.8 5759.2 9916.1 9954.7 10017.7 10021.6 10052.7 7881.7 10179.6 10184.7 10196.6 10206.6 5943.2 6389.6 6761.3 6967.7 7013.4 6870.0 8209.5 8305.3 8308.8 8322.1 6425.4 7248.7 7436.3 7516.1 7548.4 6996.2 7144.9 7153.2 7311.7 7429.5 6732.3 6760.4 6789.0 6846.8 6854.6 4645.9 4685.5 4711.3 4741.3 4874.9 4674.9 4698.3 4727.2 4747.0 4874.8 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5245.42 Median:5892.53 stddev:1702.10 (28.9%) stddev-sans-first:1666.22 08:58:27 INFO - PROCESS | 1663 | Values: 318.7 324.0 324.0 329.1 336.2 5313.2 6053.7 6269.8 6325.8 6385.4 5365.9 6202.8 6243.2 6259.4 6316.4 3792.4 4368.5 4532.9 4604.8 4684.6 4285.4 4662.7 4663.0 4695.9 4705.6 3975.6 4515.6 4659.3 4694.2 4714.0 4285.3 4348.2 4544.2 4544.9 4561.8 3185.2 3346.1 3796.7 3829.3 3913.7 5331.3 5581.6 5910.9 5914.6 5987.2 5162.8 5225.2 5269.2 5313.3 5326.4 5895.4 6577.8 6578.4 6582.4 6594.9 3751.4 4134.3 4304.6 4320.7 4322.1 5459.9 6902.6 6917.8 6958.4 6976.9 3538.9 4285.5 4356.4 4379.0 4383.4 3194.1 4156.3 4314.6 4424.2 4439.5 4546.3 5235.0 5291.2 5299.2 5320.2 6072.7 6343.0 6665.3 6709.6 6725.9 1333.2 1403.3 1517.2 1528.4 1544.9 682.2 827.4 869.6 898.0 971.5 4628.0 5504.8 5849.3 5880.7 5994.9 6761.4 6795.4 6832.4 6837.8 6846.6 5330.4 5708.8 5889.6 6155.2 6198.8 3014.8 3536.5 3579.1 3594.1 3598.2 5812.3 6789.5 6979.1 7027.2 7083.9 6369.8 6883.2 6892.6 6978.4 7012.0 6749.4 7069.3 7074.0 7082.3 7105.7 5826.6 5856.6 6707.8 6802.7 6805.6 5239.3 6408.3 6684.8 6719.8 6784.4 6201.7 6980.9 7097.1 7110.9 7115.0 4401.5 4404.2 4414.3 4422.9 4435.9 6482.8 6586.5 6703.5 6734.5 6744.7 5532.4 5788.8 6360.7 6531.2 6546.5 5293.7 6183.9 6460.2 6490.2 6512.2 5571.7 5954.9 6374.7 6530.2 6530.8 5570.9 6174.6 6274.0 6583.8 6656.8 6286.6 6302.5 6560.2 6560.3 6592.8 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18195.08 Median:30993.02 stddev:25848.77 (83.4%) stddev-sans-first:25887.63 08:58:27 INFO - PROCESS | 1663 | Values: 628.6 721.2 735.2 751.1 764.7 14641.4 14809.9 15145.6 15182.3 15270.7 14026.2 14039.9 14050.6 14057.0 14078.9 713.0 885.0 893.7 894.1 900.6 768.6 903.3 909.7 912.0 916.9 858.4 935.0 961.9 964.8 966.4 954.0 959.3 959.4 960.8 962.9 683.7 697.3 698.8 706.8 707.8 15370.4 15515.9 15520.5 15528.0 15533.7 12840.0 12869.7 12893.2 12995.2 13083.9 9861.2 10021.8 10046.2 10165.9 10405.7 3496.5 3503.8 3512.6 3570.4 3578.2 83801.3 86239.6 90143.5 90476.0 90809.1 9431.0 9515.0 9592.9 9633.8 9767.0 21861.6 22509.0 22873.9 22889.3 22893.0 7477.9 7631.3 7743.9 7828.5 7874.5 4126.2 4192.4 4197.8 4199.7 4202.3 3568.8 3595.3 3615.5 3656.6 3670.6 558.7 648.4 663.6 665.4 666.5 506.5 524.1 542.7 589.3 600.4 7810.0 7826.7 8027.6 8096.6 8337.0 556.5 564.0 568.8 573.6 578.8 3776.6 3783.3 3785.3 3858.9 3871.7 88637.6 88655.0 89774.0 90062.5 90069.5 80279.0 81023.0 81241.0 82004.0 83726.2 72584.0 73621.0 73626.0 74029.0 74570.0 7386.3 7469.6 7590.8 7599.1 7756.4 43785.9 43919.1 44056.6 44853.8 45408.0 36924.3 57953.7 61357.4 63412.1 65652.0 8687.1 10868.1 10924.9 10958.5 11385.4 9856.5 12151.5 12335.5 12477.8 12791.0 11354.8 11820.0 11859.3 11875.4 11906.1 9628.9 11215.6 11535.8 11602.5 11779.4 10376.3 10396.3 10416.9 10439.1 11234.2 9424.2 9490.6 9696.8 9716.9 10588.6 9285.8 9690.7 9706.8 9789.7 9932.2 08:58:27 INFO - PROCESS | 1663 | -------- Summary: end -------- 08:58:27 INFO - PROCESS | 1663 | 08:58:27 INFO - TEST-INFO | 1663: exit 0 08:58:27 INFO - TEST-OK | dromaeo_css | took 1112691ms 08:58:27 INFO - TEST-START | kraken 08:58:27 INFO - operating with platform_type : mac_ 08:58:27 INFO - Initialising browser for kraken test... 08:58:27 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpsVXcI_/profile http://localhost:49272/getInfo.html) 08:58:30 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 08:58:30 INFO - PROCESS | 1671 | colorDepth:24 08:58:30 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 08:58:30 INFO - PROCESS | 1671 | __metrics 08:58:30 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:58:31 INFO - TEST-INFO | 1671: exit 0 08:58:31 INFO - Browser initialized. 08:58:31 INFO - Running cycle 1/1 for kraken test... 08:58:31 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmpsVXcI_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:43 INFO - PROCESS | 1674 | RSS: Main: 248274944 08:58:43 INFO - PROCESS | 1674 | 08:58:46 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:47 INFO - PROCESS | 1674 | RSS: Main: 260325376 08:58:47 INFO - PROCESS | 1674 | 08:58:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 08:58:50 INFO - PROCESS | 1674 | RSS: Main: 269275136 08:58:50 INFO - PROCESS | 1674 | 08:58:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 08:58:54 INFO - PROCESS | 1674 | RSS: Main: 272318464 08:58:54 INFO - PROCESS | 1674 | 08:58:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 08:58:57 INFO - PROCESS | 1674 | RSS: Main: 274300928 08:58:57 INFO - PROCESS | 1674 | 08:58:59 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:59 INFO - PROCESS | 1674 | RSS: Main: 275034112 08:58:59 INFO - PROCESS | 1674 | 08:59:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:03 INFO - PROCESS | 1674 | RSS: Main: 275292160 08:59:03 INFO - PROCESS | 1674 | 08:59:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:07 INFO - PROCESS | 1674 | RSS: Main: 275398656 08:59:07 INFO - PROCESS | 1674 | 08:59:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 08:59:10 INFO - PROCESS | 1674 | RSS: Main: 275431424 08:59:10 INFO - PROCESS | 1674 | 08:59:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:12 INFO - PROCESS | 1674 | RSS: Main: 275910656 08:59:12 INFO - PROCESS | 1674 | 08:59:14 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:15 INFO - PROCESS | 1674 | RSS: Main: 275476480 08:59:15 INFO - PROCESS | 1674 | 08:59:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:18 INFO - PROCESS | 1674 | RSS: Main: 275718144 08:59:18 INFO - PROCESS | 1674 | 08:59:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:21 INFO - PROCESS | 1674 | RSS: Main: 275824640 08:59:21 INFO - PROCESS | 1674 | 08:59:24 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:25 INFO - PROCESS | 1674 | RSS: Main: 275763200 08:59:25 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 08:59:27 INFO - PROCESS | 1674 | RSS: Main: 277520384 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | __start_tp_report 08:59:27 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 08:59:27 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 08:59:27 INFO - PROCESS | 1674 | |i|pagename|runs| 08:59:27 INFO - PROCESS | 1674 | |0;ai-astar;115;94;168;175;119;127;116;118;117;117 08:59:27 INFO - PROCESS | 1674 | |1;audio-beat-detection;194;153;181;163;121;142;124;160;158;125 08:59:27 INFO - PROCESS | 1674 | |2;audio-dft;193;212;224;203;196;196;180;201;200;200 08:59:27 INFO - PROCESS | 1674 | |3;audio-fft;67;71;79;136;58;58;58;64;127;58 08:59:27 INFO - PROCESS | 1674 | |4;audio-oscillator;80;86;136;80;65;112;142;82;82;122 08:59:27 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;119;89;89;86;91;85;89;87;89;86 08:59:27 INFO - PROCESS | 1674 | |6;imaging-darkroom;150;151;96;95;100;150;107;89;125;88 08:59:27 INFO - PROCESS | 1674 | |7;imaging-desaturate;91;125;118;90;91;92;90;90;90;90 08:59:27 INFO - PROCESS | 1674 | |8;json-parse-financial;61;63;75;79;60;60;59;83;64;68 08:59:27 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;64;66;71;65;77;72;71;65;68;69 08:59:27 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;83;98;113;92;83;83;83;83;81;81 08:59:27 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;140;141;144;151;166;165;140;143;191;175 08:59:27 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;193;199;167;210;155;224;224;226;174;171 08:59:27 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;69;80;83;66;102;97;102;97;93;67 08:59:27 INFO - PROCESS | 1674 | __end_tp_report 08:59:27 INFO - PROCESS | 1674 | __start_cc_report 08:59:27 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1031 08:59:27 INFO - PROCESS | 1674 | __end_cc_report 08:59:27 INFO - PROCESS | 1674 | __startTimestamp1461167967610__endTimestamp 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | ------- Summary: start ------- 08:59:27 INFO - PROCESS | 1674 | Number of tests: 14 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:126.60 Median:123.00 stddev:25.13 (20.4%) stddev-sans-first:26.30 08:59:27 INFO - PROCESS | 1674 | Values: 115.0 94.0 168.0 175.0 119.0 127.0 116.0 118.0 117.0 117.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:159.00 stddev:24.50 (15.4%) stddev-sans-first:20.77 08:59:27 INFO - PROCESS | 1674 | Values: 194.0 153.0 181.0 163.0 121.0 142.0 124.0 160.0 158.0 125.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:200.50 Median:200.50 stddev:11.59 (5.8%) stddev-sans-first:11.97 08:59:27 INFO - PROCESS | 1674 | Values: 193.0 212.0 224.0 203.0 196.0 196.0 180.0 201.0 200.0 200.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:77.60 Median:61.00 stddev:29.31 (48.0%) stddev-sans-first:30.83 08:59:27 INFO - PROCESS | 1674 | Values: 67.0 71.0 79.0 136.0 58.0 58.0 58.0 64.0 127.0 58.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:80.00 stddev:26.96 (33.7%) stddev-sans-first:27.73 08:59:27 INFO - PROCESS | 1674 | Values: 80.0 86.0 136.0 80.0 65.0 112.0 142.0 82.0 82.0 122.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:89.00 stddev:10.01 (11.2%) stddev-sans-first:1.96 08:59:27 INFO - PROCESS | 1674 | Values: 119.0 89.0 89.0 86.0 91.0 85.0 89.0 87.0 89.0 86.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:115.10 Median:119.50 stddev:26.46 (22.1%) stddev-sans-first:24.87 08:59:27 INFO - PROCESS | 1674 | Values: 150.0 151.0 96.0 95.0 100.0 150.0 107.0 89.0 125.0 88.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:90.00 stddev:13.19 (14.7%) stddev-sans-first:13.83 08:59:27 INFO - PROCESS | 1674 | Values: 91.0 125.0 118.0 90.0 91.0 92.0 90.0 90.0 90.0 90.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:66.00 stddev:8.74 (13.2%) stddev-sans-first:8.98 08:59:27 INFO - PROCESS | 1674 | Values: 61.0 63.0 75.0 79.0 60.0 60.0 59.0 83.0 64.0 68.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:70.00 stddev:4.05 (5.8%) stddev-sans-first:3.91 08:59:27 INFO - PROCESS | 1674 | Values: 64.0 66.0 71.0 65.0 77.0 72.0 71.0 65.0 68.0 69.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:83.00 stddev:10.35 (12.5%) stddev-sans-first:10.82 08:59:27 INFO - PROCESS | 1674 | Values: 83.0 98.0 113.0 92.0 83.0 83.0 83.0 83.0 81.0 81.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:158.00 stddev:17.77 (11.2%) stddev-sans-first:17.92 08:59:27 INFO - PROCESS | 1674 | Values: 140.0 141.0 144.0 151.0 166.0 165.0 140.0 143.0 191.0 175.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:204.50 stddev:26.42 (12.9%) stddev-sans-first:28.02 08:59:27 INFO - PROCESS | 1674 | Values: 193.0 199.0 167.0 210.0 155.0 224.0 224.0 226.0 174.0 171.0 08:59:27 INFO - PROCESS | 1674 | 08:59:27 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.60 Median:81.50 stddev:14.52 (17.8%) stddev-sans-first:14.10 08:59:27 INFO - PROCESS | 1674 | Values: 69.0 80.0 83.0 66.0 102.0 97.0 102.0 97.0 93.0 67.0 08:59:27 INFO - PROCESS | 1674 | -------- Summary: end -------- 08:59:27 INFO - PROCESS | 1674 | 08:59:28 INFO - TEST-INFO | 1674: exit 0 08:59:28 INFO - TEST-OK | kraken | took 60616ms 08:59:28 INFO - SUITE-END | took 1173s 08:59:28 INFO - Completed test suite (00:19:33) 08:59:28 INFO - javascript benchmark 08:59:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3470.600880898696, 3498.370293347198, 3499.545059142312, 3514.9121271968183, 3580.4808302796096, 5749.597528173024, 5795.681237531945, 5819.883602327951, 5845.64926104434, 5855.326637436696, 5704.0, 5894.528437724983, 5962.582619216657, 5985.610935289204, 5991.760329586811, 5277.656952298107, 5313.495217954298, 5333.813316533922, 5366.4633536646215, 5403.729813509329, 5270.077736396134, 5456.017916774979, 5467.0705979983295, 5503.972480137593, 5522.641028333165, 5047.0, 5230.398504172031, 5354.143337066051, 5376.677399356012, 5428.104362780156, 3998.3602623580377, 4860.05228980349, 4905.852824415273, 5271.262023316739, 5296.232046353296, 3996.800159991989, 5161.9159976405, 5279.841604751825, 5281.313429254211, 5283.815066472655, 5619.80330688424, 5739.16782066598, 5748.252727145445, 5843.883122337529, 5893.911591326134, 6183.87632247357, 6201.782937597208, 6205.252971526077, 6231.501479881598, 6261.46777523911, 5546.4453554644615, 6240.812775616739, 6306.905396419012, 6322.272938612073, 6349.0, 5836.270466191726, 5983.491403230731, 6074.240719910012, 6076.0, 6092.75628974836, 6332.556721029484, 6360.427561519393, 6425.132607097982, 6429.292777794439, 6453.225612926479, 6105.96947015271, 6233.657148856766, 6251.218597675291, 6286.18279623646, 6287.056941458818, 6172.135900973867, 6209.65846878417, 6249.812505624838, 6250.6874656267, 6309.400606942333, 6192.504599632019, 6220.688965551795, 6266.780662676784, 6280.152179455715, 6296.527760417987, 6172.629642221481, 6180.3201647818705, 6229.252489701174, 6232.75068997235, 6264.404881536247, 4916.336294600254, 5015.423226328946, 5048.72232027242, 5049.722265275372, 5109.948900511022, 4487.887802804956, 4496.752678602708, 4507.0, 4535.319702044654, 4540.614047805973, 5893.410658934073, 6023.367546407651, 6053.848653783691, 6064.787732429344, 6076.815021070849, 5277.472252774769, 6258.655773932477, 6318.0, 6340.714667839959, 6358.237011558643, 5830.271216097988, 5959.523238141025, 5977.372375900555, 5996.070609055603, 6093.146959425684, 4519.435070616173, 5435.483629055233, 5484.506394424521, 5513.2005859150195, 5532.695701736443, 6415.67921603918, 6500.154979852589, 6500.772472963424, 6519.641419721961, 6528.902066469007, 6327.683615819098, 6331.9050214247745, 6333.809985700436, 6341.682915854281, 6346.746130154742, 6272.529560283088, 6465.0, 6510.934890651222, 6530.640814755234, 6578.0790689304495, 6191.597546159485, 6216.502679785697, 6232.937670623417, 6235.282942461675, 6264.937350626436, 6207.410296021871, 6313.873722525615, 6358.554901156875, 6358.745650174126, 6389.9680501597195, 6046.939530604814, 6050.273967123973, 6139.952147134979, 6140.692965351804, 6157.4458298753325, 6098.67428752872, 6128.908066379097, 6143.32423433413, 6159.322474527708, 6162.506999439945, 5388.730563471732, 6070.0, 6083.908741368971, 6092.969535152296, 6121.112438696275, 6114.844865410725, 6117.388261173847, 6135.44703110649, 6206.596571222856, 6206.751729930933, 6107.969460152671, 6168.25980882297, 6180.47465965398, 6200.7519699213335, 6208.4722798562625], "value": 5775.9450180232725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.7765783055453, 518.5436815602269, 519.2652396858446, 527.209186220669, 543.7987944460549, 36917.0, 37663.24673506528, 37898.0, 37902.0, 37997.81001094991, 38488.61511384886, 38998.635047773336, 39042.60957390432, 39052.0, 39196.60803391965, 7938.40461965352, 9313.068693130666, 9344.672936447225, 9439.292053096011, 9493.715188544355, 9332.020137885525, 9457.290703197254, 9465.526723663823, 9538.523073846314, 9565.56954937026, 9462.716118516455, 9482.573284202228, 9530.14228719415, 9582.329236953416, 9582.856257156149, 9463.952680236589, 9492.620295188184, 9536.713898583053, 9536.761580960461, 9548.140667339972, 9374.296927730447, 9422.246220302359, 9499.90500095004, 9506.144446999802, 9513.0, 25498.0, 30009.099727008226, 34165.48751768725, 37793.0, 37857.621423785684, 2641.6169655400054, 2905.8111222770663, 2953.9852300738576, 3023.6242509658055, 3100.860461279225, 25729.48541029169, 26540.0, 27226.0, 27268.590971135447, 27631.03291384812, 2648.351153967271, 2664.826786258887, 2690.8520031398266, 2719.551274039801, 2720.6735191777116, 378643.10678446706, 381443.0, 382907.17092828994, 386002.0, 387414.0, 31166.0, 33990.32019359599, 34264.972050838514, 35135.82432087823, 36113.63886361103, 29193.7080629191, 34427.13932151666, 35264.471032934525, 35300.47049294263, 35641.64358356435, 14503.202323872078, 14521.273936303354, 14718.632034199016, 14729.484468043567, 14760.335784889705, 11863.169578129447, 11946.924776770133, 12449.875501245053, 12551.246925184518, 12568.8688018077, 7908.446408751447, 7934.960325198453, 7969.203079692101, 8096.473729207582, 8219.0, 3378.45944648855, 3390.983045084759, 3426.5031570422148, 3426.5374174486624, 3427.485877118402, 912.8370197266504, 949.0367277213634, 972.9221662267144, 1037.5642230263309, 1042.1923009667569, 29158.0, 29330.973415930766, 29400.7059929398, 30022.24944376408, 30420.0, 1061.6337363609543, 1066.2003497376968, 1109.5284504085732, 1133.552246862501, 1151.758130792543, 13910.095843770123, 14990.550283491513, 15141.470048548468, 15215.695686086216, 15470.381184752483, 466176.0, 632281.0, 638476.0, 641952.5804741986, 643547.0, 57979.71010144922, 58745.412545873995, 58887.41112588905, 59065.818683626945, 59656.0, 1115.5370521233597, 1247.602684992814, 1296.7925131979027, 1462.978055329171, 1472.425753955958, 29077.418451630427, 29113.7088629111, 29316.267093322836, 29639.851800740857, 29750.95871644482, 50609.0, 51230.74384628053, 51252.0, 51296.0, 51439.0, 561704.0, 580724.0, 581244.0, 581620.0, 583062.0, 25853.870730646227, 26238.60642090332, 26262.73737262603, 26372.472550549264, 26703.332416689736, 44846.77576612096, 44862.0, 45402.0, 45888.54111458843, 46879.53120468752, 37136.0, 37203.44194837025, 37266.441003384425, 37972.05069873275, 38251.85244442671, 36857.63142368542, 37036.62963370332, 37300.0, 37543.061423463536, 37844.0, 36404.45393319155, 37376.62623373731, 37787.43318850274, 38067.04832379213, 38125.85622431331, 25878.353041174123, 27611.0, 28054.018109366076, 28970.42059158847, 31561.36877262396, 23253.953572088958, 24308.635370469103, 24389.39026524351, 24552.38619034467, 24786.25641230766], "value": 17637.726822832017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.46797931185966, 388.1731911029507, 396.8670495384046, 409.1163087730501, 416.3858308994236, 19279.807201927975, 20619.360254219522, 20924.372268831958, 21292.14831406744, 21306.93465326735, 17834.0, 19312.806871931312, 20642.690359644617, 21118.577628447423, 21995.23016694416, 5739.139129130622, 5874.206982057411, 6124.356942521038, 6128.816135515942, 6168.84577885552, 6026.4368217886495, 6077.301110372319, 6087.391260873921, 6140.0, 6155.815325540241, 5184.196449550326, 5872.853178670524, 6074.301455332649, 6118.938810611904, 6130.969345153268, 5693.28833895763, 5777.508911742507, 5920.437558431963, 5999.670018149022, 6087.360827113156, 5245.291885595434, 5250.133727934886, 5296.390915044781, 5299.099153143936, 5338.0, 25955.610665840028, 26672.86663566689, 26758.732412675818, 26856.731432685618, 27061.72938270612, 2075.6575165097743, 2116.5555233401005, 2192.572448372568, 2200.9779902200935, 2877.7697784177217, 14855.70288594222, 14900.329485173193, 14928.02967807089, 15035.097894126387, 15172.9378943474, 1701.2344444999676, 1749.95625109372, 1767.4344209852852, 1769.4780039888265, 1817.818218178185, 110107.0, 113315.43342283319, 115703.42148289205, 116251.0, 116571.0, 9564.473953932462, 11001.119910407308, 11439.59961401347, 11848.822267665992, 11849.881501185051, 14126.717465650629, 14450.277486125651, 14591.708165836837, 14600.97793154469, 14674.0, 8610.311175105977, 8696.956515217384, 8730.476171429735, 8752.081031491729, 8848.955755221312, 8567.828643427096, 8573.356998225157, 8578.699745508877, 8678.73963781075, 8713.738587842376, 6837.555558888656, 6855.5543889647015, 6871.4502839772695, 6886.51794374389, 6956.860862782716, 1887.2545344589084, 1907.4373059947072, 1912.129980858706, 1928.7685477742762, 1934.7001214811726, 872.1801506583791, 957.9377340472847, 965.6818442825493, 1023.7082431506984, 1032.1587905856702, 19716.70424943627, 20958.580828383347, 21478.355649330544, 21797.89101054516, 21856.23503177413, 981.8478135888948, 1010.9747256318503, 1034.3121823987115, 1082.3289560472558, 1088.7060493666665, 9441.527923603793, 11420.20058595907, 11613.245139065933, 11676.0, 11684.766304673858, 591505.0, 615084.0, 628060.0, 641269.0, 654648.0, 104624.0, 124440.0, 131191.68808311794, 132248.0, 139316.0, 998.1715176403712, 1024.078329503438, 1024.472396715692, 1045.7333379988054, 1050.1651187306263, 14975.925120374328, 18791.49668026527, 18819.0, 18819.24723011119, 19033.333833315766, 47852.76073619749, 47916.5208347926, 52045.47954520558, 53146.302571258035, 53306.73346633242, 65528.3617909537, 65624.0, 72316.9152462724, 74295.0, 76079.0, 5293.973530132479, 5593.776248949996, 7827.882581761392, 8102.83794324122, 8103.635336409758, 10345.327553708985, 12186.756264874475, 12357.0, 12553.372331383576, 12796.488140474277, 10728.73178170552, 10760.730981725519, 10793.73015674583, 11096.389698566334, 11529.674087480047, 10663.653996120842, 10846.728831779268, 10888.29226100301, 10895.782084358427, 11045.226834121535, 11050.447477626247, 11228.82097379796, 11291.491882865455, 11422.029127524254, 11438.542458301576, 7943.761687149395, 7964.084130325086, 8170.836583268182, 8209.917900821154, 8303.4602750821, 10114.393136411838, 10900.890991090304, 10963.616273430393, 11308.378039207593, 11308.49111789955], "value": 9757.073374902773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1597.2253457073318, 1626.9674606507867, 1862.6181632765285, 1925.6630089734301, 1937.651222779899, 6518.51111166662, 7359.7856353701645, 8109.148539403366, 8179.836403271931, 8479.872801907977, 8473.87289190661, 8538.316934645229, 8621.568921553928, 8657.523836189008, 8660.696875609356, 2116.449723072005, 2395.73646898841, 2423.9151629692965, 2431.732509423962, 2450.7181674107437, 2427.8543287402813, 2439.0853429963763, 2458.2010846474877, 2461.027893981876, 2476.7523247675176, 2431.9270421887372, 2435.5372479228977, 2449.889754961022, 2456.8771561421945, 2458.483718419134, 2397.9640305395433, 2410.7227668818045, 2415.3599296186526, 2420.6006009008493, 2452.1853828167027, 2360.905563777447, 2395.3652282145244, 2417.347316224627, 2418.6372044193336, 2422.7213870404953, 8729.388942774009, 8797.7800554986, 8799.164079412445, 8805.25155361795, 8834.160754728355, 5199.584033277329, 5362.383325917531, 5367.302250707383, 5393.19102134679, 5401.243825864382, 3205.2147223930288, 3276.0499455157974, 3287.161773747703, 3483.825808709554, 3517.7537572369943, 1013.7009582173276, 1029.7991891581144, 1034.1933292032227, 1037.8858325584179, 1043.8121138195122, 11307.982281594695, 11469.88530114705, 11520.963113319758, 11529.192956493049, 11538.884611153864, 4726.62187025044, 4765.428148622187, 4846.7991300616695, 4856.95143048572, 4921.237208232729, 9866.210703143732, 9891.159251463563, 9895.010498950047, 9899.356541824902, 9932.25508086882, 5265.736713164327, 5272.393674727456, 5353.063213937546, 5360.839174824683, 5389.730513474311, 4364.127174565099, 4760.357351757469, 4896.632752543503, 4903.239997800347, 4904.8038078477175, 3957.050307926077, 3995.580464051291, 4044.292248856438, 4081.6938729594804, 4134.462519872397, 1345.3676771917378, 1371.9862801371858, 1373.7733274009877, 1382.9239391833546, 1391.1305434103685, 712.6365553567614, 806.3428305930765, 861.3109512390188, 915.3501014279802, 924.5361112634887, 5494.2582751328055, 5909.409059094142, 5909.468147866713, 5969.164316995624, 6041.486473649789, 896.7713233125511, 916.6575728415309, 962.8940816510178, 966.4104896013426, 1006.8791744990648, 3140.98429507851, 3208.855601497938, 3613.1870329175727, 3815.523059617548, 3868.5357757069332, 10207.897921020844, 10438.21713371485, 10535.525901334458, 10653.934606539284, 10725.946370268099, 9578.0, 10019.499025048719, 10466.476676166161, 10604.363738175734, 10620.415877126678, 8002.199780022068, 8031.598420078973, 8178.713745019015, 8217.383696222687, 8307.460015098999, 5040.344755181803, 5278.70967096798, 5667.4615911488345, 5701.828945131652, 5759.193712880116, 9916.107550320507, 9954.651587194414, 10017.749556261151, 10021.649242276486, 10052.69841904744, 7881.684732610861, 10179.592816287266, 10184.694459166238, 10196.643117490852, 10206.642767503101, 5943.197668314722, 6389.648569328731, 6761.323867613396, 6967.686454109678, 7013.368796808311, 6870.0, 8209.466384685215, 8305.252527272574, 8308.792280192802, 8322.084570697098, 6425.421712045938, 7248.673809678683, 7436.293552112541, 7516.060492438445, 7548.3961283098315, 6996.19543752475, 7144.857102858018, 7153.177384600629, 7311.744088956861, 7429.4799364044, 6732.293109223461, 6760.425363843931, 6789.049533065474, 6846.7945961621235, 6854.588724676535, 4645.907081858411, 4685.531446855287, 4711.269753188261, 4741.288806679026, 4874.926876096791, 4674.854660608173, 4698.342232087579, 4727.17274476972, 4746.976265118652, 4874.7562621868055], "value": 4526.34317946125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.70838183062494, 323.9692229238223, 323.99676003239966, 329.0966297513328, 336.2115838359047, 5313.203019547065, 6053.697315134248, 6269.780557680482, 6325.810225693236, 6385.425311721944, 5365.892682146355, 6202.751889924409, 6243.188385509878, 6259.374062593738, 6316.399942005513, 3792.374258247386, 4368.475782906048, 4532.9093418131615, 4604.769761511911, 4684.578387945085, 4285.44289242398, 4662.650301227404, 4662.97668511657, 4695.859124226278, 4705.623550115983, 3975.60243975603, 4515.63874890008, 4659.301104834268, 4694.248920172773, 4713.952860471403, 4285.314349704048, 4348.217320882256, 4544.182047231497, 4544.931826022612, 4561.840335588238, 3185.2355434695737, 3346.0554711853415, 3796.6901419010396, 3829.349010668193, 3913.6869050475893, 5331.280277162572, 5581.609287349887, 5910.852228694317, 5914.585978981473, 5987.221661184061, 5162.767675454614, 5225.190095535198, 5269.235960785664, 5313.335833020872, 5326.414094449608, 5895.439933206381, 6577.80266592003, 6578.375054369827, 6582.440492558138, 6594.868102637968, 3751.4372844073337, 4134.255833949888, 4304.569543045702, 4320.65434765218, 4322.098276758216, 5459.945400545984, 6902.6203558804245, 6917.78630838132, 6958.408535274508, 6976.860462790766, 3538.876139335111, 4285.5071666758095, 4356.4336636237085, 4379.0366119453665, 4383.364412160283, 3194.109331055399, 4156.31669173985, 4314.633256173261, 4424.247877860771, 4439.467263928349, 4546.340780586863, 5235.0, 5291.206319052096, 5299.205119232069, 5320.228566857784, 6072.666003369769, 6342.968285158637, 6665.333466653296, 6709.563878347892, 6725.8654826903185, 1333.1601091312411, 1403.3334166271143, 1517.1579773225965, 1528.4497580870877, 1544.8686861616663, 682.2256738601624, 827.4084029918637, 869.626060793852, 897.9506127163069, 971.455984648599, 4628.0, 5504.81646446016, 5849.327327357323, 5880.705964701833, 5994.940050599438, 6761.425278851353, 6795.354441328066, 6832.350926661959, 6837.794866154023, 6846.554973926679, 5330.440303768126, 5708.771649134072, 5889.617174883619, 6155.199824022938, 6198.783042593487, 3014.7588192944513, 3536.5048893154462, 3579.1410061585034, 3594.137407022296, 3598.1544337080763, 5812.331581868139, 6789.490788190807, 6979.127609048869, 7027.227005029443, 7083.92916070843, 6369.777057802955, 6883.174019117638, 6892.586444813327, 6978.441724662015, 7011.964940175369, 6749.358810912955, 7069.328413800681, 7074.0, 7082.291770822876, 7105.680244388912, 5826.621269617462, 5856.590038697421, 6707.832304192434, 6802.693878775566, 6805.557638753465, 5239.345081864767, 6408.29508754046, 6684.83287917806, 6719.798406047827, 6784.3554862288, 6201.658908760061, 6980.860382792214, 7097.054722290398, 7110.94229481328, 7114.964425177841, 4401.537838526909, 4404.207242696345, 4414.271645178638, 4422.889427764203, 4435.911281774411, 6482.752424543508, 6586.50601204902, 6703.530752847254, 6734.528582999339, 6744.696488657924, 5532.391436942014, 5788.768449261982, 6360.681965901779, 6531.183602049744, 6546.509011824228, 5293.7353132344, 6183.938160618336, 6460.224773027267, 6490.156279683611, 6512.185976752906, 5571.66570005801, 5954.89834380641, 6374.728931615921, 6530.216374035146, 6530.8367290818105, 5570.86072848182, 6174.598651087845, 6273.964795808823, 6583.835404114935, 6656.800295991128, 6286.622802631674, 6302.464290535356, 6560.212774467094, 6560.343965603402, 6592.76925307612], "value": 4679.483406344109, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.6479571439996, 721.1778572427434, 735.1692587376265, 751.0949306086167, 764.6597264217419, 14641.41434342625, 14809.851901480995, 15145.621359465991, 15182.316795744191, 15270.694586108286, 14026.158430494177, 14039.859601403983, 14050.64873378166, 14057.0, 14078.92960535196, 713.0445203427406, 885.0353115104534, 893.70954439807, 894.0969620683125, 900.5722281916087, 768.6041688530383, 903.259327351572, 909.6816114359988, 911.9589618467152, 916.9220616247627, 858.433433933604, 934.9719508414724, 961.8653388525612, 964.8215080210149, 966.4491239993207, 953.9904600953971, 959.2757468111531, 959.3859929645033, 960.8318544254762, 962.8507581324906, 683.702589373624, 697.2713514377488, 698.7868700046483, 706.7950294414613, 707.8018154916632, 15370.385184592604, 15515.922420387938, 15520.5343839685, 15528.0, 15533.689326213525, 12840.0, 12869.67825804353, 12893.226406415644, 12995.220286782729, 13083.870711326168, 9861.161801246903, 10021.849672254923, 10046.246531510093, 10165.89834101657, 10405.739856503647, 3496.4930085137767, 3503.807290599016, 3512.578490581121, 3570.4465807799834, 3578.159132603836, 83801.3239735202, 86239.56880215621, 90143.54928225382, 90476.0, 90809.09190908073, 9430.95284523573, 9515.048495150568, 9592.856107158399, 9633.807323853483, 9767.0, 21861.562768744538, 22509.0, 22873.88563057174, 22889.31332060041, 22893.0, 7477.887831682529, 7631.3131818136635, 7743.92256077432, 7828.452008359474, 7874.527528348317, 4126.236646220459, 4192.350185721218, 4197.811098500575, 4199.664026877843, 4202.285611446062, 3568.8215589220436, 3595.2989167112164, 3615.475756015363, 3656.579493358298, 3670.5595328560744, 558.7066789935235, 648.3516483516484, 663.5786275714955, 665.3944910131756, 666.5434177588368, 506.54917123759884, 524.0854708533633, 542.7245971965928, 589.3163929841363, 600.3966014155745, 7810.0, 7826.686932522635, 8027.598620068973, 8096.595170241464, 8336.957880264967, 556.5213916032209, 563.9915401268984, 568.788480536463, 573.5521034378452, 578.82635209437, 3776.6387914755887, 3783.3379158647126, 3785.2618739346112, 3858.9228215435533, 3871.6515513603913, 88637.55681221552, 88655.0, 89774.0, 90062.54343293991, 90069.54965225131, 80279.0, 81023.0, 81241.0, 82004.0, 83726.16273837183, 72584.0, 73621.0, 73626.0, 74029.0, 74569.99999999891, 7386.335229829341, 7469.58917259556, 7590.8102297443, 7599.126100498514, 7756.379489640703, 43785.90535236645, 43919.12161756811, 44056.559434405244, 44853.77573112114, 45408.0, 36924.26151477009, 57953.710231448575, 61357.38642613517, 63412.09763707096, 65652.0, 8687.1231621766, 10868.130549555859, 10924.890751092387, 10958.452077396258, 11385.373804440835, 9856.457894815854, 12151.513939442324, 12335.50657973671, 12477.75044499123, 12791.0, 11354.829677555008, 11820.0, 11859.347735874264, 11875.406229688653, 11906.10704197206, 9628.855567166638, 11215.55137794479, 11535.76928461443, 11602.535898563963, 11779.352135632622, 10376.325538839952, 10396.272260941661, 10416.947915260374, 10439.060484556123, 11234.213605047895, 9424.246060315296, 9490.572924218288, 9696.75758106053, 9716.854247186156, 10588.629397971034, 9285.795829631346, 9690.709278721368, 9706.805863882542, 9789.706308810748, 9932.155766759906], "value": 6851.1664955242995, "unit": "score"}], "name": "dromaeo_css", "value": 7241.94626882831, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 94.0, 168.0, 175.0, 119.0, 127.0, 116.0, 118.0, 117.0, 117.0], "value": 126.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 153.0, 181.0, 163.0, 121.0, 142.0, 124.0, 160.0, 158.0, 125.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 212.0, 224.0, 203.0, 196.0, 196.0, 180.0, 201.0, 200.0, 200.0], "value": 200.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 79.0, 136.0, 58.0, 58.0, 58.0, 64.0, 127.0, 58.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 136.0, 80.0, 65.0, 112.0, 142.0, 82.0, 82.0, 122.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 89.0, 89.0, 86.0, 91.0, 85.0, 89.0, 87.0, 89.0, 86.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 96.0, 95.0, 100.0, 150.0, 107.0, 89.0, 125.0, 88.0], "value": 115.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 125.0, 118.0, 90.0, 91.0, 92.0, 90.0, 90.0, 90.0, 90.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 75.0, 79.0, 60.0, 60.0, 59.0, 83.0, 64.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 71.0, 65.0, 77.0, 72.0, 71.0, 65.0, 68.0, 69.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 98.0, 113.0, 92.0, 83.0, 83.0, 83.0, 83.0, 81.0, 81.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 144.0, 151.0, 166.0, 165.0, 140.0, 143.0, 191.0, 175.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 199.0, 167.0, 210.0, 155.0, 224.0, 224.0, 226.0, 174.0, 171.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 83.0, 66.0, 102.0, 97.0, 102.0, 97.0, 93.0, 67.0], "value": 85.6, "unit": "score"}], "name": "kraken", "value": 1617.7999999999997, "alertThreshold": 2.0}]} 08:59:28 INFO - Return code: 0 08:59:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:59:28 ERROR - # TBPL SUCCESS # 08:59:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:59:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:59:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:59:28 INFO - 2016-04-20 08:59:28.916 screenresolution[1679:10282] starting screenresolution argv=screenresolution get 08:59:28 INFO - 2016-04-20 08:59:28.920 screenresolution[1679:10282] Display 0: 1600x1200x32@60 08:59:28 INFO - 2016-04-20 08:59:28.926 screenresolution[1680:10285] starting screenresolution argv=screenresolution list 08:59:28 INFO - Available Modes on Display 0 08:59:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:59:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:59:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:59:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:59:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:59:29 INFO - Intel Iris: 08:59:29 INFO - Chipset Model: Intel Iris 08:59:29 INFO - Type: GPU 08:59:29 INFO - Bus: Built-In 08:59:29 INFO - VRAM (Dynamic, Max): 1536 MB 08:59:29 INFO - Vendor: Intel (0x8086) 08:59:29 INFO - Device ID: 0x0a2e 08:59:29 INFO - Revision ID: 0x0009 08:59:29 INFO - Displays: 08:59:29 INFO - Display: 08:59:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:59:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:59:29 INFO - Display Serial Number: 1600x1200 60 08:59:29 INFO - Main Display: Yes 08:59:29 INFO - Mirror: Off 08:59:29 INFO - Online: Yes 08:59:29 INFO - Rotation: Supported 08:59:29 INFO - Return code: 0 08:59:29 INFO - Running post-action listener: _resource_record_post_action 08:59:29 INFO - Running post-run listener: _resource_record_post_run 08:59:30 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37774848; Write bytes: 696043008; Read time: 518; Write time: 2089 08:59:30 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395682304; Write bytes: 385197568; Read time: 29845; Write time: 931 08:59:30 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30682624; Write bytes: 297390080; Read time: 306; Write time: 1127 08:59:30 INFO - Running post-run listener: _upload_blobber_files 08:59:30 INFO - Blob upload gear active. 08:59:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:30 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 08:59:30 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'] 08:59:30 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 08:59:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:59:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:31 INFO - (blobuploader) - INFO - Done attempting. 08:59:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:59:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:59:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:33 INFO - (blobuploader) - INFO - Done attempting. 08:59:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:59:33 INFO - Return code: 0 08:59:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:59:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:59:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71226c2cd113109178324d901e8bdb16fcd4e5b9419f5f71eb4ca8541d577ff43cce4e502103ff46c8c807b54b33fd99e15de06823c04b59c8ff533ea895aa7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6e3070c6ff044fa080ec43740da374e8da4a6b53864074c35afc55b49c3150a249d0748af1b977b389abe5e8384723433caafcfc76b983707c97447fd8b0a58"} 08:59:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:59:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:59:33 INFO - Contents: 08:59:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71226c2cd113109178324d901e8bdb16fcd4e5b9419f5f71eb4ca8541d577ff43cce4e502103ff46c8c807b54b33fd99e15de06823c04b59c8ff533ea895aa7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6e3070c6ff044fa080ec43740da374e8da4a6b53864074c35afc55b49c3150a249d0748af1b977b389abe5e8384723433caafcfc76b983707c97447fd8b0a58"} 08:59:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:59:33 INFO - Copying logs to upload dir... 08:59:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:59:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.460420 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-20 08:59:33.078159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 08:59:33.082039) ========= 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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71226c2cd113109178324d901e8bdb16fcd4e5b9419f5f71eb4ca8541d577ff43cce4e502103ff46c8c807b54b33fd99e15de06823c04b59c8ff533ea895aa7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6e3070c6ff044fa080ec43740da374e8da4a6b53864074c35afc55b49c3150a249d0748af1b977b389abe5e8384723433caafcfc76b983707c97447fd8b0a58"} 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.011308 build_url: 'https://queue.taskcluster.net/v1/task/A9FD4vPCTA-GiuEe8baR8A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71226c2cd113109178324d901e8bdb16fcd4e5b9419f5f71eb4ca8541d577ff43cce4e502103ff46c8c807b54b33fd99e15de06823c04b59c8ff533ea895aa7c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b6e3070c6ff044fa080ec43740da374e8da4a6b53864074c35afc55b49c3150a249d0748af1b977b389abe5e8384723433caafcfc76b983707c97447fd8b0a58"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 08:59:33.113594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:59:33.113932) ========= 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.lyFiVN6mSO/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.1BVe6GPW3e/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 08:59:33.162134) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 08:59:33.162416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 08:59:33.162754) ========= ========= Total master_lag: 4.43 =========