Skip to content

Instantly share code, notes, and snippets.

@Gourds
Created January 22, 2021 01:56
Show Gist options
  • Save Gourds/a9bffa692e9f5c16853d492314682082 to your computer and use it in GitHub Desktop.
Save Gourds/a9bffa692e9f5c16853d492314682082 to your computer and use it in GitHub Desktop.
[vp-log-3]
{"level":"info","ts":1611280349.9010384,"msg":"jwt.secret read from /config/secret"}
{"level":"warn","ts":1611280349.901045,"msg":"generating random session.key"}
{"level":"info","ts":1611280349.9011402,"msg":"configuring oidc OAuth with Endpoint https://ynfyvjwiaw.login.aliyunidaas.com/oauth/authorize"}
{"level":"debug","ts":1611280349.901146,"msg":"cfg.RootDir: /"}
{"level":"debug","ts":1611280349.9012957,"msg":"viper settings map[oauth:map[auth_url:https://ynfyvjwiaw.login.aliyunidaas.com/oauth/authorize callback_urls:[http://vouch.taiheops.com:2081/auth] client_id:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx client_secret:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx preferreddomain:taiheops.com provider:oidc scopes:[read] token_url:https://ynfyvjwiaw.login.aliyunidaas.com/oauth/token user_info_url:https://ynfyvjwiaw.login.aliyunidaas.com/api/bff/v1.2/oauth2/userinfo] vouch:map[allowallusers:true cookie:map[domain:taiheops.com maxage:14400 name:VouchCookie samesite:lax secure:false] headers:map[jwt:X-Vouch-Token querystring:access_token redirect:X-Vouch-Requested-URI] listen:0.0.0.0 loglevel:debug port:9090 testing:true]]"}
{"level":"debug","ts":1611280349.901329,"msg":"cfg.GenOauth &{Provider:oidc ClientID:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx ClientSecret:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx AuthURL:https://ynfyvjwiaw.login.aliyunidaas.com/oauth/authorize TokenURL:https://ynfyvjwiaw.login.aliyunidaas.com/oauth/token LogoutURL: RedirectURL: RedirectURLs:[http://vouch.taiheops.com:2081/auth] Scopes:[read] UserInfoURL:https://ynfyvjwiaw.login.aliyunidaas.com/api/bff/v1.2/oauth2/userinfo UserTeamURL: UserOrgURL: PreferredDomain:taiheops.com CodeChallengeMethod:}"}
2021-01-22T01:52:29.901Z INFO testing: true, using development console logger
2021-01-22T01:52:29.901Z DEBUG vouch.jwt.secret is 44 characters long
2021-01-22T01:52:29.901Z DEBUG vouch.session.key is 44 characters long
2021-01-22T01:52:29.901Z INFO jwtcache: the returned headers for a valid jwt will be cached for 20 minutes
2021-01-22T01:52:29.901Z DEBUG responses.Configure() attempting to parse templates with cfg.RootDir: /
{"level":"debug","ts":1611280349.901636,"msg":"checking availability of tcp port: 0.0.0.0:9090"}
{"level":"info","ts":1611280349.9018514,"msg":"starting Vouch Proxy","version":"a167802","buildtime":"2021-01-21T03:44:00Z","buildhost":"600455047d1d","branch":"heads/v0.20.0","semver":"v0.20.0","listen":"http://0.0.0.0:9090","tls":false,"oauth.provider":"oidc"}
{"level":"debug","ts":1611280349.9020252,"msg":"serving static files from /static"}
2021-01-22T01:53:29.740Z DEBUG /validate
2021-01-22T01:53:29.740Z ERROR no jwt found in request
2021-01-22T01:53:29.740Z DEBUG removing port from test_sso_nginx_a.taiheops.com:2081 to test domain test_sso_nginx_a.taiheops.com
2021-01-22T01:53:29.740Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:29.740Z DEBUG CaptureWriter.Write set w.StatusCode 401
2021-01-22T01:53:29.740Z INFO |401| 164.322µs /validate {"statusCode": 401, "request": 1, "latency": "164.322µs", "avgLatency": "164.322µs", "ipPort": "172.17.0.1:64117", "method": "GET", "host": "test_sso_nginx_a.taiheops.com:2081", "path": "/validate", "referer": ""}
2021-01-22T01:53:29.798Z DEBUG /login
2021-01-22T01:53:29.799Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:29.799Z DEBUG session state set to YFQ3MuiacXthuLdR4Cju4Qd4nfyRURl
2021-01-22T01:53:29.799Z DEBUG Login url param normalized to 'http://test_sso_nginx_a.taiheops.com:2081/'
2021-01-22T01:53:29.799Z DEBUG session requestedURL set to http://test_sso_nginx_a.taiheops.com:2081/
2021-01-22T01:53:29.799Z DEBUG saving session with failcount 1
2021-01-22T01:53:29.799Z DEBUG /login looking for callback_url matching
2021-01-22T01:53:29.799Z DEBUG /login callback_url set to http://vouch.taiheops.com:2081/auth
2021-01-22T01:53:29.799Z DEBUG redirecting to oauthURL https://ynfyvjwiaw.login.aliyunidaas.com/oauth/authorize?client_id=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx&redirect_uri=http%3A%2F%2Fvouch.taiheops.com%3A2081%2Fauth&response_type=code&scope=read&state=YFQ3MuiacXthuLdR4Cju4Qd4nfyRURl
2021-01-22T01:53:29.799Z INFO |200| 915.936µs /login {"statusCode": 200, "request": 2, "latency": "915.936µs", "avgLatency": "540.129µs", "ipPort": "172.17.0.1:64121", "method": "GET", "host": "vouch.taiheops.com", "path": "/login", "referer": ""}
2021-01-22T01:53:29.973Z INFO |200| 37.729µs /healthcheck {"statusCode": 200, "request": 3, "latency": "37.729µs", "avgLatency": "372.663µs", "ipPort": "127.0.0.1:40856", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
2021-01-22T01:53:36.978Z DEBUG /login
2021-01-22T01:53:36.978Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:36.978Z DEBUG session state set to 3TPt68XW0d8BLW7hzChPcFJuK2ICpCp
2021-01-22T01:53:36.978Z INFO Stray param in login request ()
2021-01-22T01:53:36.978Z DEBUG Login url param normalized to '<nil>'
2021-01-22T01:53:36.978Z DEBUG Stray params in login url ([""]) will be ignored
2021-01-22T01:53:36.978Z ERROR no destination URL requested
2021-01-22T01:53:36.978Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:36.978Z DEBUG CaptureWriter.Write set w.StatusCode 400
2021-01-22T01:53:36.978Z DEBUG rendering error for user: 400 Bad Request
2021-01-22T01:53:36.978Z INFO |400| 301µs /login {"statusCode": 400, "request": 4, "latency": "301µs", "avgLatency": "354.748µs", "ipPort": "172.17.0.1:64133", "method": "GET", "host": "vouch.taiheops.com", "path": "/login", "referer": "http://vouch.taiheops.com:2081/login?url=http://test_sso_nginx_a.taiheops.com:2081/&vouch-failcount=&X-Vouch-Token=&error="}
2021-01-22T01:53:41.484Z DEBUG /logout
2021-01-22T01:53:41.484Z DEBUG tokenString length: 0
2021-01-22T01:53:41.484Z DEBUG Error reading gzip data: EOF
2021-01-22T01:53:41.484Z DEBUG decompressed tokenString length 0
2021-01-22T01:53:41.484Z ERROR token contains an invalid number of segments
2021-01-22T01:53:41.484Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:41.484Z DEBUG /logout deleting session
2021-01-22T01:53:41.484Z INFO |200| 313.325µs /logout {"statusCode": 200, "request": 5, "latency": "313.325µs", "avgLatency": "346.464µs", "ipPort": "172.17.0.1:64137", "method": "GET", "host": "vouch.taiheops.com", "path": "/logout", "referer": "http://vouch.taiheops.com:2081/login?url=http://test_sso_nginx_a.taiheops.com:2081/&vouch-failcount=&X-Vouch-Token=&error="}
2021-01-22T01:53:44.708Z DEBUG /validate
2021-01-22T01:53:44.708Z ERROR no jwt found in request
2021-01-22T01:53:44.708Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:44.708Z DEBUG CaptureWriter.Write set w.StatusCode 401
2021-01-22T01:53:44.708Z INFO |401| 120.945µs /validate {"statusCode": 401, "request": 6, "latency": "120.945µs", "avgLatency": "308.878µs", "ipPort": "172.17.0.1:64141", "method": "GET", "host": "vouch.taiheops.com", "path": "/validate", "referer": "http://vouch.taiheops.com:2081/login?url=http://test_sso_nginx_a.taiheops.com:2081/&vouch-failcount=&X-Vouch-Token=&error="}
2021-01-22T01:53:47.542Z DEBUG /auth
2021-01-22T01:53:47.542Z INFO |200| 202.352µs /auth {"statusCode": 200, "request": 7, "latency": "202.352µs", "avgLatency": "293.66µs", "ipPort": "172.17.0.1:64149", "method": "GET", "host": "vouch.taiheops.com", "path": "/auth", "referer": "http://vouch.taiheops.com:2081/"}
2021-01-22T01:53:50.400Z DEBUG /auth/{state}/
2021-01-22T01:53:50.731Z DEBUG id_token missing - may not be supported by this provider
2021-01-22T01:53:50.731Z DEBUG ptokens: accessToken length: 36, IdToken length: 0
2021-01-22T01:53:50.767Z INFO OpenID userinfo body: {"success":true,"code":"200","message":null,"requestId":"6B5E685C-950A-4AD1-967A-03FCFA4C468F","data":{"sub":"3884468577942292116","ou_id":"5711823617764658328","nickname":"xxxx","phone_number":null,"ou_name":"xxxx","email":"[email protected]","username":"xxxx"}}
2021-01-22T01:53:50.767Z DEBUG /auth/{state}/ Claims from userinfo: {Claims:map[]}
2021-01-22T01:53:50.767Z DEBUG verifyUser: Success! skipping verification, cfg.Cfg.AllowAllUsers is true
2021-01-22T01:53:50.767Z DEBUG token created, expires: 1611294830 diff from now: 14400
2021-01-22T01:53:50.769Z DEBUG token compressed: was 224 bytes, now 288
2021-01-22T01:53:50.769Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:50.769Z INFO |200| 369.36085ms /auth/YFQ3MuiacXthuLdR4Cju4Qd4nfyRURl/ {"statusCode": 200, "request": 8, "latency": "369.36085ms", "avgLatency": "46.427058ms", "ipPort": "172.17.0.1:64155", "method": "GET", "host": "vouch.taiheops.com", "path": "/auth/YFQ3MuiacXthuLdR4Cju4Qd4nfyRURl/", "referer": "http://vouch.taiheops.com:2081/auth?code=6FzOM0&state=YFQ3MuiacXthuLdR4Cju4Qd4nfyRURl"}
2021-01-22T01:53:55.649Z DEBUG jwt found in cookie
2021-01-22T01:53:55.649Z DEBUG /validate
2021-01-22T01:53:55.649Z DEBUG jwt found in cookie
2021-01-22T01:53:55.649Z DEBUG tokenString length: 288
2021-01-22T01:53:55.649Z DEBUG decompressed tokenString length 224
2021-01-22T01:53:55.649Z DEBUG *ptokenCLaims: { [] map[] { 1611294830 0 Vouch 0 }}
2021-01-22T01:53:55.649Z ERROR no User found in jwt
2021-01-22T01:53:55.649Z DEBUG removing port from test_sso_nginx_a.taiheops.com:2081 to test domain test_sso_nginx_a.taiheops.com
2021-01-22T01:53:55.649Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:55.649Z DEBUG deleting cookie: VouchCookie
2021-01-22T01:53:55.649Z DEBUG CaptureWriter.Write set w.StatusCode 401
2021-01-22T01:53:55.649Z INFO |401| 448.388µs /validate {"statusCode": 401, "request": 9, "latency": "448.388µs", "avgLatency": "41.318317ms", "ipPort": "172.17.0.1:64161", "method": "GET", "host": "test_sso_nginx_a.taiheops.com:2081", "path": "/validate", "referer": "http://vouch.taiheops.com:2081/"}
2021-01-22T01:53:55.681Z DEBUG /login
2021-01-22T01:53:55.681Z DEBUG setting the cookie domain to taiheops.com
2021-01-22T01:53:55.681Z DEBUG deleting cookie: VouchCookie
2021-01-22T01:53:55.681Z DEBUG session state set to y6umK8Jeo0DgLhAmcgnZiMMyjTjV7Q
2021-01-22T01:53:55.682Z DEBUG Login url param normalized to 'http://test_sso_nginx_a.taiheops.com:2081/'
2021-01-22T01:53:55.682Z DEBUG session requestedURL set to http://test_sso_nginx_a.taiheops.com:2081/
2021-01-22T01:53:55.682Z DEBUG saving session with failcount 1
2021-01-22T01:53:55.682Z DEBUG /login looking for callback_url matching
2021-01-22T01:53:55.682Z DEBUG /login callback_url set to http://vouch.taiheops.com:2081/auth
2021-01-22T01:53:55.682Z DEBUG redirecting to oauthURL https://ynfyvjwiaw.login.aliyunidaas.com/oauth/authorize?client_id=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx&redirect_uri=http%3A%2F%2Fvouch.taiheops.com%3A2081%2Fauth&response_type=code&scope=read&state=y6umK8Jeo0DgLhAmcgnZiMMyjTjV7Q
2021-01-22T01:53:55.682Z INFO |200| 549.749µs /login {"statusCode": 200, "request": 10, "latency": "549.749µs", "avgLatency": "37.241461ms", "ipPort": "172.17.0.1:64165", "method": "GET", "host": "vouch.taiheops.com", "path": "/login", "referer": "http://vouch.taiheops.com:2081/"}
2021-01-22T01:53:57.901Z DEBUG /auth
2021-01-22T01:53:57.901Z INFO |200| 316.133µs /auth {"statusCode": 200, "request": 11, "latency": "316.133µs", "avgLatency": "33.884613ms", "ipPort": "172.17.0.1:64173", "method": "GET", "host": "vouch.taiheops.com", "path": "/auth", "referer": "http://vouch.taiheops.com:2081/"}
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment