Skip to content

Instantly share code, notes, and snippets.

@mhf-ir
Last active February 7, 2020 11:06
Show Gist options
  • Save mhf-ir/5798263536c402a471078e8b498db79e to your computer and use it in GitHub Desktop.
Save mhf-ir/5798263536c402a471078e8b498db79e to your computer and use it in GitHub Desktop.
{"level":"debug","ts":1581072117.4029663,"msg":"logLevel set to debug"}
{"level":"warn","ts":1581072117.4030857,"msg":"generating random session.key"}
{"level":"info","ts":1581072117.4031963,"msg":"configuring ADFS OAuth"}
{"level":"info","ts":1581072117.4032087,"msg":"configuring adfs OAuth with Endpoint https://adfs.example.tld/adfs/oauth2/authorize/"}
{"level":"debug","ts":1581072117.4032269,"msg":"vouch.jwt.secret is 44 characters long"}
{"level":"debug","ts":1581072117.403232,"msg":"vouch.session.key is 44 characters long"}
{"level":"debug","ts":1581072117.403245,"msg":"checking availability of tcp port: 0.0.0.0:19090"}
{"level":"debug","ts":1581072117.4112332,"msg":"viper settings map[vouch:map[db:map[file:/db/vouch_bolt.db] loglevel:debug headers:map[jwt:X-Vouch-Token querystring:access_token redirect:X-Vouch-Requested-URI idtoken:X-Vouch-IdP-IdToken] port:19090 cookie:map[name:VouchCookie domain:example.tld secure:false] allowallusers:true listen:0.0.0.0 jwt:map[secret:54V2jDpTQs7AfaoNOI/6J7quwyIvGLn48d8YCPWIeLE= compress:false maxage:300] domains:[example.tld app.example.tld vouch.example.tld adfs.example.tld]] oauth:map[callback_url:https://vouch.example.tld/auth provider:adfs client_id:9b31f91c-91da-47df-899f-e66c7b9cc2ef auth_url:https://adfs.example.tld/adfs/oauth2/authorize/ token_url:https://adfs.example.tld/adfs/oauth2/token/ client_secret:HdjzbBRMwTF2c_n-Vx0zScLYImd9hDGH-drfOeP0 scopes:[email profile openid]]]"}
{"level":"debug","ts":1581072117.4113564,"msg":"opening dbfile /db/vouch_bolt.db"}
{"level":"info","ts":1581072117.4126866,"msg":"starting Vouch","version":"14b5740","buildtime":"2019-12-19T19:29:27Z","buildhost":"453007767e95","branch":"master","semver":"v0.6.17","listen":"0.0.0.0:19090","oauth.provider":"adfs"}
{"level":"debug","ts":1581072117.4130483,"msg":"serving static files from /static"}
{"level":"debug","ts":1581072176.6618268,"msg":"Request received : &{GET /validate HTTP/1.0 1 0 map[X-Real-Ip:[xxx.xxx.64.31] Accept-Language:[en-US,en;q=0.5] Accept-Encoding:[gzip, deflate, br] X-Request-Id:[fa1fdb4a69e54b2486885a68c4ccefe0] X-Forwarded-Host:[app.example.tld] X-Forwarded-Port:[443] X-Request-Time:[1581072176.658] X-Aasaam-Client-Id:[aasaam_cid=000000005E3D3F309522000C13D99601] Dnt:[1] X-Forwarded-For:[xxx.xxx.64.31] X-Forwarded-Proto:[https] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] X-Aasaam-Client-New:[1] Connection:[close] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Upgrade-Insecure-Requests:[1]] {} <nil> 0 [] true app.example.tld map[] map[] <nil> map[] 127.0.0.1:48674 /validate <nil> <nil> <nil> 0xc42001ea50}"}
{"level":"debug","ts":1581072176.6619465,"msg":"/validate"}
{"level":"error","ts":1581072176.662009,"msg":"no jwt found in request"}
{"level":"debug","ts":1581072176.6620314,"msg":"domain app.example.tld matched array value at [0]=app.example.tld"}
{"level":"debug","ts":1581072176.662047,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072176.6620975,"msg":"CaptureWriter.Write set w.StatusCode 401"}
{"level":"debug","ts":1581072176.662172,"msg":"Request handled successfully: 401"}
{"level":"info","ts":1581072176.6622176,"msg":"|401| 229.465µs /validate","statusCode":401,"request":1,"latency":0.000229465,"avgLatency":0.000229465,"ipPort":"127.0.0.1:48674","method":"GET","host":"app.example.tld","path":"/validate","referer":""}
{"level":"debug","ts":1581072176.7298915,"msg":"Request received : &{GET /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= HTTP/1.0 1 0 map[X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Agent-Version:[72] X-Aasaam-Agent-Vendor:[mozilla] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Accept-Encoding:[gzip, deflate, br] X-Forwarded-Port:[443] X-Aasaam-Client-New:[0] X-Aasaam-Agent-Name:[firefox] X-Aasaam-Agent-Category:[pc] X-Aasaam-Agent-Hash:[fb8f0894] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Accept-Language:[en-US,en;q=0.5] X-Aasaam-Geo-Country-Flag:[🌐] X-Request-Id:[601de2d640ca09c3d0c7f1fb92b39069] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Host:[vouch.example.tld] X-Forwarded-Proto:[https] X-Request-Time:[1581072176.728] X-Aasaam-Agent-Os:[linux] X-Aasaam-Geo-Default-Lang-Direction:[ltr] Upgrade-Insecure-Requests:[1] X-Forwarded-For:[xxx.xxx.64.31] Connection:[close] Dnt:[1] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:48676 /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= <nil> <nil> <nil> 0xc42001ecc0}"}
{"level":"debug","ts":1581072176.7299397,"msg":"/login"}
{"level":"debug","ts":1581072176.7299638,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072176.729981,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072176.7301316,"msg":"session state set to 30S9cJJgBvZptZ2F6F8B1dkZ7H9Ikhi"}
{"level":"debug","ts":1581072176.7301555,"msg":"session requestedURL set to https://app.example.tld/"}
{"level":"debug","ts":1581072176.7301648,"msg":"saving session"}
{"level":"debug","ts":1581072176.731037,"msg":"redirecting to oauthURL https://adfs.example.tld/adfs/oauth2/authorize/?client_id=9b31f91c-91da-47df-899f-e66c7b9cc2ef&redirect_uri=https%3A%2F%2Fvouch.example.tld%2Fauth&resource=https%3A%2F%2Fvouch.example.tld%2Fauth&response_type=code&scope=email+profile+openid&state=30S9cJJgBvZptZ2F6F8B1dkZ7H9Ikhi"}
{"level":"debug","ts":1581072176.7310708,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072176.7310898,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072176.7311406,"msg":"|302| 1.153349ms /login","statusCode":302,"request":2,"latency":0.001153349,"avgLatency":0.000691407,"ipPort":"127.0.0.1:48676","method":"GET","host":"vouch.example.tld","path":"/login","referer":""}
{"level":"debug","ts":1581072177.6978219,"msg":"Request received : &{GET /healthcheck HTTP/1.1 1 1 map[User-Agent:[Go-http-client/1.1] Accept-Encoding:[gzip]] {} <nil> 0 [] false 0.0.0.0:19090 map[] map[] <nil> map[] 127.0.0.1:48950 /healthcheck <nil> <nil> <nil> 0xc4201a8480}"}
{"level":"debug","ts":1581072177.6978664,"msg":"CaptureWriter.Write set w.StatusCode 200"}
{"level":"debug","ts":1581072177.6978772,"msg":"Request handled successfully: 200"}
{"level":"info","ts":1581072177.697887,"msg":"|200| 14.968µs /healthcheck","statusCode":200,"request":3,"latency":0.000014968,"avgLatency":0.000465928,"ipPort":"127.0.0.1:48950","method":"GET","host":"0.0.0.0:19090","path":"/healthcheck","referer":""}
{"level":"debug","ts":1581072181.0586,"msg":"Request received : &{GET /auth?code=pQsdRgx81UmttR9DQRsFow.6wJwgrqr1wjOAD1PqPRKEihmqWw.TM1XNStFo5bvRCJRhLUim47cm8qwmdkTVY3X5FPGkMFzcMlE0CdMr3O_ECzvKinLT-aZLXoGpB-B70TO4mpFw2Kr4iWAxh-casqUQbvAu_h5sUz3YfBIZHUCCbdTKD07gPyZEgh0cAOqU1GzOvuLhS0p0l7guw6Fe_avAGSB_iO844xV09_oo_U-oHuKgja0EuLbjiHPOqjkjUAT-9BQpcEgL6rV-4HNiBdyacyOzGHfkT6rmMinwA_WFZlpbTp6Q7FD4GPZyZJjnmRnyHAxLu6YUOaysR6DQzndKebFRZSlZLjNKctawhtnVRL8IWntcNsFRWRhD9aWZ0Xn914HNw&state=30S9cJJgBvZptZ2F6F8B1dkZ7H9Ikhi HTTP/1.0 1 0 map[X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Client-New:[0] X-Forwarded-Host:[vouch.example.tld] X-Aasaam-Agent-Os:[linux] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-For:[xxx.xxx.64.31] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE3NnxEdi1CQkFFQ180SUFBUkFCRUFBQV82Zl9nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01JUUFmTXpCVE9XTktTbWRDZGxwd2RGb3lSalpHT0VJeFpHdGFOMGc1U1d0b2FRWnpkSEpwYm1jTURnQU1jbVZ4ZFdWemRHVmtWVkpNQm5OMGNtbHVad3djQUJwb2RIUndjem92TDJsbVlYVjBhQzVwZFcxekxtRmpMbWx5THdaemRISnBibWNNSEFBYWFIUjBjSE02THk5cFptRjFkR2d1YVhWdGN5NWhZeTVwY2k4RGFXNTBCQUlBQWc9PXzFfV9iXKChv46tc1kO_d6NrhCMlVDLBlzihfqp_18giA==] X-Aasaam-Agent-Version:[72] X-Forwarded-Proto:[https] X-Aasaam-Agent-Name:[firefox] Connection:[close] Accept-Encoding:[gzip, deflate, br] Referer:[https://adfs.example.tld/] Dnt:[1] X-Forwarded-Port:[443] X-Aasaam-Geo-Country-Flag:[🌐] X-Request-Id:[8cbb7a245b6825e0cf1b7c5d22079cd8] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Aasaam-Agent-Vendor:[mozilla] X-Aasaam-Geo-Default-Lang-Direction:[ltr] Upgrade-Insecure-Requests:[1] X-Request-Time:[1581072181.057] X-Aasaam-Agent-Category:[pc] X-Aasaam-Agent-Hash:[fb8f0894] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Accept-Language:[en-US,en;q=0.5]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:49962 /auth?code=pQsdRgx81UmttR9DQRsFow.6wJwgrqr1wjOAD1PqPRKEihmqWw.TM1XNStFo5bvRCJRhLUim47cm8qwmdkTVY3X5FPGkMFzcMlE0CdMr3O_ECzvKinLT-aZLXoGpB-B70TO4mpFw2Kr4iWAxh-casqUQbvAu_h5sUz3YfBIZHUCCbdTKD07gPyZEgh0cAOqU1GzOvuLhS0p0l7guw6Fe_avAGSB_iO844xV09_oo_U-oHuKgja0EuLbjiHPOqjkjUAT-9BQpcEgL6rV-4HNiBdyacyOzGHfkT6rmMinwA_WFZlpbTp6Q7FD4GPZyZJjnmRnyHAxLu6YUOaysR6DQzndKebFRZSlZLjNKctawhtnVRL8IWntcNsFRWRhD9aWZ0Xn914HNw&state=30S9cJJgBvZptZ2F6F8B1dkZ7H9Ikhi <nil> <nil> <nil> 0xc42001f590}"}
{"level":"debug","ts":1581072181.0587072,"msg":"/auth"}
{"level":"debug","ts":1581072181.0599213,"msg":"code: pQsdRgx81UmttR9DQRsFow.6wJwgrqr1wjOAD1PqPRKEihmqWw.TM1XNStFo5bvRCJRhLUim47cm8qwmdkTVY3X5FPGkMFzcMlE0CdMr3O_ECzvKinLT-aZLXoGpB-B70TO4mpFw2Kr4iWAxh-casqUQbvAu_h5sUz3YfBIZHUCCbdTKD07gPyZEgh0cAOqU1GzOvuLhS0p0l7guw6Fe_avAGSB_iO844xV09_oo_U-oHuKgja0EuLbjiHPOqjkjUAT-9BQpcEgL6rV-4HNiBdyacyOzGHfkT6rmMinwA_WFZlpbTp6Q7FD4GPZyZJjnmRnyHAxLu6YUOaysR6DQzndKebFRZSlZLjNKctawhtnVRL8IWntcNsFRWRhD9aWZ0Xn914HNw"}
{"level":"error","ts":1581072181.1350186,"msg":"jws: invalid token received"}
{"level":"debug","ts":1581072181.1350725,"msg":"/auth Claims from userinfo: {Claims:map[]}"}
{"level":"debug","ts":1581072181.1350825,"msg":"/auth CallbackHandler"}
{"level":"debug","ts":1581072181.1351054,"msg":"/auth {Username: Name: Email: CreatedOn:0 LastUpdate:0 ID:0}"}
{"level":"debug","ts":1581072181.1351156,"msg":"skipping verify user since cfg.Cfg.AllowAllUsers is true"}
{"level":"debug","ts":1581072181.1352766,"msg":"new user.. setting created on to 1581072181"}
{"level":"error","ts":1581072181.1354303,"msg":"key required"}
{"level":"error","ts":1581072181.1355114,"msg":"key required"}
{"level":"debug","ts":1581072181.1356149,"msg":"token: &{ 0xc42018e060 map[typ:JWT alg:HS256] { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090181 0 Vouch 0 }} false}"}
{"level":"debug","ts":1581072181.1356423,"msg":"token expires: 1581090181"}
{"level":"debug","ts":1581072181.1356504,"msg":"diff from now: 18000"}
{"level":"debug","ts":1581072181.1358473,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072181.1358788,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072181.1360335,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072181.1360695,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072181.1361396,"msg":"|302| 77.370027ms /auth","statusCode":302,"request":4,"latency":0.077370027,"avgLatency":0.019691952,"ipPort":"127.0.0.1:49962","method":"GET","host":"vouch.example.tld","path":"/auth","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072181.2499433,"msg":"Request received : &{GET /validate HTTP/1.0 1 0 map[X-Request-Id:[ba85bfbef38f9ec041beca3f0f4fed19] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Accept-Language:[en-US,en;q=0.5] Referer:[https://adfs.example.tld/] Connection:[close] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Accept-Encoding:[gzip, deflate, br] Upgrade-Insecure-Requests:[1] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-For:[xxx.xxx.64.31] X-Forwarded-Host:[app.example.tld] X-Request-Time:[1581072181.249] X-Aasaam-Client-Id:[aasaam_cid=000000005E3D3F309522000C13D99701] X-Aasaam-Client-New:[1] Dnt:[1] X-Forwarded-Port:[443] X-Forwarded-Proto:[https] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MSwiaXNzIjoiVm91Y2gifQ.kCWkczzFzUPVtLTHGOmxBUrsy9hIpsceL3x_TiSWI5U]] {} <nil> 0 [] true app.example.tld map[] map[] <nil> map[] 127.0.0.1:49968 /validate <nil> <nil> <nil> 0xc4203ca840}"}
{"level":"debug","ts":1581072181.2499974,"msg":"/validate"}
{"level":"debug","ts":1581072181.2500246,"msg":"jwt from cookie: eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MSwiaXNzIjoiVm91Y2gifQ.kCWkczzFzUPVtLTHGOmxBUrsy9hIpsceL3x_TiSWI5U"}
{"level":"debug","ts":1581072181.2500448,"msg":"tokenString eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MSwiaXNzIjoiVm91Y2gifQ.kCWkczzFzUPVtLTHGOmxBUrsy9hIpsceL3x_TiSWI5U"}
{"level":"debug","ts":1581072181.2503598,"msg":"*ptokenCLaims: { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090181 0 Vouch 0 }}"}
{"level":"debug","ts":1581072181.2504122,"msg":"JWT Claims: {Username: Sites:[app.example.tld vouch.example.tld adfs.example.tld example.tld] CustomClaims:map[] PAccessToken: PIdToken: StandardClaims:{Audience: ExpiresAt:1581090181 Id: IssuedAt:0 Issuer:Vouch NotBefore:0 Subject:}}"}
{"level":"error","ts":1581072181.2504344,"msg":"no Username found in jwt"}
{"level":"debug","ts":1581072181.250473,"msg":"domain app.example.tld matched array value at [0]=app.example.tld"}
{"level":"debug","ts":1581072181.2505162,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072181.2505317,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072181.2505562,"msg":"CaptureWriter.Write set w.StatusCode 401"}
{"level":"debug","ts":1581072181.2506132,"msg":"Request handled successfully: 401"}
{"level":"info","ts":1581072181.2506406,"msg":"|401| 614.07µs /validate","statusCode":401,"request":5,"latency":0.00061407,"avgLatency":0.015876376,"ipPort":"127.0.0.1:49968","method":"GET","host":"app.example.tld","path":"/validate","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072181.403146,"msg":"Request received : &{GET /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= HTTP/1.0 1 0 map[X-Request-Id:[71c454f5d439d6c2551b3d498b546efd] X-Forwarded-Proto:[https] X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Agent-Name:[firefox] X-Aasaam-Agent-Vendor:[mozilla] Accept-Language:[en-US,en;q=0.5] Connection:[close] X-Aasaam-Geo-Default-Lang-Direction:[ltr] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] X-Aasaam-Agent-Os:[linux] X-Aasaam-Agent-Category:[pc] X-Aasaam-Geo-Country-Flag:[🌐] Referer:[https://adfs.example.tld/] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Dnt:[1] X-Aasaam-Agent-Version:[72] X-Aasaam-Agent-Hash:[fb8f0894] Accept-Encoding:[gzip, deflate, br] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Host:[vouch.example.tld] X-Request-Time:[1581072181.401] X-Aasaam-Client-New:[0] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Forwarded-For:[xxx.xxx.64.31] X-Forwarded-Port:[443] Upgrade-Insecure-Requests:[1] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MXxEdi1CQkFFQ180SUFBUkFCRUFBQV80M19nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01JUUFmTXpCVE9XTktTbWRDZGxwd2RGb3lSalpHT0VJeFpHdGFOMGc1U1d0b2FRWnpkSEpwYm1jTURnQU1jbVZ4ZFdWemRHVmtWVkpNQm5OMGNtbHVad3dDQUFBR2MzUnlhVzVuREJ3QUdtaDBkSEJ6T2k4dmFXWmhkWFJvTG1sMWJYTXVZV011YVhJdkEybHVkQVFDQUFBPXxD1aAR4eghkXHaeNJzwAW2uE1Xgs2IkKjVOOxC81PNxA==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MSwiaXNzIjoiVm91Y2gifQ.kCWkczzFzUPVtLTHGOmxBUrsy9hIpsceL3x_TiSWI5U]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:49970 /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= <nil> <nil> <nil> 0xc4203cab70}"}
{"level":"debug","ts":1581072181.4032493,"msg":"/login"}
{"level":"debug","ts":1581072181.4032729,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072181.4032826,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072181.4032903,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072181.4035563,"msg":"session state set to 81Ppaqj4Zc9lg8GWfRSf1B9dbG8IhR"}
{"level":"debug","ts":1581072181.4035792,"msg":"session requestedURL set to https://app.example.tld/"}
{"level":"debug","ts":1581072181.4035888,"msg":"failcount for https://app.example.tld/ is 0"}
{"level":"debug","ts":1581072181.403597,"msg":"saving session"}
{"level":"debug","ts":1581072181.4037173,"msg":"redirecting to oauthURL https://adfs.example.tld/adfs/oauth2/authorize/?client_id=9b31f91c-91da-47df-899f-e66c7b9cc2ef&redirect_uri=https%3A%2F%2Fvouch.example.tld%2Fauth&resource=https%3A%2F%2Fvouch.example.tld%2Fauth&response_type=code&scope=email+profile+openid&state=81Ppaqj4Zc9lg8GWfRSf1B9dbG8IhR"}
{"level":"debug","ts":1581072181.403744,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072181.4037707,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072181.4037817,"msg":"|302| 525.07µs /login","statusCode":302,"request":6,"latency":0.00052507,"avgLatency":0.013317825,"ipPort":"127.0.0.1:49970","method":"GET","host":"vouch.example.tld","path":"/login","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072181.61542,"msg":"Request received : &{GET /auth?code=pQsdRgx81UmttR9DQRsFow.RnXDgrqr1wjPAFw6QUQgWzpTfrc.DGxkFwDFflsot9nfJmc2seQjqIKtxFzaJxNDZkTrJCIOfsJ1pl1fmJM901RbCTJMag1MVwrADJrztJjzHgFwohVppQ7GIY12wO3eFaP0UyB91n7rlgfjwpH_HwMhG_3IooiQFpkyn2WLz-j18_ZkkpZ8pnfFPDz9juZwq_-2EIMPtC0oe_VmtMoRMc_0bPoHctjfcWh_016TKlzoT9KmustyYKqvvZz4AvWcvvBaMZ3-tTkNyVJlbx6mx4HtKrHtOnhZn91wIYUWL5eV_V579BxgGkvF98NsiIqaAPrWcKGdYzuZ2np0oZBbtapkgbI7eL6kzxo9MjFC7oxe37APug&state=81Ppaqj4Zc9lg8GWfRSf1B9dbG8IhR HTTP/1.0 1 0 map[Accept-Language:[en-US,en;q=0.5] X-Aasaam-Agent-Category:[pc] X-Aasaam-Agent-Os:[linux] X-Aasaam-Agent-Version:[72] Connection:[close] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Referer:[https://adfs.example.tld/] X-Aasaam-Agent-Name:[firefox] X-Aasaam-Client-New:[0] X-Request-Time:[1581072181.614] X-Forwarded-Host:[vouch.example.tld] Dnt:[1] X-Forwarded-For:[xxx.xxx.64.31] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Proto:[https] X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Geo-Default-Lang-Direction:[ltr] X-Aasaam-Geo-Country-Flag:[🌐] Accept-Encoding:[gzip, deflate, br] X-Request-Id:[d6eeba91a76f21f231453639535964a6] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Aasaam-Agent-Vendor:[mozilla] X-Aasaam-Agent-Hash:[fb8f0894] Upgrade-Insecure-Requests:[1] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MXxEdi1CQkFFQ180SUFBUkFCRUFBQV82Yl9nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01JQUFlT0RGUWNHRnhhalJhWXpsc1p6aEhWMlpTVTJZeFFqbGtZa2M0U1doU0JuTjBjbWx1Wnd3T0FBeHlaWEYxWlhOMFpXUlZVa3dHYzNSeWFXNW5EQndBR21oMGRIQnpPaTh2YVdaaGRYUm9MbWwxYlhNdVlXTXVhWEl2Qm5OMGNtbHVad3djQUJwb2RIUndjem92TDJsbVlYVjBhQzVwZFcxekxtRmpMbWx5THdOcGJuUUVBZ0FDfGHwokUOV_NwwnoBt0h1glZLVqqBbOPQyn9hzsvJyAMg] X-Forwarded-Port:[443]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:49976 /auth?code=pQsdRgx81UmttR9DQRsFow.RnXDgrqr1wjPAFw6QUQgWzpTfrc.DGxkFwDFflsot9nfJmc2seQjqIKtxFzaJxNDZkTrJCIOfsJ1pl1fmJM901RbCTJMag1MVwrADJrztJjzHgFwohVppQ7GIY12wO3eFaP0UyB91n7rlgfjwpH_HwMhG_3IooiQFpkyn2WLz-j18_ZkkpZ8pnfFPDz9juZwq_-2EIMPtC0oe_VmtMoRMc_0bPoHctjfcWh_016TKlzoT9KmustyYKqvvZz4AvWcvvBaMZ3-tTkNyVJlbx6mx4HtKrHtOnhZn91wIYUWL5eV_V579BxgGkvF98NsiIqaAPrWcKGdYzuZ2np0oZBbtapkgbI7eL6kzxo9MjFC7oxe37APug&state=81Ppaqj4Zc9lg8GWfRSf1B9dbG8IhR <nil> <nil> <nil> 0xc42052af90}"}
{"level":"debug","ts":1581072181.615588,"msg":"/auth"}
{"level":"debug","ts":1581072181.6163332,"msg":"code: pQsdRgx81UmttR9DQRsFow.RnXDgrqr1wjPAFw6QUQgWzpTfrc.DGxkFwDFflsot9nfJmc2seQjqIKtxFzaJxNDZkTrJCIOfsJ1pl1fmJM901RbCTJMag1MVwrADJrztJjzHgFwohVppQ7GIY12wO3eFaP0UyB91n7rlgfjwpH_HwMhG_3IooiQFpkyn2WLz-j18_ZkkpZ8pnfFPDz9juZwq_-2EIMPtC0oe_VmtMoRMc_0bPoHctjfcWh_016TKlzoT9KmustyYKqvvZz4AvWcvvBaMZ3-tTkNyVJlbx6mx4HtKrHtOnhZn91wIYUWL5eV_V579BxgGkvF98NsiIqaAPrWcKGdYzuZ2np0oZBbtapkgbI7eL6kzxo9MjFC7oxe37APug"}
{"level":"error","ts":1581072181.6333733,"msg":"jws: invalid token received"}
{"level":"debug","ts":1581072181.6334078,"msg":"/auth Claims from userinfo: {Claims:map[]}"}
{"level":"debug","ts":1581072181.6334147,"msg":"/auth CallbackHandler"}
{"level":"debug","ts":1581072181.6334248,"msg":"/auth {Username: Name: Email: CreatedOn:0 LastUpdate:0 ID:0}"}
{"level":"debug","ts":1581072181.6334302,"msg":"skipping verify user since cfg.Cfg.AllowAllUsers is true"}
{"level":"debug","ts":1581072181.633464,"msg":"new user.. setting created on to 1581072181"}
{"level":"error","ts":1581072181.6335096,"msg":"key required"}
{"level":"error","ts":1581072181.6335378,"msg":"key required"}
{"level":"debug","ts":1581072181.6335764,"msg":"token: &{ 0xc42018e060 map[typ:JWT alg:HS256] { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090181 0 Vouch 0 }} false}"}
{"level":"debug","ts":1581072181.6336005,"msg":"token expires: 1581090181"}
{"level":"debug","ts":1581072181.6336102,"msg":"diff from now: 18000"}
{"level":"debug","ts":1581072181.633681,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072181.6337054,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072181.6349397,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072181.6349807,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072181.6350002,"msg":"|302| 19.396715ms /auth","statusCode":302,"request":7,"latency":0.019396715,"avgLatency":0.014186237,"ipPort":"127.0.0.1:49976","method":"GET","host":"vouch.example.tld","path":"/auth","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072181.7355435,"msg":"Request received : &{GET /validate HTTP/1.0 1 0 map[X-Forwarded-Port:[443] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Accept-Language:[en-US,en;q=0.5] Connection:[close] Referer:[https://adfs.example.tld/] Dnt:[1] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MSwiaXNzIjoiVm91Y2gifQ.kCWkczzFzUPVtLTHGOmxBUrsy9hIpsceL3x_TiSWI5U] X-Request-Id:[bbb5128c96baaf71c09f6d0f92355d7c] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Host:[app.example.tld] Accept-Encoding:[gzip, deflate, br] X-Request-Time:[1581072181.734] X-Aasaam-Client-Id:[aasaam_cid=000000005E3D3F309522000C13D99701] X-Aasaam-Client-New:[1] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] X-Forwarded-For:[xxx.xxx.64.31] X-Forwarded-Proto:[https] Upgrade-Insecure-Requests:[1]] {} <nil> 0 [] true app.example.tld map[] map[] <nil> map[] 127.0.0.1:49982 /validate <nil> <nil> <nil> 0xc4203d0660}"}
{"level":"debug","ts":1581072181.7355998,"msg":"/validate"}
{"level":"debug","ts":1581072181.7356286,"msg":"jwt from cookie: eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MSwiaXNzIjoiVm91Y2gifQ.kCWkczzFzUPVtLTHGOmxBUrsy9hIpsceL3x_TiSWI5U"}
{"level":"debug","ts":1581072181.735649,"msg":"tokenString eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MSwiaXNzIjoiVm91Y2gifQ.kCWkczzFzUPVtLTHGOmxBUrsy9hIpsceL3x_TiSWI5U"}
{"level":"debug","ts":1581072181.7358413,"msg":"*ptokenCLaims: { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090181 0 Vouch 0 }}"}
{"level":"debug","ts":1581072181.7358923,"msg":"JWT Claims: {Username: Sites:[app.example.tld vouch.example.tld adfs.example.tld example.tld] CustomClaims:map[] PAccessToken: PIdToken: StandardClaims:{Audience: ExpiresAt:1581090181 Id: IssuedAt:0 Issuer:Vouch NotBefore:0 Subject:}}"}
{"level":"error","ts":1581072181.7359142,"msg":"no Username found in jwt"}
{"level":"debug","ts":1581072181.7359369,"msg":"domain app.example.tld matched array value at [0]=app.example.tld"}
{"level":"debug","ts":1581072181.7359512,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072181.7359626,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072181.7360814,"msg":"CaptureWriter.Write set w.StatusCode 401"}
{"level":"debug","ts":1581072181.7361271,"msg":"Request handled successfully: 401"}
{"level":"info","ts":1581072181.7363043,"msg":"|401| 527.507µs /validate","statusCode":401,"request":8,"latency":0.000527507,"avgLatency":0.012478896,"ipPort":"127.0.0.1:49982","method":"GET","host":"app.example.tld","path":"/validate","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072181.8308961,"msg":"Request received : &{GET /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= HTTP/1.0 1 0 map[X-Forwarded-For:[xxx.xxx.64.31] X-Aasaam-Geo-Default-Lang-Direction:[ltr] Dnt:[1] X-Request-Id:[285badeb10710b0832fa53353524513d] X-Request-Time:[1581072181.829] X-Aasaam-Agent-Name:[firefox] Accept-Encoding:[gzip, deflate, br] Referer:[https://adfs.example.tld/] X-Forwarded-Proto:[https] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] Connection:[close] X-Forwarded-Port:[443] X-Aasaam-Agent-Version:[72] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Agent-Vendor:[mozilla] X-Aasaam-Agent-Category:[pc] X-Aasaam-Agent-Hash:[fb8f0894] Upgrade-Insecure-Requests:[1] X-Aasaam-Agent-Os:[linux] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] X-Forwarded-Host:[vouch.example.tld] X-Aasaam-Client-New:[0] X-Aasaam-Geo-Country-Flag:[🌐] Accept-Language:[en-US,en;q=0.5] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MXxEdi1CQkFFQ180SUFBUkFCRUFBQV80el9nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01JQUFlT0RGUWNHRnhhalJhWXpsc1p6aEhWMlpTVTJZeFFqbGtZa2M0U1doU0JuTjBjbWx1Wnd3T0FBeHlaWEYxWlhOMFpXUlZVa3dHYzNSeWFXNW5EQUlBQUFaemRISnBibWNNSEFBYWFIUjBjSE02THk5cFptRjFkR2d1YVhWdGN5NWhZeTVwY2k4RGFXNTBCQUlBQUE9PXzlbcMtLSmK3EgwRBsnzgSSWzTAQpNZJvzF5-qaIxJwmA==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MSwiaXNzIjoiVm91Y2gifQ.kCWkczzFzUPVtLTHGOmxBUrsy9hIpsceL3x_TiSWI5U] X-Real-Ip:[xxx.xxx.64.31]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:49984 /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= <nil> <nil> <nil> 0xc4203d0960}"}
{"level":"debug","ts":1581072181.8309872,"msg":"/login"}
{"level":"debug","ts":1581072181.8310084,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072181.831022,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072181.8310328,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072181.831577,"msg":"session state set to wjziccg3g2vN1fbCPK7M41YeB1mdtX3"}
{"level":"debug","ts":1581072181.8316078,"msg":"session requestedURL set to https://app.example.tld/"}
{"level":"debug","ts":1581072181.8316488,"msg":"failcount for https://app.example.tld/ is 0"}
{"level":"debug","ts":1581072181.8318343,"msg":"saving session"}
{"level":"debug","ts":1581072181.8319738,"msg":"redirecting to oauthURL https://adfs.example.tld/adfs/oauth2/authorize/?client_id=9b31f91c-91da-47df-899f-e66c7b9cc2ef&redirect_uri=https%3A%2F%2Fvouch.example.tld%2Fauth&resource=https%3A%2F%2Fvouch.example.tld%2Fauth&response_type=code&scope=email+profile+openid&state=wjziccg3g2vN1fbCPK7M41YeB1mdtX3"}
{"level":"debug","ts":1581072181.8320348,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072181.832056,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072181.8320696,"msg":"|302| 1.071253ms /login","statusCode":302,"request":9,"latency":0.001071253,"avgLatency":0.011211381,"ipPort":"127.0.0.1:49984","method":"GET","host":"vouch.example.tld","path":"/login","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.0810285,"msg":"Request received : &{GET /auth?code=pQsdRgx81UmttR9DQRsFow.zPsKg7qr1wjQABXpUCfyHFQE92g.rDAu1DXoCemTFLp9O1TPEAbeK4Ya1gAwFoxuyVRobajx2XOHUPa4GvgcsFU0TTt_fBfNN7nJwq7eyBNmP8rxVzqEP_lEEZfu8icwjr3Nyyg54vLC6qAwc5WeRES9TAGKlThyyoiMp5jXhHHISOqBpe1tqz89B5sErQfCaeJaQenGbaYeV-OBo6kStNyDpe2ax2fZe5pysH7_JiMKXDA3fNXymLsMmF2j_Sx336kljsrRZ1tmiTfW-e14rPnhAPrKZFM_AGrPEbh2y8xlzcIUrS9i9rJYzN3UlHPQomPkVHf2Ei8fXo-yuPlqOZ4jJNCr8ck3_3wzQJimtLf3mP48Tg&state=wjziccg3g2vN1fbCPK7M41YeB1mdtX3 HTTP/1.0 1 0 map[X-Aasaam-Agent-Version:[72] X-Aasaam-Agent-Vendor:[mozilla] Accept-Encoding:[gzip, deflate, br] X-Aasaam-Agent-Name:[firefox] X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Client-New:[0] Referer:[https://adfs.example.tld/] Dnt:[1] X-Forwarded-For:[xxx.xxx.64.31] X-Aasaam-Agent-Os:[linux] X-Aasaam-Agent-Hash:[fb8f0894] Connection:[close] Upgrade-Insecure-Requests:[1] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MXxEdi1CQkFFQ180SUFBUkFCRUFBQV82Zl9nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01JUUFmZDJwNmFXTmpaek5uTW5aT01XWmlRMUJMTjAwME1WbGxRakZ0WkhSWU13WnpkSEpwYm1jTURnQU1jbVZ4ZFdWemRHVmtWVkpNQm5OMGNtbHVad3djQUJwb2RIUndjem92TDJsbVlYVjBhQzVwZFcxekxtRmpMbWx5THdaemRISnBibWNNSEFBYWFIUjBjSE02THk5cFptRjFkR2d1YVhWdGN5NWhZeTVwY2k4RGFXNTBCQUlBQWc9PXy6_ipNmkAWnMVo1i9sauTFWUMdca2Yxncn-1-r13m4Zg==] X-Forwarded-Proto:[https] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] X-Request-Time:[1581072182.080] X-Aasaam-Geo-Default-Lang-Direction:[ltr] X-Aasaam-Geo-Country-Flag:[🌐] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] X-Forwarded-Host:[vouch.example.tld] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Port:[443] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Aasaam-Agent-Category:[pc] Accept-Language:[en-US,en;q=0.5] X-Request-Id:[0a9c708be2349d187d7ffbb3622fdc07]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:49988 /auth?code=pQsdRgx81UmttR9DQRsFow.zPsKg7qr1wjQABXpUCfyHFQE92g.rDAu1DXoCemTFLp9O1TPEAbeK4Ya1gAwFoxuyVRobajx2XOHUPa4GvgcsFU0TTt_fBfNN7nJwq7eyBNmP8rxVzqEP_lEEZfu8icwjr3Nyyg54vLC6qAwc5WeRES9TAGKlThyyoiMp5jXhHHISOqBpe1tqz89B5sErQfCaeJaQenGbaYeV-OBo6kStNyDpe2ax2fZe5pysH7_JiMKXDA3fNXymLsMmF2j_Sx336kljsrRZ1tmiTfW-e14rPnhAPrKZFM_AGrPEbh2y8xlzcIUrS9i9rJYzN3UlHPQomPkVHf2Ei8fXo-yuPlqOZ4jJNCr8ck3_3wzQJimtLf3mP48Tg&state=wjziccg3g2vN1fbCPK7M41YeB1mdtX3 <nil> <nil> <nil> 0xc4203d1050}"}
{"level":"debug","ts":1581072182.08114,"msg":"/auth"}
{"level":"debug","ts":1581072182.0815535,"msg":"code: pQsdRgx81UmttR9DQRsFow.zPsKg7qr1wjQABXpUCfyHFQE92g.rDAu1DXoCemTFLp9O1TPEAbeK4Ya1gAwFoxuyVRobajx2XOHUPa4GvgcsFU0TTt_fBfNN7nJwq7eyBNmP8rxVzqEP_lEEZfu8icwjr3Nyyg54vLC6qAwc5WeRES9TAGKlThyyoiMp5jXhHHISOqBpe1tqz89B5sErQfCaeJaQenGbaYeV-OBo6kStNyDpe2ax2fZe5pysH7_JiMKXDA3fNXymLsMmF2j_Sx336kljsrRZ1tmiTfW-e14rPnhAPrKZFM_AGrPEbh2y8xlzcIUrS9i9rJYzN3UlHPQomPkVHf2Ei8fXo-yuPlqOZ4jJNCr8ck3_3wzQJimtLf3mP48Tg"}
{"level":"error","ts":1581072182.0948544,"msg":"jws: invalid token received"}
{"level":"debug","ts":1581072182.0949228,"msg":"/auth Claims from userinfo: {Claims:map[]}"}
{"level":"debug","ts":1581072182.0949426,"msg":"/auth CallbackHandler"}
{"level":"debug","ts":1581072182.094957,"msg":"/auth {Username: Name: Email: CreatedOn:0 LastUpdate:0 ID:0}"}
{"level":"debug","ts":1581072182.094965,"msg":"skipping verify user since cfg.Cfg.AllowAllUsers is true"}
{"level":"debug","ts":1581072182.0949965,"msg":"new user.. setting created on to 1581072182"}
{"level":"error","ts":1581072182.0950387,"msg":"key required"}
{"level":"error","ts":1581072182.0950627,"msg":"key required"}
{"level":"debug","ts":1581072182.0950954,"msg":"token: &{ 0xc42018e060 map[typ:JWT alg:HS256] { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090182 0 Vouch 0 }} false}"}
{"level":"debug","ts":1581072182.0951066,"msg":"token expires: 1581090182"}
{"level":"debug","ts":1581072182.0951138,"msg":"diff from now: 18000"}
{"level":"debug","ts":1581072182.0951939,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072182.095208,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.0953398,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072182.0953636,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072182.0953734,"msg":"|302| 14.229201ms /auth","statusCode":302,"request":10,"latency":0.014229201,"avgLatency":0.011513163,"ipPort":"127.0.0.1:49988","method":"GET","host":"vouch.example.tld","path":"/auth","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.189318,"msg":"Request received : &{GET /validate HTTP/1.0 1 0 map[X-Request-Id:[5bd69bb390483d1b58b96c91560cb091] X-Forwarded-For:[xxx.xxx.64.31] X-Forwarded-Host:[app.example.tld] X-Forwarded-Port:[443] Connection:[close] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Accept-Encoding:[gzip, deflate, br] Upgrade-Insecure-Requests:[1] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q] X-Real-Ip:[xxx.xxx.64.31] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Referer:[https://adfs.example.tld/] Dnt:[1] X-Forwarded-Proto:[https] X-Request-Time:[1581072182.188] X-Aasaam-Client-Id:[aasaam_cid=000000005E3D3F309522000C13D99701] X-Aasaam-Client-New:[1] Accept-Language:[en-US,en;q=0.5]] {} <nil> 0 [] true app.example.tld map[] map[] <nil> map[] 127.0.0.1:49992 /validate <nil> <nil> <nil> 0xc4203d1bf0}"}
{"level":"debug","ts":1581072182.1894073,"msg":"/validate"}
{"level":"debug","ts":1581072182.1894279,"msg":"jwt from cookie: eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q"}
{"level":"debug","ts":1581072182.1894724,"msg":"tokenString eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q"}
{"level":"debug","ts":1581072182.1896584,"msg":"*ptokenCLaims: { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090182 0 Vouch 0 }}"}
{"level":"debug","ts":1581072182.1897,"msg":"JWT Claims: {Username: Sites:[app.example.tld vouch.example.tld adfs.example.tld example.tld] CustomClaims:map[] PAccessToken: PIdToken: StandardClaims:{Audience: ExpiresAt:1581090182 Id: IssuedAt:0 Issuer:Vouch NotBefore:0 Subject:}}"}
{"level":"error","ts":1581072182.18974,"msg":"no Username found in jwt"}
{"level":"debug","ts":1581072182.1897655,"msg":"domain app.example.tld matched array value at [0]=app.example.tld"}
{"level":"debug","ts":1581072182.189775,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.1897826,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072182.1897979,"msg":"CaptureWriter.Write set w.StatusCode 401"}
{"level":"debug","ts":1581072182.1898475,"msg":"Request handled successfully: 401"}
{"level":"info","ts":1581072182.189861,"msg":"|401| 442.056µs /validate","statusCode":401,"request":11,"latency":0.000442056,"avgLatency":0.010506699,"ipPort":"127.0.0.1:49992","method":"GET","host":"app.example.tld","path":"/validate","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.2607148,"msg":"Request received : &{GET /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= HTTP/1.0 1 0 map[User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MnxEdi1CQkFFQ180SUFBUkFCRUFBQV80M19nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01JUUFmZDJwNmFXTmpaek5uTW5aT01XWmlRMUJMTjAwME1WbGxRakZ0WkhSWU13WnpkSEpwYm1jTURnQU1jbVZ4ZFdWemRHVmtWVkpNQm5OMGNtbHVad3dDQUFBR2MzUnlhVzVuREJ3QUdtaDBkSEJ6T2k4dmFXWmhkWFJvTG1sMWJYTXVZV011YVhJdkEybHVkQVFDQUFBPXw7Y53lY5sUmsJo6_sBXonw4Ql9l-PevZYZqW0JP1b3YA==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q] X-Aasaam-Agent-Category:[pc] Dnt:[1] X-Forwarded-Proto:[https] X-Aasaam-Agent-Version:[72] X-Real-Ip:[xxx.xxx.64.31] X-Aasaam-Agent-Os:[linux] Connection:[close] X-Request-Id:[ddfbf259eb27d5cc2cb6f206d7d151d2] X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Agent-Hash:[fb8f0894] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Accept-Encoding:[gzip, deflate, br] X-Forwarded-Port:[443] X-Forwarded-Host:[vouch.example.tld] X-Aasaam-Agent-Name:[firefox] Referer:[https://adfs.example.tld/] X-Forwarded-For:[xxx.xxx.64.31] X-Aasaam-Agent-Vendor:[mozilla] X-Aasaam-Geo-Default-Lang-Direction:[ltr] Accept-Language:[en-US,en;q=0.5] X-Aasaam-Client-New:[0] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Aasaam-Geo-Country-Flag:[🌐] Upgrade-Insecure-Requests:[1] X-Request-Time:[1581072182.259]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:49994 /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= <nil> <nil> <nil> 0xc4203d1ef0}"}
{"level":"debug","ts":1581072182.26079,"msg":"/login"}
{"level":"debug","ts":1581072182.2610457,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072182.2610712,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.2611444,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072182.261604,"msg":"session state set to HL2oNIHcYUdRDGS1byjaHj84J0BdZ"}
{"level":"debug","ts":1581072182.2616377,"msg":"session requestedURL set to https://app.example.tld/"}
{"level":"debug","ts":1581072182.2616532,"msg":"failcount for https://app.example.tld/ is 0"}
{"level":"debug","ts":1581072182.2616642,"msg":"saving session"}
{"level":"debug","ts":1581072182.261778,"msg":"redirecting to oauthURL https://adfs.example.tld/adfs/oauth2/authorize/?client_id=9b31f91c-91da-47df-899f-e66c7b9cc2ef&redirect_uri=https%3A%2F%2Fvouch.example.tld%2Fauth&resource=https%3A%2F%2Fvouch.example.tld%2Fauth&response_type=code&scope=email+profile+openid&state=HL2oNIHcYUdRDGS1byjaHj84J0BdZ"}
{"level":"debug","ts":1581072182.2618215,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072182.2618525,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072182.2618718,"msg":"|302| 1.065543ms /login","statusCode":302,"request":12,"latency":0.001065543,"avgLatency":0.009719936,"ipPort":"127.0.0.1:49994","method":"GET","host":"vouch.example.tld","path":"/login","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.4657383,"msg":"Request received : &{GET /auth?code=pQsdRgx81UmttR9DQRsFow.0fhIg7qr1wjRABCO9-doR-Z_rr4.hy1u5ZGHjYU4wxbu7Zstve_QH8-L9gTSEMvHFO9-5UnjU3g_OhK1k2jqBmOTuPl-8WdmGbMYh96kPXk6De2fJNfzc7JwF0BXR9xIUGRu4rtDARmty03bfBHDyPEi7h94qIQW1QLD67cKXIE3yRBrTtvP2PBgENznD-uurOYAJFL6CWyOwa1KwtL_JNm0LDu-BTqMFkDsaCpB3f8JDUsKX60aTR5oatFd7b1mGrY79SGQKemwmfw6CdbP6BdY1PojcOmNPDr0jP0wn1hX-JgHwSywAWNKF40fbRhDVsSANXE8i1wmFAGeaexQsOYoqmUEnYC21rRCZzSZ6VlPU2hIAA&state=HL2oNIHcYUdRDGS1byjaHj84J0BdZ HTTP/1.0 1 0 map[X-Real-Ip:[xxx.xxx.64.31] X-Request-Id:[e6bbc4a5a19e5955584ae4c53a55f5a4] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Aasaam-Agent-Os:[linux] X-Aasaam-Agent-Vendor:[mozilla] X-Aasaam-Geo-Country-Flag:[🌐] Connection:[close] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] X-Forwarded-Proto:[https] X-Request-Time:[1581072182.463] Dnt:[1] X-Forwarded-Port:[443] X-Aasaam-Agent-Name:[firefox] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Accept-Encoding:[gzip, deflate, br] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MnxEdi1CQkFFQ180SUFBUkFCRUFBQV82WF9nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01Id0FkU0V3eWIwNUpTR05aVldSU1JFZFRNV0o1YW1GSWFqZzBTakJDWkZvR2MzUnlhVzVuREE0QURISmxjWFZsYzNSbFpGVlNUQVp6ZEhKcGJtY01IQUFhYUhSMGNITTZMeTlwWm1GMWRHZ3VhWFZ0Y3k1aFl5NXBjaThHYzNSeWFXNW5EQndBR21oMGRIQnpPaTh2YVdaaGRYUm9MbWwxYlhNdVlXTXVhWEl2QTJsdWRBUUNBQUk9fAZ3gCbgWjFSDejJhW7AsIQYoW5u9WPbn07aZ-pQTH1G] X-Forwarded-Host:[vouch.example.tld] X-Aasaam-Agent-Hash:[fb8f0894] Accept-Language:[en-US,en;q=0.5] Referer:[https://adfs.example.tld/] X-Forwarded-For:[xxx.xxx.64.31] X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Client-New:[0] X-Aasaam-Agent-Version:[72] X-Aasaam-Agent-Category:[pc] X-Aasaam-Geo-Default-Lang-Direction:[ltr] Upgrade-Insecure-Requests:[1]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:49998 /auth?code=pQsdRgx81UmttR9DQRsFow.0fhIg7qr1wjRABCO9-doR-Z_rr4.hy1u5ZGHjYU4wxbu7Zstve_QH8-L9gTSEMvHFO9-5UnjU3g_OhK1k2jqBmOTuPl-8WdmGbMYh96kPXk6De2fJNfzc7JwF0BXR9xIUGRu4rtDARmty03bfBHDyPEi7h94qIQW1QLD67cKXIE3yRBrTtvP2PBgENznD-uurOYAJFL6CWyOwa1KwtL_JNm0LDu-BTqMFkDsaCpB3f8JDUsKX60aTR5oatFd7b1mGrY79SGQKemwmfw6CdbP6BdY1PojcOmNPDr0jP0wn1hX-JgHwSywAWNKF40fbRhDVsSANXE8i1wmFAGeaexQsOYoqmUEnYC21rRCZzSZ6VlPU2hIAA&state=HL2oNIHcYUdRDGS1byjaHj84J0BdZ <nil> <nil> <nil> 0xc4200936e0}"}
{"level":"debug","ts":1581072182.4658966,"msg":"/auth"}
{"level":"debug","ts":1581072182.4662209,"msg":"code: pQsdRgx81UmttR9DQRsFow.0fhIg7qr1wjRABCO9-doR-Z_rr4.hy1u5ZGHjYU4wxbu7Zstve_QH8-L9gTSEMvHFO9-5UnjU3g_OhK1k2jqBmOTuPl-8WdmGbMYh96kPXk6De2fJNfzc7JwF0BXR9xIUGRu4rtDARmty03bfBHDyPEi7h94qIQW1QLD67cKXIE3yRBrTtvP2PBgENznD-uurOYAJFL6CWyOwa1KwtL_JNm0LDu-BTqMFkDsaCpB3f8JDUsKX60aTR5oatFd7b1mGrY79SGQKemwmfw6CdbP6BdY1PojcOmNPDr0jP0wn1hX-JgHwSywAWNKF40fbRhDVsSANXE8i1wmFAGeaexQsOYoqmUEnYC21rRCZzSZ6VlPU2hIAA"}
{"level":"error","ts":1581072182.4800913,"msg":"jws: invalid token received"}
{"level":"debug","ts":1581072182.4801428,"msg":"/auth Claims from userinfo: {Claims:map[]}"}
{"level":"debug","ts":1581072182.4801538,"msg":"/auth CallbackHandler"}
{"level":"debug","ts":1581072182.480171,"msg":"/auth {Username: Name: Email: CreatedOn:0 LastUpdate:0 ID:0}"}
{"level":"debug","ts":1581072182.4803364,"msg":"skipping verify user since cfg.Cfg.AllowAllUsers is true"}
{"level":"debug","ts":1581072182.480375,"msg":"new user.. setting created on to 1581072182"}
{"level":"error","ts":1581072182.4804235,"msg":"key required"}
{"level":"error","ts":1581072182.4804482,"msg":"key required"}
{"level":"debug","ts":1581072182.4804866,"msg":"token: &{ 0xc42018e060 map[typ:JWT alg:HS256] { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090182 0 Vouch 0 }} false}"}
{"level":"debug","ts":1581072182.4804983,"msg":"token expires: 1581090182"}
{"level":"debug","ts":1581072182.480506,"msg":"diff from now: 18000"}
{"level":"debug","ts":1581072182.4805603,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072182.4805803,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.4806747,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072182.480709,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072182.4807258,"msg":"|302| 14.81612ms /auth","statusCode":302,"request":13,"latency":0.01481612,"avgLatency":0.01011195,"ipPort":"127.0.0.1:49998","method":"GET","host":"vouch.example.tld","path":"/auth","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.5572476,"msg":"Request received : &{GET /validate HTTP/1.0 1 0 map[X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Host:[app.example.tld] X-Aasaam-Client-Id:[aasaam_cid=000000005E3D3F309522000C13D99701] X-Aasaam-Client-New:[1] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Accept-Encoding:[gzip, deflate, br] X-Forwarded-Port:[443] X-Forwarded-Proto:[https] X-Request-Time:[1581072182.556] Referer:[https://adfs.example.tld/] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q] X-Request-Id:[07bd9efbf5a29ce87c6d0ec18cacf54b] Connection:[close] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Accept-Language:[en-US,en;q=0.5] Dnt:[1] Upgrade-Insecure-Requests:[1] X-Forwarded-For:[xxx.xxx.64.31]] {} <nil> 0 [] true app.example.tld map[] map[] <nil> map[] 127.0.0.1:50006 /validate <nil> <nil> <nil> 0xc42018a210}"}
{"level":"debug","ts":1581072182.5573053,"msg":"/validate"}
{"level":"debug","ts":1581072182.55733,"msg":"jwt from cookie: eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q"}
{"level":"debug","ts":1581072182.5573459,"msg":"tokenString eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q"}
{"level":"debug","ts":1581072182.5575254,"msg":"*ptokenCLaims: { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090182 0 Vouch 0 }}"}
{"level":"debug","ts":1581072182.557558,"msg":"JWT Claims: {Username: Sites:[app.example.tld vouch.example.tld adfs.example.tld example.tld] CustomClaims:map[] PAccessToken: PIdToken: StandardClaims:{Audience: ExpiresAt:1581090182 Id: IssuedAt:0 Issuer:Vouch NotBefore:0 Subject:}}"}
{"level":"error","ts":1581072182.5575747,"msg":"no Username found in jwt"}
{"level":"debug","ts":1581072182.5575924,"msg":"domain app.example.tld matched array value at [0]=app.example.tld"}
{"level":"debug","ts":1581072182.5576036,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.5576127,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072182.5576386,"msg":"CaptureWriter.Write set w.StatusCode 401"}
{"level":"debug","ts":1581072182.5576692,"msg":"Request handled successfully: 401"}
{"level":"info","ts":1581072182.557837,"msg":"|401| 364.788µs /validate","statusCode":401,"request":14,"latency":0.000364788,"avgLatency":0.009415725,"ipPort":"127.0.0.1:50006","method":"GET","host":"app.example.tld","path":"/validate","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.6235878,"msg":"Request received : &{GET /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= HTTP/1.0 1 0 map[Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Accept-Encoding:[gzip, deflate, br] Dnt:[1] Upgrade-Insecure-Requests:[1] X-Forwarded-For:[xxx.xxx.64.31] X-Forwarded-Host:[vouch.example.tld] X-Aasaam-Agent-Category:[pc] X-Request-Id:[1c61e2dc96d472a03c5c1469eda1252e] X-Aasaam-Agent-Vendor:[mozilla] Referer:[https://adfs.example.tld/] Connection:[close] X-Forwarded-Port:[443] X-Aasaam-Geo-Default-Lang-Direction:[ltr] X-Aasaam-Geo-Country-Flag:[🌐] Accept-Language:[en-US,en;q=0.5] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MnxEdi1CQkFFQ180SUFBUkFCRUFBQV80dl9nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01Id0FkU0V3eWIwNUpTR05aVldSU1JFZFRNV0o1YW1GSWFqZzBTakJDWkZvR2MzUnlhVzVuREE0QURISmxjWFZsYzNSbFpGVlNUQVp6ZEhKcGJtY01BZ0FBQm5OMGNtbHVad3djQUJwb2RIUndjem92TDJsbVlYVjBhQzVwZFcxekxtRmpMbWx5THdOcGJuUUVBZ0FBfCsGD6wVA7LZmZVm59qXWcdaVk1J5OC8VjyWculEM7qD; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q] X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Agent-Os:[linux] X-Aasaam-Agent-Hash:[fb8f0894] X-Request-Time:[1581072182.622] X-Aasaam-Client-New:[0] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Aasaam-Agent-Version:[72] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Proto:[https] X-Aasaam-Agent-Name:[firefox]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:50008 /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= <nil> <nil> <nil> 0xc42018a570}"}
{"level":"debug","ts":1581072182.6236465,"msg":"/login"}
{"level":"debug","ts":1581072182.6236618,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072182.6236675,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.6236718,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072182.6238804,"msg":"session state set to 5378Gn8x1fKqABNFa8YBA1JUzfUyqRk"}
{"level":"debug","ts":1581072182.6238964,"msg":"session requestedURL set to https://app.example.tld/"}
{"level":"debug","ts":1581072182.6239026,"msg":"failcount for https://app.example.tld/ is 0"}
{"level":"debug","ts":1581072182.6239073,"msg":"saving session"}
{"level":"debug","ts":1581072182.6241894,"msg":"redirecting to oauthURL https://adfs.example.tld/adfs/oauth2/authorize/?client_id=9b31f91c-91da-47df-899f-e66c7b9cc2ef&redirect_uri=https%3A%2F%2Fvouch.example.tld%2Fauth&resource=https%3A%2F%2Fvouch.example.tld%2Fauth&response_type=code&scope=email+profile+openid&state=5378Gn8x1fKqABNFa8YBA1JUzfUyqRk"}
{"level":"debug","ts":1581072182.6242144,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072182.6242292,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072182.6242383,"msg":"|302| 584.855µs /login","statusCode":302,"request":15,"latency":0.000584855,"avgLatency":0.008827001,"ipPort":"127.0.0.1:50008","method":"GET","host":"vouch.example.tld","path":"/login","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.8485487,"msg":"Request received : &{GET /auth?code=pQsdRgx81UmttR9DQRsFow.rZOEg7qr1wjSAIsEqqJ-Tezg1OQ.mPA_xzNsGGo9PQMoJxZOEcnnVvY0s037cDS9OR_nvxW312S_QZTNsUQfgFlesvZqE8b1UT1uToEcjeGrDjCgWn2srpQwaJhXCpcDfCYN6I5J7_xdoRWrcm8BgGphN9TdmQQBRLkHRTMNcBvWFDBJ2e5vy7ncdyVulTvMHNz_OyaB1Wvmf4aSKJoyiYwHWkgrOk1-7509HCwLRws7RDQyDX2mXUMfzk0K8_vExu7UQuGicGGwow0XcQk5tdD1azAEe2si3P1GuaAzkInKAtXDi8OF1yZVEAQUOxiX7vcrcht4GfxDpGvlww9yXk9LIY3xswxNJkSg4phLu30L0rV7Pg&state=5378Gn8x1fKqABNFa8YBA1JUzfUyqRk HTTP/1.0 1 0 map[X-Aasaam-Agent-Category:[pc] X-Aasaam-Agent-Vendor:[mozilla] X-Aasaam-Agent-Hash:[fb8f0894] Accept-Encoding:[gzip, deflate, br] X-Request-Time:[1581072182.847] Accept-Language:[en-US,en;q=0.5] Dnt:[1] X-Forwarded-Host:[vouch.example.tld] X-Aasaam-Agent-Os:[linux] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Port:[443] X-Aasaam-Agent-Version:[72] Referer:[https://adfs.example.tld/] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MnxEdi1CQkFFQ180SUFBUkFCRUFBQV82Zl9nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01JUUFmTlRNM09FZHVPSGd4Wmt0eFFVSk9SbUU0V1VKQk1VcFZlbVpWZVhGU2F3WnpkSEpwYm1jTURnQU1jbVZ4ZFdWemRHVmtWVkpNQm5OMGNtbHVad3djQUJwb2RIUndjem92TDJsbVlYVjBhQzVwZFcxekxtRmpMbWx5THdaemRISnBibWNNSEFBYWFIUjBjSE02THk5cFptRjFkR2d1YVhWdGN5NWhZeTVwY2k4RGFXNTBCQUlBQWc9PXw3U-_kDgguGabZLHDzLWLEtrnQd9xqtG4tuN709KmSQQ==] X-Request-Id:[653d11569aba0ed684478dea26cc849e] Upgrade-Insecure-Requests:[1] X-Aasaam-Agent-Name:[firefox] Connection:[close] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] X-Forwarded-For:[xxx.xxx.64.31] X-Aasaam-Geo-Default-Lang-Direction:[ltr] X-Aasaam-Geo-Country-Flag:[🌐] X-Aasaam-Client-New:[0] X-Aasaam-Client-Id:[b85c1cd1] X-Forwarded-Proto:[https]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:50018 /auth?code=pQsdRgx81UmttR9DQRsFow.rZOEg7qr1wjSAIsEqqJ-Tezg1OQ.mPA_xzNsGGo9PQMoJxZOEcnnVvY0s037cDS9OR_nvxW312S_QZTNsUQfgFlesvZqE8b1UT1uToEcjeGrDjCgWn2srpQwaJhXCpcDfCYN6I5J7_xdoRWrcm8BgGphN9TdmQQBRLkHRTMNcBvWFDBJ2e5vy7ncdyVulTvMHNz_OyaB1Wvmf4aSKJoyiYwHWkgrOk1-7509HCwLRws7RDQyDX2mXUMfzk0K8_vExu7UQuGicGGwow0XcQk5tdD1azAEe2si3P1GuaAzkInKAtXDi8OF1yZVEAQUOxiX7vcrcht4GfxDpGvlww9yXk9LIY3xswxNJkSg4phLu30L0rV7Pg&state=5378Gn8x1fKqABNFa8YBA1JUzfUyqRk <nil> <nil> <nil> 0xc42018ac60}"}
{"level":"debug","ts":1581072182.8486364,"msg":"/auth"}
{"level":"debug","ts":1581072182.8489027,"msg":"code: pQsdRgx81UmttR9DQRsFow.rZOEg7qr1wjSAIsEqqJ-Tezg1OQ.mPA_xzNsGGo9PQMoJxZOEcnnVvY0s037cDS9OR_nvxW312S_QZTNsUQfgFlesvZqE8b1UT1uToEcjeGrDjCgWn2srpQwaJhXCpcDfCYN6I5J7_xdoRWrcm8BgGphN9TdmQQBRLkHRTMNcBvWFDBJ2e5vy7ncdyVulTvMHNz_OyaB1Wvmf4aSKJoyiYwHWkgrOk1-7509HCwLRws7RDQyDX2mXUMfzk0K8_vExu7UQuGicGGwow0XcQk5tdD1azAEe2si3P1GuaAzkInKAtXDi8OF1yZVEAQUOxiX7vcrcht4GfxDpGvlww9yXk9LIY3xswxNJkSg4phLu30L0rV7Pg"}
{"level":"error","ts":1581072182.8634846,"msg":"jws: invalid token received"}
{"level":"debug","ts":1581072182.8635228,"msg":"/auth Claims from userinfo: {Claims:map[]}"}
{"level":"debug","ts":1581072182.8635333,"msg":"/auth CallbackHandler"}
{"level":"debug","ts":1581072182.8635483,"msg":"/auth {Username: Name: Email: CreatedOn:0 LastUpdate:0 ID:0}"}
{"level":"debug","ts":1581072182.8635576,"msg":"skipping verify user since cfg.Cfg.AllowAllUsers is true"}
{"level":"debug","ts":1581072182.8635874,"msg":"new user.. setting created on to 1581072182"}
{"level":"error","ts":1581072182.863629,"msg":"key required"}
{"level":"error","ts":1581072182.8636427,"msg":"key required"}
{"level":"debug","ts":1581072182.8636775,"msg":"token: &{ 0xc42018e060 map[alg:HS256 typ:JWT] { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090182 0 Vouch 0 }} false}"}
{"level":"debug","ts":1581072182.8636985,"msg":"token expires: 1581090182"}
{"level":"debug","ts":1581072182.8637066,"msg":"diff from now: 18000"}
{"level":"debug","ts":1581072182.8637724,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072182.8637857,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.8638828,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072182.8639026,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072182.863914,"msg":"|302| 15.269582ms /auth","statusCode":302,"request":16,"latency":0.015269582,"avgLatency":0.009229662,"ipPort":"127.0.0.1:50018","method":"GET","host":"vouch.example.tld","path":"/auth","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.9357314,"msg":"Request received : &{GET /validate HTTP/1.0 1 0 map[X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Host:[app.example.tld] Accept-Language:[en-US,en;q=0.5] Accept-Encoding:[gzip, deflate, br] Upgrade-Insecure-Requests:[1] X-Request-Id:[072a36828ed8026c1684a4eb5e594163] X-Request-Time:[1581072182.934] X-Aasaam-Client-Id:[aasaam_cid=000000005E3D3F309522000C13D99701] Connection:[close] Dnt:[1] X-Forwarded-Proto:[https] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q] X-Forwarded-For:[xxx.xxx.64.31] X-Forwarded-Port:[443] X-Aasaam-Client-New:[1] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] Referer:[https://adfs.example.tld/]] {} <nil> 0 [] true app.example.tld map[] map[] <nil> map[] 127.0.0.1:50022 /validate <nil> <nil> <nil> 0xc42001f0b0}"}
{"level":"debug","ts":1581072182.935779,"msg":"/validate"}
{"level":"debug","ts":1581072182.9358242,"msg":"jwt from cookie: eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q"}
{"level":"debug","ts":1581072182.93584,"msg":"tokenString eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q"}
{"level":"debug","ts":1581072182.9360352,"msg":"*ptokenCLaims: { [app.example.tld vouch.example.tld adfs.example.tld example.tld] map[] { 1581090182 0 Vouch 0 }}"}
{"level":"debug","ts":1581072182.9360952,"msg":"JWT Claims: {Username: Sites:[app.example.tld vouch.example.tld adfs.example.tld example.tld] CustomClaims:map[] PAccessToken: PIdToken: StandardClaims:{Audience: ExpiresAt:1581090182 Id: IssuedAt:0 Issuer:Vouch NotBefore:0 Subject:}}"}
{"level":"error","ts":1581072182.9361105,"msg":"no Username found in jwt"}
{"level":"debug","ts":1581072182.9361246,"msg":"domain app.example.tld matched array value at [0]=app.example.tld"}
{"level":"debug","ts":1581072182.9361331,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.93614,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072182.936195,"msg":"CaptureWriter.Write set w.StatusCode 401"}
{"level":"debug","ts":1581072182.9362135,"msg":"Request handled successfully: 401"}
{"level":"info","ts":1581072182.9362264,"msg":"|401| 435.097µs /validate","statusCode":401,"request":17,"latency":0.000435097,"avgLatency":0.008712335,"ipPort":"127.0.0.1:50022","method":"GET","host":"app.example.tld","path":"/validate","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072182.9903274,"msg":"Request received : &{GET /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= HTTP/1.0 1 0 map[Upgrade-Insecure-Requests:[1] X-Real-Ip:[xxx.xxx.64.31] X-Forwarded-Port:[443] X-Aasaam-Agent-Version:[72] X-Aasaam-Agent-Os:[linux] User-Agent:[Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:72.0) Gecko/20100101 Firefox/72.0] X-Forwarded-Proto:[https] X-Aasaam-Agent-Vendor:[mozilla] Connection:[close] Cookie:[aasaam_cid=AAAAADA/PV4MACKVAZfZEw==; VouchSession=MTU4MTA3MjE4MnxEdi1CQkFFQ180SUFBUkFCRUFBQV80M19nZ0FEQm5OMGNtbHVad3dIQUFWemRHRjBaUVp6ZEhKcGJtY01JUUFmTlRNM09FZHVPSGd4Wmt0eFFVSk9SbUU0V1VKQk1VcFZlbVpWZVhGU2F3WnpkSEpwYm1jTURnQU1jbVZ4ZFdWemRHVmtWVkpNQm5OMGNtbHVad3dDQUFBR2MzUnlhVzVuREJ3QUdtaDBkSEJ6T2k4dmFXWmhkWFJvTG1sMWJYTXVZV011YVhJdkEybHVkQVFDQUFBPXxa5nSLXKBtu9IM9t9-jJ-RoGoaVSZua-mQyxrAXZ7s1g==; VouchCookie=eyJhbGciOiJIUzI1NiIsInR5cCI6IkpXVCJ9.eyJ1c2VybmFtZSI6IiIsInNpdGVzIjpbImlmYXV0aC5pdW1zLmFjLmlyIiwidm91Y2guaXVtcy5hYy5pciIsImFkZnMuaXVtcy5hYy5pciIsIml1bXMuYWMuaXIiXSwiQ3VzdG9tQ2xhaW1zIjpudWxsLCJQQWNjZXNzVG9rZW4iOiIiLCJQSWRUb2tlbiI6IiIsImV4cCI6MTU4MTA5MDE4MiwiaXNzIjoiVm91Y2gifQ.gnqExLpIjatVfL6UUjRf-UarBZbClw0Ok04L-iCHs1Q] X-Forwarded-For:[xxx.xxx.64.31] X-Aasaam-Geo-Default-Lang-Direction:[ltr] Accept-Language:[en-US,en;q=0.5] Referer:[https://adfs.example.tld/] X-Aasaam-Agent-Name:[firefox] X-Aasaam-Agent-Hash:[fb8f0894] Accept:[text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8] X-Request-Id:[1f38d5abdb5ad7b7ea1d24aa7f0dd43e] X-Forwarded-Host:[vouch.example.tld] X-Request-Time:[1581072182.989] X-Aasaam-Client-Id:[b85c1cd1] X-Aasaam-Client-New:[0] X-Aasaam-Foreign-Referer-Host:[adfs.example.tld] X-Aasaam-Geo-Country-Flag:[🌐] X-Aasaam-Agent-Category:[pc] Accept-Encoding:[gzip, deflate, br] Dnt:[1]] {} <nil> 0 [] true vouch.example.tld map[] map[] <nil> map[] 127.0.0.1:50024 /login?url=https://app.example.tld/&vouch-failcount=&X-Vouch-Token=&error= <nil> <nil> <nil> 0xc42001f4d0}"}
{"level":"debug","ts":1581072182.9903874,"msg":"/login"}
{"level":"debug","ts":1581072182.9904065,"msg":"domain vouch.example.tld matched array value at [1]=vouch.example.tld"}
{"level":"debug","ts":1581072182.9904153,"msg":"setting the cookie domain to example.tld"}
{"level":"debug","ts":1581072182.990423,"msg":"deleting cookie: VouchCookie"}
{"level":"debug","ts":1581072182.9906218,"msg":"session state set to 19KuGgXRGKJoR2oVhoEL7RZXTaKMo80S"}
{"level":"debug","ts":1581072182.990643,"msg":"session requestedURL set to https://app.example.tld/"}
{"level":"debug","ts":1581072182.9906526,"msg":"failcount for https://app.example.tld/ is 0"}
{"level":"debug","ts":1581072182.9906607,"msg":"saving session"}
{"level":"debug","ts":1581072182.9907491,"msg":"redirecting to oauthURL https://adfs.example.tld/adfs/oauth2/authorize/?client_id=9b31f91c-91da-47df-899f-e66c7b9cc2ef&redirect_uri=https%3A%2F%2Fvouch.example.tld%2Fauth&resource=https%3A%2F%2Fvouch.example.tld%2Fauth&response_type=code&scope=email+profile+openid&state=19KuGgXRGKJoR2oVhoEL7RZXTaKMo80S"}
{"level":"debug","ts":1581072182.9907696,"msg":"CaptureWriter.Write set w.StatusCode 302"}
{"level":"debug","ts":1581072182.9907877,"msg":"Request handled successfully: 302"}
{"level":"info","ts":1581072182.9907992,"msg":"|302| 402.264µs /login","statusCode":302,"request":18,"latency":0.000402264,"avgLatency":0.008250665,"ipPort":"127.0.0.1:50024","method":"GET","host":"vouch.example.tld","path":"/login","referer":"https://adfs.example.tld/"}
{"level":"debug","ts":1581072238.0097332,"msg":"Request received : &{GET /healthcheck HTTP/1.1 1 1 map[User-Agent:[Go-http-client/1.1] Accept-Encoding:[gzip]] {} <nil> 0 [] false 0.0.0.0:19090 map[] map[] <nil> map[] 127.0.0.1:51946 /healthcheck <nil> <nil> <nil> 0xc42001fce0}"}
{"level":"debug","ts":1581072238.0098062,"msg":"CaptureWriter.Write set w.StatusCode 200"}
{"level":"debug","ts":1581072238.0098252,"msg":"Request handled successfully: 200"}
{"level":"info","ts":1581072238.0106122,"msg":"|200| 26.228µs /healthcheck","statusCode":200,"request":19,"latency":0.000026228,"avgLatency":0.0078178,"ipPort":"127.0.0.1:51946","method":"GET","host":"0.0.0.0:19090","path":"/healthcheck","referer":""}
{"level":"debug","ts":1581072298.3117113,"msg":"Request received : &{GET /healthcheck HTTP/1.1 1 1 map[User-Agent:[Go-http-client/1.1] Accept-Encoding:[gzip]] {} <nil> 0 [] false 0.0.0.0:19090 map[] map[] <nil> map[] 127.0.0.1:54362 /healthcheck <nil> <nil> <nil> 0xc4201a8360}"}
{"level":"debug","ts":1581072298.3117626,"msg":"CaptureWriter.Write set w.StatusCode 200"}
{"level":"debug","ts":1581072298.31179,"msg":"Request handled successfully: 200"}
{"level":"info","ts":1581072298.3118064,"msg":"|200| 45.994µs /healthcheck","statusCode":200,"request":20,"latency":0.000045994,"avgLatency":0.00742921,"ipPort":"127.0.0.1:54362","method":"GET","host":"0.0.0.0:19090","path":"/healthcheck","referer":""}
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment