Skip to content

Instantly share code, notes, and snippets.

@pieterbreed

pieterbreed/logging output.txt

Created July 20, 2017 12:48
Show Gist options
  • Save pieterbreed/df22ac5e83ed7948155081d835419cab to your computer and use it in GitHub Desktop.
Save pieterbreed/df22ac5e83ed7948155081d835419cab to your computer and use it in GitHub Desktop.
Download ZIP
envconsul bug report
Raw
logging output.txt
mysql-test_1 | 2017/07/20 12:45:20 [INFO] envconsul v0.6.2 (ddf8503)
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (runner) creating new runner (command: [./mysql_test.sh], once: false)
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (runner) final config (tokens suppressed):
mysql-test_1 |
mysql-test_1 | {
mysql-test_1 | "path": "envconsul.config",
mysql-test_1 | "consul": "",
mysql-test_1 | "prefix": null,
mysql-test_1 | "secret": [
mysql-test_1 | {
mysql-test_1 | "path": "mysql/creds/full",
mysql-test_1 | "format": "MYSQL_DB_{{ key }}",
mysql-test_1 | "no_prefix": true
mysql-test_1 | }
mysql-test_1 | ],
mysql-test_1 | "auth": {
mysql-test_1 | "enabled": false,
mysql-test_1 | "username": "",
mysql-test_1 | "password": ""
mysql-test_1 | },
mysql-test_1 | "vault": {
mysql-test_1 | "address": "http://vault:8200",
mysql-test_1 | "renew": true,
mysql-test_1 | "ssl": {
mysql-test_1 | "enabled": true,
mysql-test_1 | "verify": true
mysql-test_1 | }
mysql-test_1 | },
mysql-test_1 | "ssl": {
mysql-test_1 | "enabled": false,
mysql-test_1 | "verify": true
mysql-test_1 | },
mysql-test_1 | "syslog": {
mysql-test_1 | "enabled": false,
mysql-test_1 | "facility": "LOCAL0"
mysql-test_1 | },
mysql-test_1 | "max_stale": 1000000000,
mysql-test_1 | "retry": 5000000000,
mysql-test_1 | "sanitize": false,
mysql-test_1 | "splay": 0,
mysql-test_1 | "upcase": true,
mysql-test_1 | "timeout": 5000000000,
mysql-test_1 | "wait": {
mysql-test_1 | "min": 0,
mysql-test_1 | "max": 0
mysql-test_1 | },
mysql-test_1 | "kill_signal": "SIGTERM",
mysql-test_1 | "LogLevel": "debug",
mysql-test_1 | "pristine": false
mysql-test_1 | }
mysql-test_1 |
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (clients) creating consul/api client
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (clients) creating vault/api client
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (clients) setting vault address to "http://vault:8200"
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (clients) enabling vault SSL
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (clients) setting vault token
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (runner) creating Watcher
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (watcher) adding vault_token
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (watcher) vault_token starting
mysql-test_1 | 2017/07/20 12:45:20 looking at vault mysql/creds/full
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (view) vault_token starting fetch
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (vault_token) renewing vault token
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (runner) starting
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (watcher) adding "secret(mysql/creds/full)"
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (watcher) "secret(mysql/creds/full)" starting
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (view) "secret(mysql/creds/full)" starting fetch
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] ("secret(mysql/creds/full)") querying vault with &{AllowStale:true WaitIndex:0 WaitTime:1m0s}
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (vault_token) successfully renewed token
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (view) vault_token received data
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (view) vault_token starting fetch
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (vault_token) renewing vault token
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (vault_token) sleeping for "383h59m59s"
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (runner) running
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (runner) missing data for "secret(mysql/creds/full)"
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] ("secret(mysql/creds/full)") vault returned the secret
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (view) "secret(mysql/creds/full)" received data
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (view) "secret(mysql/creds/full)" starting fetch
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (runner) running
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] ("secret(mysql/creds/full)") querying vault with &{AllowStale:true WaitIndex:1500554720 WaitTime:1m0s}
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] ("secret(mysql/creds/full)") pretending to long-poll for "1m0s"
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (runner) setting MYSQL_DB_PASSWORD="3b013ce6-78fc-5379-ed79-4595499cb51f" from "secret(mysql/creds/full)"
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] (runner) setting MYSQL_DB_USERNAME="full-toke-feceaa" from "secret(mysql/creds/full)"
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] Environment:
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] MYSQL_DB_USERNAME="full-toke-feceaa"
mysql-test_1 | 2017/07/20 12:45:20 [DEBUG] MYSQL_DB_PASSWORD="3b013ce6-78fc-5379-ed79-4595499cb51f"
mysql-test_1 | 2017/07/20 12:45:20 [INFO] (runner) running command ./mysql_test.sh
mysql-test_1 | 1500554720:Thu Jul 20 12:45:21 UTC 2017
mysql-test_1 | count(*)
mysql-test_1 | 10
mysql-test_1 | 1500554720:Thu Jul 20 12:45:22 UTC 2017
mysql-test_1 | count(*)
mysql-test_1 | 11
mysql-test_1 | 1500554720:Thu Jul 20 12:45:23 UTC 2017
mysql-test_1 | count(*)
mysql-test_1 | 12
<SNIP>
mysql-test_1 | 1500554720:Thu Jul 20 12:46:19 UTC 2017
mysql-test_1 | count(*)
mysql-test_1 | 63
mysql-test_1 | 1500554720:Thu Jul 20 12:46:20 UTC 2017
mysql-test_1 | count(*)
mysql-test_1 | 64
# HERE IS THE BUG
mysql-test_1 | 2017/07/20 12:46:20 [WARN] ("secret(mysql/creds/full)") failed to renew, re-reading: Error making API request.
mysql-test_1 |
mysql-test_1 | URL: PUT http://vault:8200/v1/sys/renew/mysql/creds/full/43e0fcab-2275-b9d4-27fe-a9c82fa952af
mysql-test_1 | Code: 403. Errors:
mysql-test_1 |
mysql-test_1 | * permission denied
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] ("secret(mysql/creds/full)") vault returned the secret
mysql-test_1 | 2017/07/20 12:46:20 [INFO] (view) "secret(mysql/creds/full)" received data
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] (view) "secret(mysql/creds/full)" starting fetch
mysql-test_1 | 2017/07/20 12:46:20 [INFO] (runner) running
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] ("secret(mysql/creds/full)") querying vault with &{AllowStale:true WaitIndex:1500554780 WaitTime:1m0s}
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] (runner) setting MYSQL_DB_PASSWORD="1166671a-b01c-b05e-37e0-6630bf30aa9d" from "secret(mysql/creds/full)"
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] (runner) setting MYSQL_DB_USERNAME="full-toke-930e60" from "secret(mysql/creds/full)"
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] Environment:
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] ("secret(mysql/creds/full)") pretending to long-poll for "1m0s"
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] MYSQL_DB_PASSWORD="1166671a-b01c-b05e-37e0-6630bf30aa9d"
mysql-test_1 | 2017/07/20 12:46:20 [DEBUG] MYSQL_DB_USERNAME="full-toke-930e60"
mysql-test_1 | 2017/07/20 12:46:20 [INFO] (runner) running command ./mysql_test.sh
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment