Skip to content

Instantly share code, notes, and snippets.

Embed
What would you like to do?
Logs Vouch Proxy version : v0.37.3
Attaching to vouch_vouch_1
vouch_1 | {"level":"warn","ts":1660762651.354251,"msg":"set cfg.RootDir from VOUCH_ROOT env var: /"}
vouch_1 | {"level":"warn","ts":1660762651.3908663,"msg":"generating random session.key"}
vouch_1 | {"level":"info","ts":1660762651.3931358,"msg":"configuring ADFS OAuth"}
vouch_1 | {"level":"info","ts":1660762651.3970895,"msg":"configuring adfs OAuth with Endpoint https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize"}
vouch_1 | {"level":"info","ts":1660762651.3980758,"msg":"Vouch.header.claims sub will be forwarded downstream in the Header X-Vouch-IdP-Claims-Sub"}
vouch_1 | {"level":"debug","ts":1660762651.3987796,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_sub"}
vouch_1 | {"level":"info","ts":1660762651.3995266,"msg":"Vouch.header.claims name will be forwarded downstream in the Header X-Vouch-IdP-Claims-Name"}
vouch_1 | {"level":"debug","ts":1660762651.401783,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_name"}
vouch_1 | {"level":"info","ts":1660762651.4024665,"msg":"Vouch.header.claims email will be forwarded downstream in the Header X-Vouch-IdP-Claims-Email"}
vouch_1 | {"level":"debug","ts":1660762651.402708,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_email"}
vouch_1 | {"level":"debug","ts":1660762651.4028685,"msg":"cfg.RootDir: /"}
vouch_1 | 2022-08-17T18:57:31.403Z INFO testing: true, using development console logger
vouch_1 | 2022-08-17T18:57:31.403Z DEBUG vouch.jwt.secret is 44 characters long
vouch_1 | 2022-08-17T18:57:31.403Z DEBUG vouch.session.key is 44 characters long
vouch_1 | 2022-08-17T18:57:31.405Z INFO jwtcache: the returned headers for a valid jwt will be cached for 20 minutes
vouch_1 | 2022-08-17T18:57:31.405Z DEBUG responses.Configure() attempting to parse embedded templates
vouch_1 | {"level":"debug","ts":1660762651.403206,"msg":"Cfg {LogLevel:debug Listen:0.0.0.0 Port:9090 DocumentRoot: WriteTimeout:15 ReadTimeout:15 IdleTimeout:15 Domains:[] WhiteList:[] TeamWhiteList:[] AllowAllUsers:true PublicAccess:false TLS:{Cert: Key: Profile:intermediate} JWT:{SigningMethod:HS256 MaxAge:240 Issuer:Vouch Secret:XXXXXXXX PrivateKeyFile: PublicKeyFile: Compress:false} Cookie:{Name:my-vouch-ct Domain:mydomain.com Secure:true HTTPOnly:true MaxAge:240 SameSite:} Headers:{JWT:X-Vouch-Token User:X-Vouch-User QueryString:access_token Redirect:X-Vouch-Requested-URI Success:X-Vouch-Success Error:X-Vouch-Error ClaimHeader:X-Vouch-IdP-Claims- Claims:[sub name email] AccessToken:X-Vouch-IdP-AccessToken IDToken:X-Vouch-IdP-IdToken ClaimsCleaned:map[email:X-Vouch-IdP-Claims-Email name:X-Vouch-IdP-Claims-Name sub:X-Vouch-IdP-Claims-Sub]} Session:{Name:VouchSession MaxAge:5 Key:XXXXXXXX} TestURL: TestURLs:[] Testing:true LogoutRedirectURLs:[https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/logout?post_logout_redirect_uri=https://account.mydomain.com:8443]}"}
vouch_1 | {"level":"debug","ts":1660762651.4033024,"msg":"cfg.GenOauth {Provider:adfs ClientID:12345678 ClientSecret:XXXXXXXX AuthURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize TokenURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/token LogoutURL: RedirectURL:https://vouch.mydomain.com:8443/auth RedirectURLs:[] RelyingPartyId:https://vouch.mydomain.com:8443/auth Scopes:[openid email profile] Claims:<nil> UserInfoURL:https://graph.microsoft.com/oidc/userinfo UserTeamURL: UserOrgURL: PreferredDomain: AzureToken:id_token CodeChallengeMethod:}"}
vouch_1 | {"level":"debug","ts":1660762651.4067543,"msg":"checking availability of tcp port: 0.0.0.0:9090"}
vouch_1 | {"level":"info","ts":1660762651.4070482,"msg":"Copyright 2020-2022 the Vouch Proxy Authors"}
vouch_1 | {"level":"warn","ts":1660762651.407086,"msg":"This is free software with ABSOLUTELY NO WARRANTY."}
vouch_1 | {"level":"info","ts":1660762651.407104,"msg":"starting Vouch Proxy","version":"a7461a8","buildtime":"2022-08-12T20:40:14Z","uname":"Linux","buildhost":"localhost","branch":"HEAD","semver":"v0.37.3","listen":"http://0.0.0.0:9090","tls":false,"document_root":"","oauth.provider":"adfs"}
vouch_1 | {"level":"warn","ts":1660762660.7941523,"msg":"set cfg.RootDir from VOUCH_ROOT env var: /"}
vouch_1 | 2022-08-17T18:57:40.804Z INFO testing: true, using development console logger
vouch_1 | 2022-08-17T18:57:40.804Z DEBUG vouch.jwt.secret is 44 characters long
vouch_1 | 2022-08-17T18:57:40.804Z DEBUG vouch.session.key is 44 characters long
vouch_1 | 2022-08-17T18:57:40.805Z INFO jwtcache: the returned headers for a valid jwt will be cached for 20 minutes
vouch_1 | 2022-08-17T18:57:40.805Z DEBUG responses.Configure() attempting to parse embedded templates
vouch_1 | {"level":"warn","ts":1660762660.8043354,"msg":"generating random session.key"}
vouch_1 | {"level":"info","ts":1660762660.8044717,"msg":"configuring ADFS OAuth"}
vouch_1 | {"level":"info","ts":1660762660.8044958,"msg":"configuring adfs OAuth with Endpoint https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize"}
vouch_1 | {"level":"info","ts":1660762660.804568,"msg":"Vouch.header.claims sub will be forwarded downstream in the Header X-Vouch-IdP-Claims-Sub"}
vouch_1 | {"level":"debug","ts":1660762660.8045943,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_sub"}
vouch_1 | {"level":"info","ts":1660762660.8046138,"msg":"Vouch.header.claims name will be forwarded downstream in the Header X-Vouch-IdP-Claims-Name"}
vouch_1 | {"level":"debug","ts":1660762660.8046367,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_name"}
vouch_1 | {"level":"info","ts":1660762660.8046587,"msg":"Vouch.header.claims email will be forwarded downstream in the Header X-Vouch-IdP-Claims-Email"}
vouch_1 | {"level":"debug","ts":1660762660.8046799,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_email"}
vouch_1 | {"level":"debug","ts":1660762660.8046927,"msg":"cfg.RootDir: /"}
vouch_1 | {"level":"debug","ts":1660762660.80474,"msg":"Cfg {LogLevel:debug Listen:0.0.0.0 Port:9090 DocumentRoot: WriteTimeout:15 ReadTimeout:15 IdleTimeout:15 Domains:[] WhiteList:[] TeamWhiteList:[] AllowAllUsers:true PublicAccess:false TLS:{Cert: Key: Profile:intermediate} JWT:{SigningMethod:HS256 MaxAge:240 Issuer:Vouch Secret:XXXXXXXX PrivateKeyFile: PublicKeyFile: Compress:false} Cookie:{Name:my-vouch-ct Domain:mydomain.com Secure:true HTTPOnly:true MaxAge:240 SameSite:} Headers:{JWT:X-Vouch-Token User:X-Vouch-User QueryString:access_token Redirect:X-Vouch-Requested-URI Success:X-Vouch-Success Error:X-Vouch-Error ClaimHeader:X-Vouch-IdP-Claims- Claims:[sub name email] AccessToken:X-Vouch-IdP-AccessToken IDToken:X-Vouch-IdP-IdToken ClaimsCleaned:map[email:X-Vouch-IdP-Claims-Email name:X-Vouch-IdP-Claims-Name sub:X-Vouch-IdP-Claims-Sub]} Session:{Name:VouchSession MaxAge:5 Key:XXXXXXXX} TestURL: TestURLs:[] Testing:true LogoutRedirectURLs:[https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/logout?post_logout_redirect_uri=https://account.mydomain.com:8443]}"}
vouch_1 | {"level":"debug","ts":1660762660.8048074,"msg":"cfg.GenOauth {Provider:adfs ClientID:12345678 ClientSecret:XXXXXXXX AuthURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize TokenURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/token LogoutURL: RedirectURL:https://vouch.mydomain.com:8443/auth RedirectURLs:[] RelyingPartyId:https://vouch.mydomain.com:8443/auth Scopes:[openid email profile] Claims:<nil> UserInfoURL:https://graph.microsoft.com/oidc/userinfo UserTeamURL: UserOrgURL: PreferredDomain: AzureToken:id_token CodeChallengeMethod:}"}
vouch_1 | {"level":"debug","ts":1660762660.8053887,"msg":"checking availability of tcp port: 0.0.0.0:9090"}
vouch_1 | {"level":"info","ts":1660762660.8055658,"msg":"Copyright 2020-2022 the Vouch Proxy Authors"}
vouch_1 | {"level":"warn","ts":1660762660.80561,"msg":"This is free software with ABSOLUTELY NO WARRANTY."}
vouch_1 | {"level":"info","ts":1660762660.805629,"msg":"starting Vouch Proxy","version":"a7461a8","buildtime":"2022-08-12T20:40:14Z","uname":"Linux","buildhost":"localhost","branch":"HEAD","semver":"v0.37.3","listen":"http://0.0.0.0:9090","tls":false,"document_root":"","oauth.provider":"adfs"}
vouch_1 | {"level":"warn","ts":1660762687.9204164,"msg":"set cfg.RootDir from VOUCH_ROOT env var: /"}
vouch_1 | {"level":"warn","ts":1660762687.9325013,"msg":"generating random session.key"}
vouch_1 | {"level":"info","ts":1660762687.9336746,"msg":"configuring ADFS OAuth"}
vouch_1 | {"level":"info","ts":1660762687.9340503,"msg":"configuring adfs OAuth with Endpoint https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize"}
vouch_1 | {"level":"info","ts":1660762687.934415,"msg":"Vouch.header.claims sub will be forwarded downstream in the Header X-Vouch-IdP-Claims-Sub"}
vouch_1 | {"level":"debug","ts":1660762687.934774,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_sub"}
vouch_1 | {"level":"info","ts":1660762687.9356265,"msg":"Vouch.header.claims name will be forwarded downstream in the Header X-Vouch-IdP-Claims-Name"}
vouch_1 | {"level":"debug","ts":1660762687.937269,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_name"}
vouch_1 | {"level":"info","ts":1660762687.9377687,"msg":"Vouch.header.claims email will be forwarded downstream in the Header X-Vouch-IdP-Claims-Email"}
vouch_1 | {"level":"debug","ts":1660762687.938249,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_email"}
vouch_1 | {"level":"debug","ts":1660762687.9388783,"msg":"cfg.RootDir: /"}
vouch_1 | {"level":"debug","ts":1660762687.9391398,"msg":"Cfg {LogLevel:debug Listen:0.0.0.0 Port:9090 DocumentRoot: WriteTimeout:15 ReadTimeout:15 IdleTimeout:15 Domains:[] WhiteList:[] TeamWhiteList:[] AllowAllUsers:true PublicAccess:false TLS:{Cert: Key: Profile:intermediate} JWT:{SigningMethod:HS256 MaxAge:240 Issuer:Vouch Secret:XXXXXXXX PrivateKeyFile: PublicKeyFile: Compress:false} Cookie:{Name:my-vouch-ct Domain:mydomain.com Secure:true HTTPOnly:true MaxAge:240 SameSite:} Headers:{JWT:X-Vouch-Token User:X-Vouch-User QueryString:access_token Redirect:X-Vouch-Requested-URI Success:X-Vouch-Success Error:X-Vouch-Error ClaimHeader:X-Vouch-IdP-Claims- Claims:[sub name email] AccessToken:X-Vouch-IdP-AccessToken IDToken:X-Vouch-IdP-IdToken ClaimsCleaned:map[email:X-Vouch-IdP-Claims-Email name:X-Vouch-IdP-Claims-Name sub:X-Vouch-IdP-Claims-Sub]} Session:{Name:VouchSession MaxAge:5 Key:XXXXXXXX} TestURL: TestURLs:[] Testing:true LogoutRedirectURLs:[https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/logout?post_logout_redirect_uri=https://account.mydomain.com:8443]}"}
vouch_1 | {"level":"debug","ts":1660762687.9399312,"msg":"cfg.GenOauth {Provider:adfs ClientID:12345678 ClientSecret:XXXXXXXX AuthURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize TokenURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/token LogoutURL: RedirectURL:https://vouch.mydomain.com:8443/auth RedirectURLs:[] RelyingPartyId:https://vouch.mydomain.com:8443/auth Scopes:[openid email profile] Claims:<nil> UserInfoURL:https://graph.microsoft.com/oidc/userinfo UserTeamURL: UserOrgURL: PreferredDomain: AzureToken:id_token CodeChallengeMethod:}"}
vouch_1 | 2022-08-17T18:58:07.940Z INFO testing: true, using development console logger
vouch_1 | 2022-08-17T18:58:07.940Z DEBUG vouch.jwt.secret is 44 characters long
vouch_1 | 2022-08-17T18:58:07.940Z DEBUG vouch.session.key is 44 characters long
vouch_1 | 2022-08-17T18:58:07.941Z INFO jwtcache: the returned headers for a valid jwt will be cached for 20 minutes
vouch_1 | 2022-08-17T18:58:07.941Z DEBUG responses.Configure() attempting to parse embedded templates
vouch_1 | {"level":"debug","ts":1660762687.9420912,"msg":"checking availability of tcp port: 0.0.0.0:9090"}
vouch_1 | {"level":"info","ts":1660762687.942535,"msg":"Copyright 2020-2022 the Vouch Proxy Authors"}
vouch_1 | {"level":"warn","ts":1660762687.9426696,"msg":"This is free software with ABSOLUTELY NO WARRANTY."}
vouch_1 | {"level":"info","ts":1660762687.9427266,"msg":"starting Vouch Proxy","version":"a7461a8","buildtime":"2022-08-12T20:40:14Z","uname":"Linux","buildhost":"localhost","branch":"HEAD","semver":"v0.37.3","listen":"http://0.0.0.0:9090","tls":false,"document_root":"","oauth.provider":"adfs"}
vouch_1 | 2022-08-17T18:59:09.039Z INFO |200| 108.5µs /healthcheck {"statusCode": 200, "request": 1, "latency": "108.5µs", "avgLatency": "108.5µs", "ipPort": "127.0.0.1:57164", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T18:59:35.550Z DEBUG /validate
vouch_1 | 2022-08-17T18:59:35.550Z WARN no jwt found in request
vouch_1 | 2022-08-17T18:59:35.550Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-17T18:59:35.550Z DEBUG CaptureWriter.Write set w.StatusCode 401
vouch_1 | 2022-08-17T18:59:35.550Z INFO |401| 295.1µs /validate {"statusCode": 401, "request": 2, "latency": "295.1µs", "avgLatency": "201.8µs", "ipPort": "172.18.0.5:51742", "method": "GET", "host": "vouch.mydomain.com", "path": "/validate", "referer": ""}
vouch_1 | 2022-08-17T18:59:35.594Z DEBUG /login
vouch_1 | 2022-08-17T18:59:35.595Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-17T18:59:35.596Z DEBUG session state set to bRVQMCXIyfhttP1evQa5n50xVYLk9dJ
vouch_1 | 2022-08-17T18:59:35.597Z DEBUG Login url param normalized to 'https://account.mydomain.com:8443/'
vouch_1 | 2022-08-17T18:59:35.597Z DEBUG session requestedURL set to https://account.mydomain.com:8443/
vouch_1 | 2022-08-17T18:59:35.597Z DEBUG saving session with failcount 1
vouch_1 | 2022-08-17T18:59:35.598Z DEBUG redirecting to oauthURL https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize?client_id=e05d7f18-f987-4d41-9d84-3f50686d1957&redirect_uri=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&resource=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&response_type=code&scope=openid+email+profile&state=bRVQMCXIyfhttP1evQa5n50xVYLk9dJ
vouch_1 | 2022-08-17T18:59:35.600Z INFO |200| 5.5332ms /login {"statusCode": 200, "request": 3, "latency": "5.5332ms", "avgLatency": "1.978933ms", "ipPort": "172.18.0.5:51746", "method": "GET", "host": "vouch.mydomain.com", "path": "/login", "referer": ""}
vouch_1 | 2022-08-17T18:59:55.966Z DEBUG /auth
vouch_1 | 2022-08-17T18:59:55.968Z INFO |200| 2.3905ms /auth {"statusCode": 200, "request": 4, "latency": "2.3905ms", "avgLatency": "2.081824ms", "ipPort": "172.18.0.5:51754", "method": "GET", "host": "vouch.mydomain.com", "path": "/auth", "referer": "https://mydomain.b2clogin.com/"}
vouch_1 | 2022-08-17T18:59:58.457Z DEBUG /auth/{state}/
vouch_1 | 2022-08-17T18:59:58.458Z DEBUG code: eyJraWQiOiJCR2xWdDJLQ2x4dXJCNGJlSmtmMFFxa2k0SXRQT29LSTZYcU9jdmt5WkZJIiwidmVyIjoiMS4wIiwiemlwIjoiRGVmbGF0ZSIsInNlciI6IjEuMCJ9.Rv3ggXsYzzk4o40kKM69yVuwp_r3katFlMrsj0R_Wdz0j7xnIfE63Hxv0UPy4x7meixKrKE0CN3A03PAo275u-KQeOMIwBNgnerhG1hH5XnFGrLOcPQsORlw0vx0B1g2IZcA5JjD0rzpNcK-GInDtDk9r4W0SUKxFFSw3ap-PFlEfUIy-dBpTJ-1PI_TNHOvRRgnSp-VPIGASzd3mWC0FceXO8W6O9FBwi6Wh3M1N3SP-m0dby2tdnn8-15zB4u7Bq6B_a9XmJD-Ot9xzlKAMVCHxJRKI5VcIM95FHrlTWrT4yMDdkvYXKZYw59jjjoPRTGKbemR8PxJ74amxn5Zkg.1looY1qC93s-l2JK.H9G0iOh-8KCFadw10Q6qOrDtd2-Sh8uZWpAgGwFYCJeDhTfv00C-sl8iw3AbqkJEMdnBdPBf4Vq5o-QfE7lJFqaKfbJpjP5769FkevdWZz8ANnZIJ4xGkCmgR_19bjqBQvmS9uNF4cnaefMk-MHFam2SZ9XmgSaU5qzniNn3SDad15TptjTbffQJXa7KLcoKn5K6DGm1FgOLpkpPX53fJkRYNrrOqXwd3Pa9P7rEb48QyI_Orofiy0xuV2WdPAAnHbq1xWVioJrQLlpdUdfvr8nZBt9Yg07C4_L12gQCmU9HHQ0gcodfKmXGTTVhk6fEP8l1JRI1eWhL1fRfgToA43U8RNbDy0VcYbNhjzOu6wY1Jpzbtr_X7XYus5iUdtNU8FKS1zg0xl4I5R9rWumv1FGLSGrCcHAIh5pz6Q3AMb5AUKI1df735aUDiLyrW5R7QNVXqnQTkp1BE8c6zCWCVJO2HU8jJOSyaOTcjbvSMFNhrTmzVOR3-HEKq842EMprBOhGLbDX_r8nPIO9jrQGc1Uw05EyDreroWxzm71GeBe7qHXvOvNy3HOzOGPbmphg6dR-haLVIH_wOsCoS7t4LEslbZ9ZrN_DD840lgovFoBAt68Fl3RnAIjGk6B5oLsxCYRhfK0YOUQF0JQ6Talge1g_E-BhcNiTbKoE4lGepgEAO25gGnXTaHQd.VRHQu-lnYau59WyuDQq6KQ
vouch_1 | 2022-08-17T19:00:01.408Z DEBUG getUserInfoFromADFS idToken: {"exp":1660766401,"nbf":1660762801,"ver":"1.0","iss":"https://mydomain.b2clogin.com/88bbf8d4-7659-4181-8671-7e4c934bfdcf/v2.0/","sub":"cdf56ec7-9858-4f60-841d-985805feffdf","aud":"e05d7f18-f987-4d41-9d84-3f50686d1957","acr":"B2c-signup","iat":1660762801,"auth_time":1660762795,"signInName":"arun.kumar@mydomain.co.nz","name":"Arun","given_name":"Arun","family_name":"Kumar","email":"arun.kumar@mydomain.co.nz","tid":"88bbf8d4-7659-4181-8671-7e4c934bfdcf"}
vouch_1 | 2022-08-17T19:00:01.408Z INFO adfs adfsUser: {User:{Username: Name:Arun Email:arun.kumar@mydomain.co.nz CreatedOn:0 LastUpdate:0 ID:0 TeamMemberships:[]} Sub:cdf56ec7-9858-4f60-841d-985805feffdf UPN:}
vouch_1 | 2022-08-17T19:00:01.410Z DEBUG User Obj: &{Username: Name: Email:arun.kumar@mydomain.co.nz CreatedOn:0 LastUpdate:0 ID:0 TeamMemberships:[]}
vouch_1 | 2022-08-17T19:00:01.411Z DEBUG /auth/{state}/ Claims from userinfo: {Claims:map[email:arun.kumar@mydomain.co.nz name:Arun sub:cdf56ec7-9858-4f60-841d-985805feffdf]}
vouch_1 | 2022-08-17T19:00:01.411Z DEBUG verifyUser: Success! skipping verification, cfg.Cfg.AllowAllUsers is true
vouch_1 | 2022-08-17T19:00:01.411Z DEBUG token created, expires: 1660777201 diff from now: 14400
vouch_1 | 2022-08-17T19:00:01.412Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-17T19:00:01.413Z INFO |200| 2.9893553s /auth/bRVQMCXIyfhttP1evQa5n50xVYLk9dJ/ {"statusCode": 200, "request": 5, "latency": "2.9893553s", "avgLatency": "599.536519ms", "ipPort": "172.18.0.5:51762", "method": "GET", "host": "vouch.mydomain.com", "path": "/auth/bRVQMCXIyfhttP1evQa5n50xVYLk9dJ/", "referer": "https://vouch.mydomain.com:8443/auth?state=bRVQMCXIyfhttP1evQa5n50xVYLk9dJ&code=eyJraWQiOiJCR2xWdDJLQ2x4dXJCNGJlSmtmMFFxa2k0SXRQT29LSTZYcU9jdmt5WkZJIiwidmVyIjoiMS4wIiwiemlwIjoiRGVmbGF0ZSIsInNlciI6IjEuMCJ9.Rv3ggXsYzzk4o40kKM69yVuwp_r3katFlMrsj0R_Wdz0j7xnIfE63Hxv0UPy4x7meixKrKE0CN3A03PAo275u-KQeOMIwBNgnerhG1hH5XnFGrLOcPQsORlw0vx0B1g2IZcA5JjD0rzpNcK-GInDtDk9r4W0SUKxFFSw3ap-PFlEfUIy-dBpTJ-1PI_TNHOvRRgnSp-VPIGASzd3mWC0FceXO8W6O9FBwi6Wh3M1N3SP-m0dby2tdnn8-15zB4u7Bq6B_a9XmJD-Ot9xzlKAMVCHxJRKI5VcIM95FHrlTWrT4yMDdkvYXKZYw59jjjoPRTGKbemR8PxJ74amxn5Zkg.1looY1qC93s-l2JK.H9G0iOh-8KCFadw10Q6qOrDtd2-Sh8uZWpAgGwFYCJeDhTfv00C-sl8iw3AbqkJEMdnBdPBf4Vq5o-QfE7lJFqaKfbJpjP5769FkevdWZz8ANnZIJ4xGkCmgR_19bjqBQvmS9uNF4cnaefMk-MHFam2SZ9XmgSaU5qzniNn3SDad15TptjTbffQJXa7KLcoKn5K6DGm1FgOLpkpPX53fJkRYNrrOqXwd3Pa9P7rEb48QyI_Orofiy0xuV2WdPAAnHbq1xWVioJrQLlpdUdfvr8nZBt9Yg07C4_L12gQCmU9HHQ0gcodfKmXGTTVhk6fEP8l1JRI1eWhL1fRfgToA43U8RNbDy0VcYbNhjzOu6wY1Jpzbtr_X7XYus5iUdtNU8FKS1zg0xl4I5R9rWumv1FGLSGrCcHAIh5pz6Q3AMb5AUKI1df735aUDiLyrW5R7QNVXqnQTkp1BE8c6zCWCVJO2HU8jJOSyaOTcjbvSMFNhrTmzVOR3-HEKq842EMprBOhGLbDX_r8nPIO9jrQGc1Uw05EyDreroWxzm71GeBe7qHXvOvNy3HOzOGPbmphg6dR-haLVIH_wOsCoS7t4LEslbZ9ZrN_DD840lgovFoBAt68Fl3RnAIjGk6B5oLsxCYRhfK0YOUQF0JQ6Talge1g_E-BhcNiTbKoE4lGepgEAO25gGnXTaHQd.VRHQu-lnYau59WyuDQq6KQ"}
vouch_1 | 2022-08-17T19:00:06.449Z DEBUG jwt found in cookie
vouch_1 | 2022-08-17T19:00:06.449Z DEBUG /validate
vouch_1 | 2022-08-17T19:00:06.450Z DEBUG jwt found in cookie
vouch_1 | 2022-08-17T19:00:06.450Z DEBUG tokenString length: 1819
vouch_1 | 2022-08-17T19:00:06.452Z DEBUG *ptokenCLaims: { map[email:arun.kumar@mydomain.co.nz name:Arun sub:cdf56ec7-9858-4f60-841d-985805feffdf] eyJ0eXAiOiJKV1QiLCJhbGciOiJSUzI1NiIsImtpZCI6IlNMWmVpdmFuYWlxSGYwZGVCRmh5b0dQVnk0aTQyQWluUDlhWVd4Q29hQVUifQ.eyJleHAiOjE2NjA3NjY0MDEsIm5iZiI6MTY2MDc2MjgwMSwidmVyIjoiMS4wIiwiaXNzIjoiaHR0cHM6Ly9zdHVmZm5lYmIyY3VhdC5iMmNsb2dpbi5jb20vODhiYmY4ZDQtNzY1OS00MTgxLTg2NzEtN2U0YzkzNGJmZGNmL3YyLjAvIiwic3ViIjoiY2RmNTZlYzctOTg1OC00ZjYwLTg0MWQtOTg1ODA1ZmVmZmRmIiwiYXVkIjoiZTA1ZDdmMTgtZjk4Ny00ZDQxLTlkODQtM2Y1MDY4NmQxOTU3IiwiYWNyIjoiYjJjXzFhX3NpZ251cF9zaWduaW5fdXBmcm9udF9kYXRhX2NhcHR1cmUiLCJpYXQiOjE2NjA3NjI4MDEsImF1dGhfdGltZSI6MTY2MDc2Mjc5NSwic2lnbkluTmFtZSI6ImFydW4ua3VtYXJAc3R1ZmYuY28ubnoiLCJuYW1lIjoiQXJ1biIsImdpdmVuX25hbWUiOiJBcnVuIiwiZmFtaWx5X25hbWUiOiJLdW1hciIsImVtYWlsIjoiYXJ1bi5rdW1hckBzdHVmZi5jby5ueiIsInRpZCI6Ijg4YmJmOGQ0LTc2NTktNDE4MS04NjcxLTdlNGM5MzRiZmRjZiJ9.MspwkC1sCOoYJwTeUR8HSrAQpPkWz_W1YKbWsGS3gY8XFtk70dMsYg8LeTK6odMtONKQpWZq3H0-f6ncK1SYVjXUssiNUrZpEVn1etGSDZ_kmTnAFG5EvGem_4T-xODec3sA0TdB0Bid4rz0zCKyCslVeaD49LCQJTN9te0iyaVAvLnEATRlf841DFvaB9nD0wQSCuSVV8eG-_yKUODWqj41av50UoPctv41FSESO1wv42RmmtcjW8VkudzGhVf77HVph__AEceOLrYy9UbqAs51SJst3ZbjFjmbmH3UNGXtjQ8vHlawwd9h_C0C1okN4xFh0yDG5-uWnCZNukMp4Q {mydomain.com 1660777201 0 Vouch 0 }}
vouch_1 | 2022-08-17T19:00:06.452Z WARN no User found in jwt
vouch_1 | 2022-08-17T19:00:06.454Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-17T19:00:06.455Z DEBUG deleting cookie: my-vouch-ct
vouch_1 | 2022-08-17T19:00:06.455Z DEBUG CaptureWriter.Write set w.StatusCode 401
vouch_1 | 2022-08-17T19:00:06.456Z INFO |401| 7.2087ms /validate {"statusCode": 401, "request": 6, "latency": "7.2087ms", "avgLatency": "500.815216ms", "ipPort": "172.18.0.5:51772", "method": "GET", "host": "vouch.mydomain.com", "path": "/validate", "referer": "https://vouch.mydomain.com:8443/"}
vouch_1 | 2022-08-17T19:00:06.465Z DEBUG /login
vouch_1 | 2022-08-17T19:00:06.465Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-17T19:00:06.466Z DEBUG deleting cookie: my-vouch-ct
vouch_1 | 2022-08-17T19:00:06.467Z DEBUG session state set to IpiDJsxzJWuBtds27bQpvyOk6JsyvJr
vouch_1 | 2022-08-17T19:00:06.467Z DEBUG Login url param normalized to 'https://account.mydomain.com:8443/'
vouch_1 | 2022-08-17T19:00:06.468Z DEBUG session requestedURL set to https://account.mydomain.com:8443/
vouch_1 | 2022-08-17T19:00:06.468Z DEBUG saving session with failcount 1
vouch_1 | 2022-08-17T19:00:06.469Z DEBUG redirecting to oauthURL https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize?client_id=e05d7f18-f987-4d41-9d84-3f50686d1957&redirect_uri=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&resource=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&response_type=code&scope=openid+email+profile&state=IpiDJsxzJWuBtds27bQpvyOk6JsyvJr
vouch_1 | 2022-08-17T19:00:06.470Z INFO |200| 4.7469ms /login {"statusCode": 200, "request": 7, "latency": "4.7469ms", "avgLatency": "429.948314ms", "ipPort": "172.18.0.5:51774", "method": "GET", "host": "vouch.mydomain.com", "path": "/login", "referer": "https://vouch.mydomain.com:8443/"}
vouch_1 | 2022-08-17T19:00:09.138Z INFO |200| 120µs /healthcheck {"statusCode": 200, "request": 8, "latency": "120µs", "avgLatency": "376.219775ms", "ipPort": "127.0.0.1:57208", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | {"level":"warn","ts":1660762877.1047423,"msg":"set cfg.RootDir from VOUCH_ROOT env var: /"}
vouch_1 | {"level":"warn","ts":1660762877.123116,"msg":"generating random session.key"}
vouch_1 | {"level":"info","ts":1660762877.123253,"msg":"configuring ADFS OAuth"}
vouch_1 | {"level":"info","ts":1660762877.1232975,"msg":"configuring adfs OAuth with Endpoint https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize"}
vouch_1 | {"level":"info","ts":1660762877.123351,"msg":"Vouch.header.claims sub will be forwarded downstream in the Header X-Vouch-IdP-Claims-Sub"}
vouch_1 | 2022-08-17T19:01:17.123Z INFO testing: true, using development console logger
vouch_1 | 2022-08-17T19:01:17.123Z DEBUG vouch.jwt.secret is 44 characters long
vouch_1 | 2022-08-17T19:01:17.123Z DEBUG vouch.session.key is 44 characters long
vouch_1 | 2022-08-17T19:01:17.123Z INFO jwtcache: the returned headers for a valid jwt will be cached for 20 minutes
vouch_1 | 2022-08-17T19:01:17.123Z DEBUG responses.Configure() attempting to parse embedded templates
vouch_1 | {"level":"debug","ts":1660762877.1233733,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_sub"}
vouch_1 | {"level":"info","ts":1660762877.1233935,"msg":"Vouch.header.claims name will be forwarded downstream in the Header X-Vouch-IdP-Claims-Name"}
vouch_1 | {"level":"debug","ts":1660762877.1234128,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_name"}
vouch_1 | {"level":"info","ts":1660762877.1234274,"msg":"Vouch.header.claims email will be forwarded downstream in the Header X-Vouch-IdP-Claims-Email"}
vouch_1 | {"level":"debug","ts":1660762877.1234465,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_email"}
vouch_1 | {"level":"debug","ts":1660762877.1234653,"msg":"cfg.RootDir: /"}
vouch_1 | {"level":"debug","ts":1660762877.123517,"msg":"Cfg {LogLevel:debug Listen:0.0.0.0 Port:9090 DocumentRoot: WriteTimeout:15 ReadTimeout:15 IdleTimeout:15 Domains:[] WhiteList:[] TeamWhiteList:[] AllowAllUsers:true PublicAccess:false TLS:{Cert: Key: Profile:intermediate} JWT:{SigningMethod:HS256 MaxAge:240 Issuer:Vouch Secret:XXXXXXXX PrivateKeyFile: PublicKeyFile: Compress:false} Cookie:{Name:my-vouch-ct Domain:mydomain.com Secure:true HTTPOnly:true MaxAge:240 SameSite:} Headers:{JWT:X-Vouch-Token User:X-Vouch-User QueryString:access_token Redirect:X-Vouch-Requested-URI Success:X-Vouch-Success Error:X-Vouch-Error ClaimHeader:X-Vouch-IdP-Claims- Claims:[sub name email] AccessToken:X-Vouch-IdP-AccessToken IDToken:X-Vouch-IdP-IdToken ClaimsCleaned:map[email:X-Vouch-IdP-Claims-Email name:X-Vouch-IdP-Claims-Name sub:X-Vouch-IdP-Claims-Sub]} Session:{Name:VouchSession MaxAge:5 Key:XXXXXXXX} TestURL: TestURLs:[] Testing:true LogoutRedirectURLs:[https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/logout?post_logout_redirect_uri=https://account.mydomain.com:8443]}"}
vouch_1 | {"level":"debug","ts":1660762877.1235511,"msg":"cfg.GenOauth {Provider:adfs ClientID:12345678 ClientSecret:XXXXXXXX AuthURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize TokenURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/token LogoutURL: RedirectURL:https://vouch.mydomain.com:8443/auth RedirectURLs:[] RelyingPartyId:https://vouch.mydomain.com:8443/auth Scopes:[openid email profile] Claims:<nil> UserInfoURL:https://graph.microsoft.com/oidc/userinfo UserTeamURL: UserOrgURL: PreferredDomain: AzureToken:id_token CodeChallengeMethod:}"}
vouch_1 | {"level":"debug","ts":1660762877.1238134,"msg":"checking availability of tcp port: 0.0.0.0:9090"}
vouch_1 | {"level":"info","ts":1660762877.1252863,"msg":"Copyright 2020-2022 the Vouch Proxy Authors"}
vouch_1 | {"level":"warn","ts":1660762877.12532,"msg":"This is free software with ABSOLUTELY NO WARRANTY."}
vouch_1 | {"level":"info","ts":1660762877.1270435,"msg":"starting Vouch Proxy","version":"a7461a8","buildtime":"2022-08-12T20:40:14Z","uname":"Linux","buildhost":"localhost","branch":"HEAD","semver":"v0.37.3","listen":"http://0.0.0.0:9090","tls":false,"document_root":"","oauth.provider":"adfs"}
vouch_1 | 2022-08-17T19:02:17.144Z INFO |200| 65.5µs /healthcheck {"statusCode": 200, "request": 1, "latency": "65.5µs", "avgLatency": "65.5µs", "ipPort": "127.0.0.1:57210", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:03:17.216Z INFO |200| 37.1µs /healthcheck {"statusCode": 200, "request": 2, "latency": "37.1µs", "avgLatency": "51.3µs", "ipPort": "127.0.0.1:57212", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:04:17.364Z INFO |200| 437.5µs /healthcheck {"statusCode": 200, "request": 3, "latency": "437.5µs", "avgLatency": "180.033µs", "ipPort": "127.0.0.1:57214", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:05:17.475Z INFO |200| 40.7µs /healthcheck {"statusCode": 200, "request": 4, "latency": "40.7µs", "avgLatency": "145.2µs", "ipPort": "127.0.0.1:57216", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:06:17.861Z INFO |200| 797.2µs /healthcheck {"statusCode": 200, "request": 5, "latency": "797.2µs", "avgLatency": "275.6µs", "ipPort": "127.0.0.1:57218", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:07:50.242Z INFO |200| 686.5µs /healthcheck {"statusCode": 200, "request": 6, "latency": "686.5µs", "avgLatency": "344.083µs", "ipPort": "127.0.0.1:57220", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:08:50.369Z INFO |200| 60.1µs /healthcheck {"statusCode": 200, "request": 7, "latency": "60.1µs", "avgLatency": "303.514µs", "ipPort": "127.0.0.1:57222", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:09:50.543Z INFO |200| 129.9µs /healthcheck {"statusCode": 200, "request": 8, "latency": "129.9µs", "avgLatency": "281.813µs", "ipPort": "127.0.0.1:57224", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:10:50.680Z INFO |200| 285.7µs /healthcheck {"statusCode": 200, "request": 9, "latency": "285.7µs", "avgLatency": "282.244µs", "ipPort": "127.0.0.1:57226", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:11:50.783Z INFO |200| 34.1µs /healthcheck {"statusCode": 200, "request": 10, "latency": "34.1µs", "avgLatency": "257.43µs", "ipPort": "127.0.0.1:57228", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:12:50.870Z INFO |200| 788.2µs /healthcheck {"statusCode": 200, "request": 11, "latency": "788.2µs", "avgLatency": "305.681µs", "ipPort": "127.0.0.1:57230", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:13:51.059Z INFO |200| 42.1µs /healthcheck {"statusCode": 200, "request": 12, "latency": "42.1µs", "avgLatency": "283.716µs", "ipPort": "127.0.0.1:57232", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:14:51.192Z INFO |200| 1.9275ms /healthcheck {"statusCode": 200, "request": 13, "latency": "1.9275ms", "avgLatency": "410.16µs", "ipPort": "127.0.0.1:57234", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:15:51.267Z INFO |200| 134.9µs /healthcheck {"statusCode": 200, "request": 14, "latency": "134.9µs", "avgLatency": "390.499µs", "ipPort": "127.0.0.1:57236", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:16:51.342Z INFO |200| 36.9µs /healthcheck {"statusCode": 200, "request": 15, "latency": "36.9µs", "avgLatency": "366.926µs", "ipPort": "127.0.0.1:57238", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:17:51.437Z INFO |200| 41.3µs /healthcheck {"statusCode": 200, "request": 16, "latency": "41.3µs", "avgLatency": "346.575µs", "ipPort": "127.0.0.1:57240", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:18:51.510Z INFO |200| 53.6µs /healthcheck {"statusCode": 200, "request": 17, "latency": "53.6µs", "avgLatency": "329.342µs", "ipPort": "127.0.0.1:57242", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:26:35.949Z INFO |200| 108µs /healthcheck {"statusCode": 200, "request": 18, "latency": "108µs", "avgLatency": "317.046µs", "ipPort": "127.0.0.1:57244", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-17T19:27:36.050Z INFO |200| 55.1µs /healthcheck {"statusCode": 200, "request": 19, "latency": "55.1µs", "avgLatency": "303.26µs", "ipPort": "127.0.0.1:57246", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T01:30:07.804Z INFO |200| 1.1914ms /healthcheck {"statusCode": 200, "request": 20, "latency": "1.1914ms", "avgLatency": "347.667µs", "ipPort": "127.0.0.1:57248", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T02:54:07.476Z INFO |200| 284.3µs /healthcheck {"statusCode": 200, "request": 21, "latency": "284.3µs", "avgLatency": "344.65µs", "ipPort": "127.0.0.1:57250", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T02:55:07.620Z INFO |200| 995.1µs /healthcheck {"statusCode": 200, "request": 22, "latency": "995.1µs", "avgLatency": "374.215µs", "ipPort": "127.0.0.1:57252", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T02:57:11.893Z INFO |200| 48.2µs /healthcheck {"statusCode": 200, "request": 23, "latency": "48.2µs", "avgLatency": "360.041µs", "ipPort": "127.0.0.1:57254", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T02:58:12.128Z INFO |200| 57.5µs /healthcheck {"statusCode": 200, "request": 24, "latency": "57.5µs", "avgLatency": "347.436µs", "ipPort": "127.0.0.1:57256", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T02:59:12.242Z INFO |200| 1.2396ms /healthcheck {"statusCode": 200, "request": 25, "latency": "1.2396ms", "avgLatency": "383.122µs", "ipPort": "127.0.0.1:57258", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:00:12.397Z INFO |200| 147.6µs /healthcheck {"statusCode": 200, "request": 26, "latency": "147.6µs", "avgLatency": "374.064µs", "ipPort": "127.0.0.1:57260", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:01:12.500Z INFO |200| 37.1µs /healthcheck {"statusCode": 200, "request": 27, "latency": "37.1µs", "avgLatency": "361.584µs", "ipPort": "127.0.0.1:57262", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:02:12.630Z INFO |200| 70.3µs /healthcheck {"statusCode": 200, "request": 28, "latency": "70.3µs", "avgLatency": "351.181µs", "ipPort": "127.0.0.1:57264", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:03:13.049Z INFO |200| 485µs /healthcheck {"statusCode": 200, "request": 29, "latency": "485µs", "avgLatency": "355.795µs", "ipPort": "127.0.0.1:57266", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | {"level":"warn","ts":1660791832.4385011,"msg":"set cfg.RootDir from VOUCH_ROOT env var: /"}
vouch_1 | {"level":"warn","ts":1660791832.47329,"msg":"generating random session.key"}
vouch_1 | {"level":"info","ts":1660791832.4739957,"msg":"configuring ADFS OAuth"}
vouch_1 | {"level":"info","ts":1660791832.4741817,"msg":"configuring adfs OAuth with Endpoint https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize"}
vouch_1 | {"level":"info","ts":1660791832.4743905,"msg":"Vouch.header.claims sub will be forwarded downstream in the Header X-Vouch-IdP-Claims-Sub"}
vouch_1 | {"level":"debug","ts":1660791832.474714,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_sub"}
vouch_1 | {"level":"info","ts":1660791832.4749303,"msg":"Vouch.header.claims name will be forwarded downstream in the Header X-Vouch-IdP-Claims-Name"}
vouch_1 | {"level":"debug","ts":1660791832.4750772,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_name"}
vouch_1 | {"level":"info","ts":1660791832.4752743,"msg":"Vouch.header.claims email will be forwarded downstream in the Header X-Vouch-IdP-Claims-Email"}
vouch_1 | {"level":"debug","ts":1660791832.475713,"msg":"nginx will populate the variable $auth_resp_x_vouch_idp_claims_email"}
vouch_1 | {"level":"debug","ts":1660791832.4760084,"msg":"cfg.RootDir: /"}
vouch_1 | {"level":"debug","ts":1660791832.476241,"msg":"Cfg {LogLevel:debug Listen:0.0.0.0 Port:9090 DocumentRoot: WriteTimeout:15 ReadTimeout:15 IdleTimeout:15 Domains:[] WhiteList:[] TeamWhiteList:[] AllowAllUsers:true PublicAccess:false TLS:{Cert: Key: Profile:intermediate} JWT:{SigningMethod:HS256 MaxAge:240 Issuer:Vouch Secret:XXXXXXXX PrivateKeyFile: PublicKeyFile: Compress:false} Cookie:{Name:my-vouch-ct Domain:mydomain.com Secure:true HTTPOnly:true MaxAge:240 SameSite:} Headers:{JWT:X-Vouch-Token User:X-Vouch-User QueryString:access_token Redirect:X-Vouch-Requested-URI Success:X-Vouch-Success Error:X-Vouch-Error ClaimHeader:X-Vouch-IdP-Claims- Claims:[sub name email] AccessToken:X-Vouch-IdP-AccessToken IDToken:X-Vouch-IdP-IdToken ClaimsCleaned:map[email:X-Vouch-IdP-Claims-Email name:X-Vouch-IdP-Claims-Name sub:X-Vouch-IdP-Claims-Sub]} Session:{Name:VouchSession MaxAge:5 Key:XXXXXXXX} TestURL: TestURLs:[] Testing:true LogoutRedirectURLs:[https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/logout?post_logout_redirect_uri=https://account.mydomain.com:8443]}"}
vouch_1 | {"level":"debug","ts":1660791832.4767137,"msg":"cfg.GenOauth {Provider:adfs ClientID:12345678 ClientSecret:XXXXXXXX AuthURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize TokenURL:https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/token LogoutURL: RedirectURL:https://vouch.mydomain.com:8443/auth RedirectURLs:[] RelyingPartyId:https://vouch.mydomain.com:8443/auth Scopes:[openid email profile] Claims:<nil> UserInfoURL:https://graph.microsoft.com/oidc/userinfo UserTeamURL: UserOrgURL: PreferredDomain: AzureToken:id_token CodeChallengeMethod:}"}
vouch_1 | 2022-08-18T03:03:52.477Z INFO testing: true, using development console logger
vouch_1 | 2022-08-18T03:03:52.477Z DEBUG vouch.jwt.secret is 44 characters long
vouch_1 | 2022-08-18T03:03:52.477Z DEBUG vouch.session.key is 44 characters long
vouch_1 | 2022-08-18T03:03:52.478Z INFO jwtcache: the returned headers for a valid jwt will be cached for 20 minutes
vouch_1 | 2022-08-18T03:03:52.478Z DEBUG responses.Configure() attempting to parse embedded templates
vouch_1 | {"level":"debug","ts":1660791832.4813364,"msg":"checking availability of tcp port: 0.0.0.0:9090"}
vouch_1 | {"level":"info","ts":1660791832.4835687,"msg":"Copyright 2020-2022 the Vouch Proxy Authors"}
vouch_1 | {"level":"warn","ts":1660791832.4838629,"msg":"This is free software with ABSOLUTELY NO WARRANTY."}
vouch_1 | {"level":"info","ts":1660791832.4841096,"msg":"starting Vouch Proxy","version":"a7461a8","buildtime":"2022-08-12T20:40:14Z","uname":"Linux","buildhost":"localhost","branch":"HEAD","semver":"v0.37.3","listen":"http://0.0.0.0:9090","tls":false,"document_root":"","oauth.provider":"adfs"}
vouch_1 | 2022-08-18T03:04:21.416Z DEBUG /validate
vouch_1 | 2022-08-18T03:04:21.417Z WARN no jwt found in request
vouch_1 | 2022-08-18T03:04:21.417Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-18T03:04:21.417Z DEBUG CaptureWriter.Write set w.StatusCode 401
vouch_1 | 2022-08-18T03:04:21.418Z INFO |401| 1.0999ms /validate {"statusCode": 401, "request": 1, "latency": "1.0999ms", "avgLatency": "1.0999ms", "ipPort": "172.18.0.5:35236", "method": "GET", "host": "vouch.mydomain.com", "path": "/validate", "referer": ""}
vouch_1 | 2022-08-18T03:04:21.498Z DEBUG /login
vouch_1 | 2022-08-18T03:04:21.498Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-18T03:04:21.499Z DEBUG session state set to nsxXwQvoMrdiPNCo496sdnm0ZqmGblhS
vouch_1 | 2022-08-18T03:04:21.499Z DEBUG Login url param normalized to 'https://account.mydomain.com:8443/'
vouch_1 | 2022-08-18T03:04:21.499Z DEBUG session requestedURL set to https://account.mydomain.com:8443/
vouch_1 | 2022-08-18T03:04:21.499Z DEBUG saving session with failcount 1
vouch_1 | 2022-08-18T03:04:21.505Z DEBUG redirecting to oauthURL https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize?client_id=e05d7f18-f987-4d41-9d84-3f50686d1957&redirect_uri=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&resource=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&response_type=code&scope=openid+email+profile&state=nsxXwQvoMrdiPNCo496sdnm0ZqmGblhS
vouch_1 | 2022-08-18T03:04:21.512Z INFO |200| 14.8516ms /login {"statusCode": 200, "request": 2, "latency": "14.8516ms", "avgLatency": "7.97575ms", "ipPort": "172.18.0.5:35240", "method": "GET", "host": "vouch.mydomain.com", "path": "/login", "referer": ""}
vouch_1 | 2022-08-18T03:04:47.593Z DEBUG /auth
vouch_1 | 2022-08-18T03:04:47.593Z INFO |200| 646.8µs /auth {"statusCode": 200, "request": 3, "latency": "646.8µs", "avgLatency": "5.532767ms", "ipPort": "172.18.0.5:35248", "method": "GET", "host": "vouch.mydomain.com", "path": "/auth", "referer": "https://mydomain.b2clogin.com/"}
vouch_1 | 2022-08-18T03:04:50.027Z DEBUG /auth/{state}/
vouch_1 | 2022-08-18T03:04:50.033Z DEBUG code: eyJraWQiOiJCR2xWdDJLQ2x4dXJCNGJlSmtmMFFxa2k0SXRQT29LSTZYcU9jdmt5WkZJIiwidmVyIjoiMS4wIiwiemlwIjoiRGVmbGF0ZSIsInNlciI6IjEuMCJ9.h2sSyZ22Vin8V_7gSIQ0THyDHCw8IPQ5oeGXcA04sPOmhOyvklr29AHoGIyrjjd6U7pQKOFTPgFVH7q56D6kV6bRkdJW1jTLDOsi8Bg8pPFo49DxVQ_qBBnGcxkGkv-xqWX8NokEoS_AJ_qrMh5Ge3hV2HXOzMZHl2UQWrz5N659jndGxM5Hncfgwenn8NjrwfSAavG3onmHM1zRQIeR2AnJBKMHiDLJOcCWAfBrEV0cd3LbbmLvn7d541Omvi7-VJOUE18m6galsaCpcPf0sjBgoQkRd96EV1a_HyIzCXogdnm03dCZVlrhuRDu47V3oSHQRcAnUFJSpJFm3FvY3g.GVBBdVo7wyw0Uwpw.RplNVgEFUg-nJ1SCpFxpMPUn5nfEyhTDDBmdEbECpK8jl7Iz0J1qfQkYqeHz-uWv2tQRV_WA2HnSP8gtJltB0-7FmVJ0ucNis1_qS3igDzBbACsleBHRutg_THMti6Q1HXdykkT6ZG9nO9ync4Ms8SNv2N1qHYdT6MIVlp_Rk7DAkpMYWUM8F3aGQOT2VsJPWPGqo3lkvAY15tWMoPZdCdlJYvqSutz5up2yYiUCFAOnjVJhwn7MERHqT928C81zWB0V7KwoZ4vmJ-jNNbnDVECDX7FPfUeHZqXZtKmtrDS8x2zcG6_6NW0tpYUcKFTrMigAcHz9rQyLW3ASt1NNzOonxjjwzMjA9SF0APYq6udYV8lP3vxAAz-ugNdNL31Rr35amtccUUNTeScNx2FtI636ZrgvEYJ1xJmGvnzdtTlCApEoRM1f_bbws51HfcHKa8w5CEz2np0JGo2YGQ-d08ewXHnN2veTgypiKu0iFfBg7_oyTKnJtcbrnvK1hXA7_cZQJsb03-qYW2Gx_7ejwNpMGNOeHnWU56LSpLUzNhHpZm_SfWFufEE9rFrmNd6-8RUxGcBmdg_OLoSEhqdYtLpx7zhzlbD9Lsm9i44GLXSKKD1FTl-r-h0bHUH5Jp0UHk29QMOSFGYN9sGNn2U3idsUa9b_g2dcbV7_KkDvLLYEsU5-WyvdgYiGXw.2ykqzyT6MW17BtWvoqocAg
vouch_1 | 2022-08-18T03:04:52.517Z INFO |200| 64.2µs /healthcheck {"statusCode": 200, "request": 4, "latency": "64.2µs", "avgLatency": "4.165626ms", "ipPort": "127.0.0.1:57298", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:04:55.102Z DEBUG getUserInfoFromADFS idToken: {"exp":1660795495,"nbf":1660791895,"ver":"1.0","iss":"https://mydomain.b2clogin.com/88bbf8d4-7659-4181-8671-7e4c934bfdcf/v2.0/","sub":"cdf56ec7-9858-4f60-841d-985805feffdf","aud":"e05d7f18-f987-4d41-9d84-3f50686d1957","acr":"B2c-signup","iat":1660791895,"auth_time":1660791886,"signInName":"arun.kumar@mydomain.co.nz","name":"Arun","given_name":"Arun","family_name":"Kumar","email":"arun.kumar@mydomain.co.nz","tid":"88bbf8d4-7659-4181-8671-7e4c934bfdcf"}
vouch_1 | 2022-08-18T03:04:55.103Z INFO adfs adfsUser: {User:{Username: Name:Arun Email:arun.kumar@mydomain.co.nz CreatedOn:0 LastUpdate:0 ID:0 TeamMemberships:[]} Sub:cdf56ec7-9858-4f60-841d-985805feffdf UPN:}
vouch_1 | 2022-08-18T03:04:55.103Z DEBUG User Obj: &{Username: Name: Email:arun.kumar@mydomain.co.nz CreatedOn:0 LastUpdate:0 ID:0 TeamMemberships:[]}
vouch_1 | 2022-08-18T03:04:55.103Z DEBUG /auth/{state}/ Claims from userinfo: {Claims:map[email:arun.kumar@mydomain.co.nz name:Arun sub:cdf56ec7-9858-4f60-841d-985805feffdf]}
vouch_1 | 2022-08-18T03:04:55.103Z DEBUG verifyUser: Success! skipping verification, cfg.Cfg.AllowAllUsers is true
vouch_1 | 2022-08-18T03:04:55.103Z DEBUG token created, expires: 1660806295 diff from now: 14400
vouch_1 | 2022-08-18T03:04:55.105Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-18T03:04:55.107Z INFO |200| 5.0797321s /auth/nsxXwQvoMrdiPNCo496sdnm0ZqmGblhS/ {"statusCode": 200, "request": 5, "latency": "5.0797321s", "avgLatency": "1.01927892s", "ipPort": "172.18.0.5:35256", "method": "GET", "host": "vouch.mydomain.com", "path": "/auth/nsxXwQvoMrdiPNCo496sdnm0ZqmGblhS/", "referer": "https://vouch.mydomain.com:8443/auth?state=nsxXwQvoMrdiPNCo496sdnm0ZqmGblhS&code=eyJraWQiOiJCR2xWdDJLQ2x4dXJCNGJlSmtmMFFxa2k0SXRQT29LSTZYcU9jdmt5WkZJIiwidmVyIjoiMS4wIiwiemlwIjoiRGVmbGF0ZSIsInNlciI6IjEuMCJ9.h2sSyZ22Vin8V_7gSIQ0THyDHCw8IPQ5oeGXcA04sPOmhOyvklr29AHoGIyrjjd6U7pQKOFTPgFVH7q56D6kV6bRkdJW1jTLDOsi8Bg8pPFo49DxVQ_qBBnGcxkGkv-xqWX8NokEoS_AJ_qrMh5Ge3hV2HXOzMZHl2UQWrz5N659jndGxM5Hncfgwenn8NjrwfSAavG3onmHM1zRQIeR2AnJBKMHiDLJOcCWAfBrEV0cd3LbbmLvn7d541Omvi7-VJOUE18m6galsaCpcPf0sjBgoQkRd96EV1a_HyIzCXogdnm03dCZVlrhuRDu47V3oSHQRcAnUFJSpJFm3FvY3g.GVBBdVo7wyw0Uwpw.RplNVgEFUg-nJ1SCpFxpMPUn5nfEyhTDDBmdEbECpK8jl7Iz0J1qfQkYqeHz-uWv2tQRV_WA2HnSP8gtJltB0-7FmVJ0ucNis1_qS3igDzBbACsleBHRutg_THMti6Q1HXdykkT6ZG9nO9ync4Ms8SNv2N1qHYdT6MIVlp_Rk7DAkpMYWUM8F3aGQOT2VsJPWPGqo3lkvAY15tWMoPZdCdlJYvqSutz5up2yYiUCFAOnjVJhwn7MERHqT928C81zWB0V7KwoZ4vmJ-jNNbnDVECDX7FPfUeHZqXZtKmtrDS8x2zcG6_6NW0tpYUcKFTrMigAcHz9rQyLW3ASt1NNzOonxjjwzMjA9SF0APYq6udYV8lP3vxAAz-ugNdNL31Rr35amtccUUNTeScNx2FtI636ZrgvEYJ1xJmGvnzdtTlCApEoRM1f_bbws51HfcHKa8w5CEz2np0JGo2YGQ-d08ewXHnN2veTgypiKu0iFfBg7_oyTKnJtcbrnvK1hXA7_cZQJsb03-qYW2Gx_7ejwNpMGNOeHnWU56LSpLUzNhHpZm_SfWFufEE9rFrmNd6-8RUxGcBmdg_OLoSEhqdYtLpx7zhzlbD9Lsm9i44GLXSKKD1FTl-r-h0bHUH5Jp0UHk29QMOSFGYN9sGNn2U3idsUa9b_g2dcbV7_KkDvLLYEsU5-WyvdgYiGXw.2ykqzyT6MW17BtWvoqocAg"}
vouch_1 | 2022-08-18T03:05:16.495Z DEBUG jwt found in cookie
vouch_1 | 2022-08-18T03:05:16.495Z DEBUG /validate
vouch_1 | 2022-08-18T03:05:16.496Z DEBUG jwt found in cookie
vouch_1 | 2022-08-18T03:05:16.496Z DEBUG tokenString length: 1819
vouch_1 | 2022-08-18T03:05:16.498Z DEBUG *ptokenCLaims: { map[email:arun.kumar@mydomain.co.nz name:Arun sub:cdf56ec7-9858-4f60-841d-985805feffdf] eyJ0eXAiOiJKV1QiLCJhbGciOiJSUzI1NiIsImtpZCI6IlNMWmVpdmFuYWlxSGYwZGVCRmh5b0dQVnk0aTQyQWluUDlhWVd4Q29hQVUifQ.eyJleHAiOjE2NjA3OTU0OTUsIm5iZiI6MTY2MDc5MTg5NSwidmVyIjoiMS4wIiwiaXNzIjoiaHR0cHM6Ly9zdHVmZm5lYmIyY3VhdC5iMmNsb2dpbi5jb20vODhiYmY4ZDQtNzY1OS00MTgxLTg2NzEtN2U0YzkzNGJmZGNmL3YyLjAvIiwic3ViIjoiY2RmNTZlYzctOTg1OC00ZjYwLTg0MWQtOTg1ODA1ZmVmZmRmIiwiYXVkIjoiZTA1ZDdmMTgtZjk4Ny00ZDQxLTlkODQtM2Y1MDY4NmQxOTU3IiwiYWNyIjoiYjJjXzFhX3NpZ251cF9zaWduaW5fdXBmcm9udF9kYXRhX2NhcHR1cmUiLCJpYXQiOjE2NjA3OTE4OTUsImF1dGhfdGltZSI6MTY2MDc5MTg4Niwic2lnbkluTmFtZSI6ImFydW4ua3VtYXJAc3R1ZmYuY28ubnoiLCJuYW1lIjoiQXJ1biIsImdpdmVuX25hbWUiOiJBcnVuIiwiZmFtaWx5X25hbWUiOiJLdW1hciIsImVtYWlsIjoiYXJ1bi5rdW1hckBzdHVmZi5jby5ueiIsInRpZCI6Ijg4YmJmOGQ0LTc2NTktNDE4MS04NjcxLTdlNGM5MzRiZmRjZiJ9.jtCmLOdRGHnmErKEnmPPepv_sMPvv2VhsErF4ZZI6d-t1OIziIHbt8cQDmwwFXJKlIQYnnVg7BJhqWowt8ASEbyp4dmCgJlVuIU61tLtf8OcmuNqAaQ_RadLm4qprpD3_MbBl3hyBTTGC10uyd85VjhGLaZtxVG_E63C2WGoFwxo9ZobBRayJ7DMbuYLOuhUyWytbFOLkLSy8Qz2YqQ9r9hiGud0oHkdm0s4i8AwvSl8CRm0f4YRjVK3AnG51QdzuSO4ef1DJFUszMZSmThlmocxULHHLeEpPVPjmTOBfQkqD89MmCBMXb2lKqRpZxIpYXMNnfa9z4lzfDHPg6MeJg {mydomain.com 1660806295 0 Vouch 0 }}
vouch_1 | 2022-08-18T03:05:16.498Z WARN no User found in jwt
vouch_1 | 2022-08-18T03:05:16.499Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-18T03:05:16.499Z DEBUG deleting cookie: my-vouch-ct
vouch_1 | 2022-08-18T03:05:16.499Z DEBUG CaptureWriter.Write set w.StatusCode 401
vouch_1 | 2022-08-18T03:05:16.501Z INFO |401| 6.8603ms /validate {"statusCode": 401, "request": 6, "latency": "6.8603ms", "avgLatency": "850.542484ms", "ipPort": "172.18.0.5:35272", "method": "GET", "host": "vouch.mydomain.com", "path": "/validate", "referer": "https://vouch.mydomain.com:8443/"}
vouch_1 | 2022-08-18T03:05:16.507Z DEBUG /login
vouch_1 | 2022-08-18T03:05:16.509Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-18T03:05:16.509Z DEBUG deleting cookie: my-vouch-ct
vouch_1 | 2022-08-18T03:05:16.510Z DEBUG session state set to Uswrm3bkKMYbJ7wWzCbcMM6g7K0kK
vouch_1 | 2022-08-18T03:05:16.510Z DEBUG Login url param normalized to 'https://account.mydomain.com:8443/'
vouch_1 | 2022-08-18T03:05:16.510Z DEBUG session requestedURL set to https://account.mydomain.com:8443/
vouch_1 | 2022-08-18T03:05:16.510Z DEBUG saving session with failcount 1
vouch_1 | 2022-08-18T03:05:16.511Z DEBUG redirecting to oauthURL https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize?client_id=e05d7f18-f987-4d41-9d84-3f50686d1957&redirect_uri=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&resource=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&response_type=code&scope=openid+email+profile&state=Uswrm3bkKMYbJ7wWzCbcMM6g7K0kK
vouch_1 | 2022-08-18T03:05:16.513Z INFO |200| 6.3344ms /login {"statusCode": 200, "request": 7, "latency": "6.3344ms", "avgLatency": "729.94133ms", "ipPort": "172.18.0.5:35274", "method": "GET", "host": "vouch.mydomain.com", "path": "/login", "referer": "https://vouch.mydomain.com:8443/"}
vouch_1 | 2022-08-18T03:05:20.364Z DEBUG /auth
vouch_1 | 2022-08-18T03:05:20.365Z INFO |200| 1.2117ms /auth {"statusCode": 200, "request": 8, "latency": "1.2117ms", "avgLatency": "638.850127ms", "ipPort": "172.18.0.5:35282", "method": "GET", "host": "vouch.mydomain.com", "path": "/auth", "referer": "https://vouch.mydomain.com:8443/"}
vouch_1 | 2022-08-18T03:05:23.503Z DEBUG /auth/{state}/
vouch_1 | 2022-08-18T03:05:23.504Z DEBUG code: eyJraWQiOiJCR2xWdDJLQ2x4dXJCNGJlSmtmMFFxa2k0SXRQT29LSTZYcU9jdmt5WkZJIiwidmVyIjoiMS4wIiwiemlwIjoiRGVmbGF0ZSIsInNlciI6IjEuMCJ9.GFCxsQeIegxSt_Y9YaHUXaxjCGjPQ9z6Z4eaWHjoclgjSb5tRjcF7ysgz_cWeGhD5HHK0oOCpbuGRY4lNzRbzOYrfiX8aiXFOMPfz0x8FJDta1T1BbC1pNpUHhCuT2DOALU_3madBncPDnA1dohK-zo6ZU3_6a18p9BfQlWAQnxZSwJ8EuyONJ6RCzpMz3nTeFnLo69xFjUHLgkfUN7qzNnEbnslNc040dujbwaWkdBVvmPnj-auu6ybo2jLPBYH8TM41N8yvndJb9uJ6cJCzqKh-V9AYpvaSIQN7eC-P7hRdAv2BPPr15GlObg9NZsFXkmE3p0sGNHzC_W-HV7XLw.xKZuxgd_iv7cadLT.34WpjLErCkMsOE36WRURADjy9MtU8v-ib0aRrjYzA6a6y0jSpKCPPKlBe3vntRAvXt7TAJbSyE4JKsDwZ_lgyeAmvPDhdvySCDG1Edd-9brpa8cHE3fS4_twiidlcXk2svCnwoG6GBFLOe1VZM6F-xT9CbVyPn7psR66WKZ2s4Fv5T88WficH9lXBy-Ne5nv8oDxLVshwjU89GpD7NTdkJRAQ7XqX5tq2efdOsrhEgVNCX_-w6Ot35tBd9zvWIMqgVWw-LHv6TFd0x4zTfNT7YJxISAKKkVxYwdLIXwviQMqygXuGMj046WaDe3nDu9xckL9o2IMlGKv9yHzX1_iki6rsDSZh_VHqrsNV5KG02Yh2jbX2fR_cVodGaSpaH5KriFCzBeJftqTN8jOabBi25Dw7WwP04DVBqnUbUGisRckgu7WWhRrAd-We4JHMKlrgg52MSho5THvmoDAiGs68KuRj0-R9Cz5Vwjsq-4ZzkKWUAJD2mwgVldEA2_AQR6WmXLu3PEuZu1ivZghQR0jdko8dpb_ZWLh5mdXclqFo7n7pjFRxRrPUaAROvnN51KxGnjSIcjEhDEgZA11kRI8GdBciC2sJZ2xvsgH7gBIC-IjtxSbb_zP25Un873ysY11JUmuzqLWwrfHe4_BIxEGTMHXCfaJKB0Lv87-mf1DDfbdv-ZBv8agO9hz.oUVJTwCyS4hroyrc3gcsFw
vouch_1 | 2022-08-18T03:05:25.645Z DEBUG getUserInfoFromADFS idToken: {"exp":1660795525,"nbf":1660791925,"ver":"1.0","iss":"https://mydomain.b2clogin.com/88bbf8d4-7659-4181-8671-7e4c934bfdcf/v2.0/","sub":"cdf56ec7-9858-4f60-841d-985805feffdf","aud":"e05d7f18-f987-4d41-9d84-3f50686d1957","acr":"B2c-signup","iat":1660791925,"auth_time":1660791920,"signInName":"arun.kumar@mydomain.co.nz","name":"Arun","given_name":"Arun","family_name":"Kumar","email":"arun.kumar@mydomain.co.nz","tid":"88bbf8d4-7659-4181-8671-7e4c934bfdcf"}
vouch_1 | 2022-08-18T03:05:25.645Z INFO adfs adfsUser: {User:{Username: Name:Arun Email:arun.kumar@mydomain.co.nz CreatedOn:0 LastUpdate:0 ID:0 TeamMemberships:[]} Sub:cdf56ec7-9858-4f60-841d-985805feffdf UPN:}
vouch_1 | 2022-08-18T03:05:25.646Z DEBUG User Obj: &{Username: Name: Email:arun.kumar@mydomain.co.nz CreatedOn:0 LastUpdate:0 ID:0 TeamMemberships:[]}
vouch_1 | 2022-08-18T03:05:25.647Z DEBUG /auth/{state}/ Claims from userinfo: {Claims:map[email:arun.kumar@mydomain.co.nz name:Arun sub:cdf56ec7-9858-4f60-841d-985805feffdf]}
vouch_1 | 2022-08-18T03:05:25.647Z DEBUG verifyUser: Success! skipping verification, cfg.Cfg.AllowAllUsers is true
vouch_1 | 2022-08-18T03:05:25.648Z DEBUG token created, expires: 1660806325 diff from now: 14400
vouch_1 | 2022-08-18T03:05:25.648Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-18T03:05:25.650Z INFO |200| 2.1466817s /auth/Uswrm3bkKMYbJ7wWzCbcMM6g7K0kK/ {"statusCode": 200, "request": 9, "latency": "2.1466817s", "avgLatency": "806.386968ms", "ipPort": "172.18.0.5:35290", "method": "GET", "host": "vouch.mydomain.com", "path": "/auth/Uswrm3bkKMYbJ7wWzCbcMM6g7K0kK/", "referer": "https://vouch.mydomain.com:8443/auth?state=Uswrm3bkKMYbJ7wWzCbcMM6g7K0kK&code=eyJraWQiOiJCR2xWdDJLQ2x4dXJCNGJlSmtmMFFxa2k0SXRQT29LSTZYcU9jdmt5WkZJIiwidmVyIjoiMS4wIiwiemlwIjoiRGVmbGF0ZSIsInNlciI6IjEuMCJ9.GFCxsQeIegxSt_Y9YaHUXaxjCGjPQ9z6Z4eaWHjoclgjSb5tRjcF7ysgz_cWeGhD5HHK0oOCpbuGRY4lNzRbzOYrfiX8aiXFOMPfz0x8FJDta1T1BbC1pNpUHhCuT2DOALU_3madBncPDnA1dohK-zo6ZU3_6a18p9BfQlWAQnxZSwJ8EuyONJ6RCzpMz3nTeFnLo69xFjUHLgkfUN7qzNnEbnslNc040dujbwaWkdBVvmPnj-auu6ybo2jLPBYH8TM41N8yvndJb9uJ6cJCzqKh-V9AYpvaSIQN7eC-P7hRdAv2BPPr15GlObg9NZsFXkmE3p0sGNHzC_W-HV7XLw.xKZuxgd_iv7cadLT.34WpjLErCkMsOE36WRURADjy9MtU8v-ib0aRrjYzA6a6y0jSpKCPPKlBe3vntRAvXt7TAJbSyE4JKsDwZ_lgyeAmvPDhdvySCDG1Edd-9brpa8cHE3fS4_twiidlcXk2svCnwoG6GBFLOe1VZM6F-xT9CbVyPn7psR66WKZ2s4Fv5T88WficH9lXBy-Ne5nv8oDxLVshwjU89GpD7NTdkJRAQ7XqX5tq2efdOsrhEgVNCX_-w6Ot35tBd9zvWIMqgVWw-LHv6TFd0x4zTfNT7YJxISAKKkVxYwdLIXwviQMqygXuGMj046WaDe3nDu9xckL9o2IMlGKv9yHzX1_iki6rsDSZh_VHqrsNV5KG02Yh2jbX2fR_cVodGaSpaH5KriFCzBeJftqTN8jOabBi25Dw7WwP04DVBqnUbUGisRckgu7WWhRrAd-We4JHMKlrgg52MSho5THvmoDAiGs68KuRj0-R9Cz5Vwjsq-4ZzkKWUAJD2mwgVldEA2_AQR6WmXLu3PEuZu1ivZghQR0jdko8dpb_ZWLh5mdXclqFo7n7pjFRxRrPUaAROvnN51KxGnjSIcjEhDEgZA11kRI8GdBciC2sJZ2xvsgH7gBIC-IjtxSbb_zP25Un873ysY11JUmuzqLWwrfHe4_BIxEGTMHXCfaJKB0Lv87-mf1DDfbdv-ZBv8agO9hz.oUVJTwCyS4hroyrc3gcsFw"}
vouch_1 | 2022-08-18T03:05:28.281Z DEBUG jwt found in cookie
vouch_1 | 2022-08-18T03:05:28.281Z DEBUG /validate
vouch_1 | 2022-08-18T03:05:28.281Z DEBUG jwt found in cookie
vouch_1 | 2022-08-18T03:05:28.281Z DEBUG tokenString length: 1819
vouch_1 | 2022-08-18T03:05:28.281Z DEBUG *ptokenCLaims: { map[email:arun.kumar@mydomain.co.nz name:Arun sub:cdf56ec7-9858-4f60-841d-985805feffdf] eyJ0eXAiOiJKV1QiLCJhbGciOiJSUzI1NiIsImtpZCI6IlNMWmVpdmFuYWlxSGYwZGVCRmh5b0dQVnk0aTQyQWluUDlhWVd4Q29hQVUifQ.eyJleHAiOjE2NjA3OTU1MjUsIm5iZiI6MTY2MDc5MTkyNSwidmVyIjoiMS4wIiwiaXNzIjoiaHR0cHM6Ly9zdHVmZm5lYmIyY3VhdC5iMmNsb2dpbi5jb20vODhiYmY4ZDQtNzY1OS00MTgxLTg2NzEtN2U0YzkzNGJmZGNmL3YyLjAvIiwic3ViIjoiY2RmNTZlYzctOTg1OC00ZjYwLTg0MWQtOTg1ODA1ZmVmZmRmIiwiYXVkIjoiZTA1ZDdmMTgtZjk4Ny00ZDQxLTlkODQtM2Y1MDY4NmQxOTU3IiwiYWNyIjoiYjJjXzFhX3NpZ251cF9zaWduaW5fdXBmcm9udF9kYXRhX2NhcHR1cmUiLCJpYXQiOjE2NjA3OTE5MjUsImF1dGhfdGltZSI6MTY2MDc5MTkyMCwic2lnbkluTmFtZSI6ImFydW4ua3VtYXJAc3R1ZmYuY28ubnoiLCJuYW1lIjoiQXJ1biIsImdpdmVuX25hbWUiOiJBcnVuIiwiZmFtaWx5X25hbWUiOiJLdW1hciIsImVtYWlsIjoiYXJ1bi5rdW1hckBzdHVmZi5jby5ueiIsInRpZCI6Ijg4YmJmOGQ0LTc2NTktNDE4MS04NjcxLTdlNGM5MzRiZmRjZiJ9.clH1zegN-pWWAlaOEsVTjYy4CN8dFMlxYovI4HuquIUXkyo-qSkoK2Vw3LAlesUIh8wmIlo3IHY_u48bamPmP4akhfsOJV0CvveHjicyB5RQrkVS8OrQMmCMI1TkqbslPtVADZB6uBD_euX47A8aj-yJLwXIuZkmLBnVAqZlCpvBAvtB6Po38nQuxu4N_2GjQypEd15PZ-1GCE-hfx0ULWB0SNQ2eXbYAMznupT-OkCA0qP4EMICDE7UA6I_BzH7Bre4RVe1Ajw-0MY3UgOASsfWfvOG3kKKaITDW_rFfTXtsM7Uu0rnyXW3RT596wckInQUP8Qn6yXGTCPiE4ipLA {mydomain.com 1660806325 0 Vouch 0 }}
vouch_1 | 2022-08-18T03:05:28.282Z WARN no User found in jwt
vouch_1 | 2022-08-18T03:05:28.282Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-18T03:05:28.282Z DEBUG deleting cookie: my-vouch-ct
vouch_1 | 2022-08-18T03:05:28.282Z DEBUG CaptureWriter.Write set w.StatusCode 401
vouch_1 | 2022-08-18T03:05:28.283Z INFO |401| 2.8167ms /validate {"statusCode": 401, "request": 10, "latency": "2.8167ms", "avgLatency": "726.029942ms", "ipPort": "172.18.0.5:35298", "method": "GET", "host": "vouch.mydomain.com", "path": "/validate", "referer": "https://vouch.mydomain.com:8443/"}
vouch_1 | 2022-08-18T03:05:28.289Z DEBUG /login
vouch_1 | 2022-08-18T03:05:28.289Z DEBUG setting the cookie domain to mydomain.com
vouch_1 | 2022-08-18T03:05:28.290Z DEBUG deleting cookie: my-vouch-ct
vouch_1 | 2022-08-18T03:05:28.290Z DEBUG session state set to S967lxSkzh9BWoNSpQI7lu4IV6N4r61
vouch_1 | 2022-08-18T03:05:28.290Z DEBUG Login url param normalized to 'https://account.mydomain.com:8443/'
vouch_1 | 2022-08-18T03:05:28.290Z DEBUG session requestedURL set to https://account.mydomain.com:8443/
vouch_1 | 2022-08-18T03:05:28.290Z DEBUG saving session with failcount 1
vouch_1 | 2022-08-18T03:05:28.290Z DEBUG redirecting to oauthURL https://mydomain.b2clogin.com/mydomain.onmicrosoft.com/B2c-signup/oauth2/v2.0/authorize?client_id=e05d7f18-f987-4d41-9d84-3f50686d1957&redirect_uri=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&resource=https%3A%2F%2Fvouch.mydomain.com%3A8443%2Fauth&response_type=code&scope=openid+email+profile&state=S967lxSkzh9BWoNSpQI7lu4IV6N4r61
vouch_1 | 2022-08-18T03:05:28.292Z INFO |200| 2.3976ms /login {"statusCode": 200, "request": 11, "latency": "2.3976ms", "avgLatency": "660.245184ms", "ipPort": "172.18.0.5:35300", "method": "GET", "host": "vouch.mydomain.com", "path": "/login", "referer": "https://vouch.mydomain.com:8443/"}
vouch_1 | 2022-08-18T03:05:52.600Z INFO |200| 128.3µs /healthcheck {"statusCode": 200, "request": 12, "latency": "128.3µs", "avgLatency": "605.235444ms", "ipPort": "127.0.0.1:57342", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:06:52.728Z INFO |200| 39.3µs /healthcheck {"statusCode": 200, "request": 13, "latency": "39.3µs", "avgLatency": "558.681895ms", "ipPort": "127.0.0.1:57344", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:07:52.814Z INFO |200| 33.3µs /healthcheck {"statusCode": 200, "request": 14, "latency": "33.3µs", "avgLatency": "518.778424ms", "ipPort": "127.0.0.1:57346", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:08:52.921Z INFO |200| 96.4µs /healthcheck {"statusCode": 200, "request": 15, "latency": "96.4µs", "avgLatency": "484.199623ms", "ipPort": "127.0.0.1:57348", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
vouch_1 | 2022-08-18T03:09:53.019Z INFO |200| 77.2µs /healthcheck {"statusCode": 200, "request": 16, "latency": "77.2µs", "avgLatency": "453.941972ms", "ipPort": "127.0.0.1:57350", "method": "GET", "host": "0.0.0.0:9090", "path": "/healthcheck", "referer": ""}
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment