Try   HackMD

LINE login via Spring Security OAuth

Google

2021-01-07 23:49:48.943 DEBUG 45392 --- [-nio-443-exec-3] o.a.coyote.http11.Http11InputBuffer      : Received [
	GET /login/oauth2/code/google?
		state=caxd_tfz6vzOzBQz_1EOPUWwOXam0Vr1sBwIB55iYoM%3D&
		code=4%2F0AY0e-g4FjYVBmnvOMO2Q_MIkJNLit4hHEZZvjWdqE2ifzykp-D1JRg4p3KtSEnkzuEMHYA&
		scope=email+profile+openid+https%3A%2F%2Fwww.googleapis.com%2Fauth%2Fuserinfo.email+https%3A%2F%2Fwww.googleapis.com%2Fauth%2Fuserinfo.profile&
		authuser=0&
		prompt=none
	HTTP/1.1

	Host: aecaea407068.ngrok.io
	User-Agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.16; rv:84.0) Gecko/20100101 Firefox/84.0
	Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8
	Accept-Encoding: gzip, deflate, br
	Accept-Language: en-US,en;q=0.5
	Cache-Control: no-cache
	Cookie: JSESSIONID=82A9A5D0D59595740CED1579EB9C6167
	Dnt: 1
	Pragma: no-cache
	Referer: https://accounts.google.com.tw/
	Te: trailers
	Upgrade-Insecure-Requests: 1
	X-Forwarded-For: 203.204.113.10
	X-Forwarded-Proto: https
]
2021-01-07 23:49:48.943 DEBUG 45392 --- [-nio-443-exec-3] o.a.t.util.http.Rfc6265CookieProcessor   : Cookies: Parsing b[]: JSESSIONID=82A9A5D0D59595740CED1579EB9C6167
2021-01-07 23:49:48.944 DEBUG 45392 --- [-nio-443-exec-3] o.a.catalina.connector.CoyoteAdapter     :  Requested cookie session id is 82A9A5D0D59595740CED1579EB9C6167
2021-01-07 23:49:48.944 DEBUG 45392 --- [-nio-443-exec-3] o.a.c.authenticator.AuthenticatorBase    : Security checking request GET /login/oauth2/code/google
2021-01-07 23:49:48.944 DEBUG 45392 --- [-nio-443-exec-3] org.apache.catalina.realm.RealmBase      :   No applicable constraints defined
2021-01-07 23:49:48.944 DEBUG 45392 --- [-nio-443-exec-3] o.a.c.authenticator.AuthenticatorBase    : Not subject to any constraint
2021-01-07 23:49:48.944 DEBUG 45392 --- [-nio-443-exec-3] o.apache.catalina.core.StandardWrapper   :   Returning non-STM instance
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.b.w.s.f.OrderedRequestContextFilter  : Bound request context to thread: org.apache.catalina.connector.RequestFacade@499acbe3
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Trying to match request against DefaultSecurityFilterChain [
	RequestMatcher=any request, Filters=[
		org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@4baac699,
		org.springframework.security.web.context.SecurityContextPersistenceFilter@54bdaee7,
		org.springframework.security.web.header.HeaderWriterFilter@2632a0a4,
		org.springframework.security.web.csrf.CsrfFilter@709c4118,
		org.springframework.security.web.authentication.logout.LogoutFilter@5b5207ee,
		org.springframework.security.oauth2.client.web.OAuth2AuthorizationRequestRedirectFilter@3443904c,
		org.springframework.security.oauth2.client.web.OAuth2AuthorizationRequestRedirectFilter@4f6fd12d,
		org.springframework.security.oauth2.client.web.OAuth2LoginAuthenticationFilter@3671781e,
		org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter@509b0d0a,
		org.springframework.security.web.authentication.ui.DefaultLogoutPageGeneratingFilter@76a6f67a,
		org.springframework.security.web.savedrequest.RequestCacheAwareFilter@4a183b5d,
		org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@791c953a,
		org.springframework.security.web.authentication.AnonymousAuthenticationFilter@47f1b73a,
		org.springframework.security.oauth2.client.web.OAuth2AuthorizationCodeGrantFilter@63c3eb5d,
		org.springframework.security.web.session.SessionManagementFilter@463bb3b9,
		org.springframework.security.web.access.ExceptionTranslationFilter@615fec89,
		org.springframework.security.web.access.intercept.FilterSecurityInterceptor@6619533e
	]
] (1/1)
2021-01-07 23:49:48.944 DEBUG 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Securing GET /login/oauth2/code/google?
	state=caxd_tfz6vzOzBQz_1EOPUWwOXam0Vr1sBwIB55iYoM%3D&
	code=4%2F0AY0e-g4FjYVBmnvOMO2Q_MIkJNLit4hHEZZvjWdqE2ifzykp-D1JRg4p3KtSEnkzuEMHYA&
	scope=email+profile+openid+https%3A%2F%2Fwww.googleapis.com%2Fauth%2Fuserinfo.email+https%3A%2F%2Fwww.googleapis.com%2Fauth%2Fuserinfo.profile&
	authuser=0&
	prompt=none
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Invoking WebAsyncManagerIntegrationFilter (1/17)
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Invoking SecurityContextPersistenceFilter (2/17)
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] w.c.HttpSessionSecurityContextRepository : Did not find SecurityContext in HttpSession 82A9A5D0D59595740CED1579EB9C6167 using the SPRING_SECURITY_CONTEXT session attribute
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] w.c.HttpSessionSecurityContextRepository : Created SecurityContextImpl [Null authentication]
2021-01-07 23:49:48.944 DEBUG 45392 --- [-nio-443-exec-3] s.s.w.c.SecurityContextPersistenceFilter : Set SecurityContextHolder to empty SecurityContext
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Invoking HeaderWriterFilter (3/17)
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Invoking CsrfFilter (4/17)
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.csrf.CsrfFilter         : Did not protect against CSRF since request did not match CsrfNotRequired [TRACE, HEAD, GET, OPTIONS]
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Invoking LogoutFilter (5/17)
2021-01-07 23:49:48.944 TRACE 45392 --- [-nio-443-exec-3] o.s.s.w.a.logout.LogoutFilter            : Did not match request to Ant [pattern='/logout', POST]
2021-01-07 23:49:48.945 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Invoking OAuth2AuthorizationRequestRedirectFilter (6/17)
2021-01-07 23:49:48.945 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Invoking OAuth2AuthorizationRequestRedirectFilter (7/17)
2021-01-07 23:49:48.945 TRACE 45392 --- [-nio-443-exec-3] o.s.security.web.FilterChainProxy        : Invoking OAuth2LoginAuthenticationFilter (8/17)
2021-01-07 23:49:48.945 DEBUG 45392 --- [-nio-443-exec-3] org.apache.tomcat.util.http.Parameters   : Set encoding to UTF-8
2021-01-07 23:49:48.945 DEBUG 45392 --- [-nio-443-exec-3] org.apache.tomcat.util.http.Parameters   : Decoding query null UTF-8
2021-01-07 23:49:48.945 DEBUG 45392 --- [-nio-443-exec-3] org.apache.tomcat.util.http.Parameters   : Start processing with input [
	state=caxd_tfz6vzOzBQz_1EOPUWwOXam0Vr1sBwIB55iYoM%3D&
	code=4%2F0AY0e-g4FjYVBmnvOMO2Q_MIkJNLit4hHEZZvjWdqE2ifzykp-D1JRg4p3KtSEnkzuEMHYA&
	scope=email+profile+openid+https%3A%2F%2Fwww.googleapis.com%2Fauth%2Fuserinfo.email+https%3A%2F%2Fwww.googleapis.com%2Fauth%2Fuserinfo.profile&
	authuser=0&
	prompt=none
]
2021-01-07 23:49:48.946 TRACE 45392 --- [-nio-443-exec-3] o.s.s.authentication.ProviderManager     : Authenticating request with OAuth2LoginAuthenticationProvider (1/4)
2021-01-07 23:49:48.946 TRACE 45392 --- [-nio-443-exec-3] o.s.s.authentication.ProviderManager     : Authenticating request with OidcAuthorizationCodeAuthenticationProvider (2/4)
2021-01-07 23:49:48.946 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : HTTP POST https://www.googleapis.com/oauth2/v4/token
2021-01-07 23:49:48.946 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : Accept=[application/json, application/*+json]
2021-01-07 23:49:48.946 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : Writing [{
	grant_type=[authorization_code],
	code=[4/0AY0e-g4FjYVBmnvOMO2Q_MIkJNLit4hHEZZvjWdqE2ifzykp-D1JRg4p3KtSEnkzuEMHYA],
	redirect_uri=[https://aecaea407068.ngrok.io/login/oauth2/code/google]
}] as "application/x-www-form-urlencoded;charset=UTF-8"
2021-01-07 23:49:48.946 TRACE 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : ProxySelector Request for https://www.googleapis.com/oauth2/v4/token
2021-01-07 23:49:48.946 TRACE 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : Looking for HttpClient for URL https://www.googleapis.com/oauth2/v4/token and proxy value of DIRECT
2021-01-07 23:49:48.946 TRACE 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : Creating new HttpsClient with url:https://www.googleapis.com/oauth2/v4/token and proxy:DIRECT with connect timeout:-1
2021-01-07 23:49:49.004 TRACE 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : Proxy used: DIRECT
2021-01-07 23:49:49.036 DEBUG 45392 --- [-nio-443-exec-3] jdk.event.security                       : X509Certificate: Alg:SHA256withRSA, Serial:dc4160d60d37e7740500000000830c2b, Subject:CN=upload.video.google.com, O=Google LLC, L=Mountain View, ST=California, C=US, Issuer:CN=GTS CA 1O1, O=Google Trust Services, C=US, Key type:EC, Length:256, Cert Id:34255342, Valid from:12/15/20, 10:47 PM, Valid until:3/9/21, 10:47 PM
2021-01-07 23:49:49.037 DEBUG 45392 --- [-nio-443-exec-3] jdk.event.security                       : X509Certificate: Alg:SHA256withRSA, Serial:1e3b49aa18d8aa981256950b8, Subject:CN=GTS CA 1O1, O=Google Trust Services, C=US, Issuer:CN=GlobalSign, O=GlobalSign, OU=GlobalSign Root CA - R2, Key type:RSA, Length:2048, Cert Id:1544128074, Valid from:6/15/17, 8:00 AM, Valid until:12/15/21, 8:00 AM
2021-01-07 23:49:49.039 DEBUG 45392 --- [-nio-443-exec-3] jdk.event.security                       : ValidationChain: 7087067, 1544128074, 34255342
2021-01-07 23:49:49.076 DEBUG 45392 --- [-nio-443-exec-3] jdk.event.security                       :  TLSHandshake: www.googleapis.com:443, TLSv1.2, TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256, 34255342
2021-01-07 23:49:49.077 DEBUG 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : sun.net.www.MessageHeader@68a78e0c8 pairs: {
	POST /oauth2/v4/token HTTP/1.1: null
	Accept: application/json;charset=UTF-8
	Content-Type: application/x-www-form-urlencoded;charset=UTF-8
	Authorization: Basic NDkwOTExMTYxMzM5LThmZmRua2g3cnIzdW5uNnJnNnZsMzVtbGo4aW5qbDFsLmFwcHMuZ29vZ2xldXNlcmNvbnRlbnQuY29tOjZvWTJtVGNUR3RObVZ4TVJtYzZPamR4dA==
	User-Agent: Java/11.0.9
	Host: www.googleapis.com
	Connection: keep-alive
	Content-Length: 192
}
2021-01-07 23:49:49.138 DEBUG 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : sun.net.www.MessageHeader@7f03d0c816 pairs: {
	null: HTTP/1.1 200 OK
	Pragma: no-cache
	Expires: Mon, 01 Jan 1990 00:00:00 GMT
	Cache-Control: no-cache, no-store, max-age=0, must-revalidate
	Date: Thu, 07 Jan 2021 15:49:49 GMT
	Content-Type: application/json; charset=utf-8
	Vary: X-Origin
	Vary: Referer
	Server: scaffolding on HTTPServer2
	X-XSS-Protection: 0
	X-Frame-Options: SAMEORIGIN
	X-Content-Type-Options: nosniff
	Alt-Svc:
		h3-29=":443";
		ma=2592000,h3-T051=":443";
		ma=2592000,h3-Q050=":443";
		ma=2592000,h3-Q046=":443";
		ma=2592000,h3-Q043=":443";
		ma=2592000,quic=":443";
		ma=2592000;
		v="46,43"
	Accept-Ranges: none
	Vary: Origin,Accept-Encoding
	Transfer-Encoding: chunked
}
2021-01-07 23:49:49.139 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : Response 200 OK
2021-01-07 23:49:49.139 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : Reading to [org.springframework.security.oauth2.core.endpoint.OAuth2AccessTokenResponse] as "application/json;charset=utf-8"
2021-01-07 23:49:49.145 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : HTTP GET https://www.googleapis.com/oauth2/v3/certs
2021-01-07 23:49:49.145 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : Accept=[text/plain, application/json, application/*+json, */*]
2021-01-07 23:49:49.145 TRACE 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : ProxySelector Request for https://www.googleapis.com/oauth2/v3/certs
2021-01-07 23:49:49.145 TRACE 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : Looking for HttpClient for URL https://www.googleapis.com/oauth2/v3/certs and proxy value of DIRECT
2021-01-07 23:49:49.145 TRACE 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : Creating new HttpsClient with url:https://www.googleapis.com/oauth2/v3/certs and proxy:DIRECT with connect timeout:-1
2021-01-07 23:49:49.170 TRACE 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : Proxy used: DIRECT
2021-01-07 23:49:49.203 DEBUG 45392 --- [-nio-443-exec-3] jdk.event.security                       : ValidationChain: 7087067, 1544128074, 34255342
2021-01-07 23:49:49.234 DEBUG 45392 --- [-nio-443-exec-3] jdk.event.security                       :  TLSHandshake: www.googleapis.com:443, TLSv1.2, TLS_ECDHE_ECDSA_WITH_AES_128_GCM_SHA256, 34255342
2021-01-07 23:49:49.235 DEBUG 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : sun.net.www.MessageHeader@3f1b429f5 pairs: {
	GET /oauth2/v3/certs HTTP/1.1: null
	Accept: application/json, application/jwk-set+json
	User-Agent: Java/11.0.9
	Host: www.googleapis.com
	Connection: keep-alive
}
2021-01-07 23:49:49.253 DEBUG 45392 --- [-nio-443-exec-3] s.n.www.protocol.http.HttpURLConnection  : sun.net.www.MessageHeader@4a8f828116 pairs: {
	null: HTTP/1.1 200 OK
	Date: Thu, 07 Jan 2021 15:49:21 GMT
	Expires: Thu, 07 Jan 2021 21:49:29 GMT
	Content-Type: application/json; charset=UTF-8
	Vary: X-Origin
	Vary: Referer
	Server: ESF
	X-XSS-Protection: 0
	X-Frame-Options: SAMEORIGIN
	X-Content-Type-Options: nosniff
	Cache-Control: public, max-age=21608, must-revalidate, no-transform
	Age: 28
	Alt-Svc:
		h3-29=":443";
		ma=2592000,h3-T051=":443";
		ma=2592000,h3-Q050=":443";
		ma=2592000,h3-Q046=":443";
		ma=2592000,h3-Q043=":443";
		ma=2592000,quic=":443";
		ma=2592000;
		v="46,43"
	Accept-Ranges: none
	Vary: Origin,Accept-Encoding
	Transfer-Encoding: chunked
}
2021-01-07 23:49:49.253 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : Response 200 OK
2021-01-07 23:49:49.253 DEBUG 45392 --- [-nio-443-exec-3] o.s.web.client.RestTemplate              : Reading to [java.lang.String] as "application/json;charset=UTF-8"
2021-01-07 23:49:49.286 TRACE 45392 --- [-nio-443-exec-3] s.CompositeSessionAuthenticationStrategy : Preparing session with ChangeSessionIdAuthenticationStrategy (1/2)
2021-01-07 23:49:49.286 DEBUG 45392 --- [-nio-443-exec-3] .s.ChangeSessionIdAuthenticationStrategy : Changed session id from 82A9A5D0D59595740CED1579EB9C6167
2021-01-07 23:49:49.287 TRACE 45392 --- [-nio-443-exec-3] o.s.b.f.s.DefaultListableBeanFactory     : Returning cached instance of singleton bean 'delegatingApplicationListener'
2021-01-07 23:49:49.287 TRACE 45392 --- [-nio-443-exec-3] o.s.b.f.s.DefaultListableBeanFactory     : Returning cached instance of singleton bean 'liveReloadServerEventListener'
2021-01-07 23:49:49.287 TRACE 45392 --- [-nio-443-exec-3] s.CompositeSessionAuthenticationStrategy : Preparing session with CsrfAuthenticationStrategy (2/2)
2021-01-07 23:49:49.288 DEBUG 45392 --- [-nio-443-exec-3] .s.o.c.w.OAuth2LoginAuthenticationFilter : Set SecurityContextHolder to OAuth2AuthenticationToken [
	Principal=Name: [104514270174761409755],
	Granted Authorities: [
		[
			ROLE_USER,
			SCOPE_https://www.googleapis.com/auth/userinfo.email,
			SCOPE_https://www.googleapis.com/auth/userinfo.profile,
			SCOPE_openid
		]
	],
	User Attributes: [
		{
			at_hash=nDMOIHzTMsncSVwIc0UtMw,
			sub=104514270174761409755,
			email_verified=true,
			iss=https://accounts.google.com,
			given_name=Jin-Hua,
			locale=en,
			nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg,
			picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c,
			aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com],
			azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com,
			name=Jin-Hua Qiu,
			exp=2021-01-07T16:49:49Z,
			family_name=Qiu,
			iat=2021-01-07T15:49:49Z,
			email=lifelink.com.tw@gmail.com
		}
	],
	Credentials=[PROTECTED],
	Authenticated=true,
	Details=WebAuthenticationDetails [
		RemoteIpAddress=0:0:0:0:0:0:0:1,
		SessionId=82A9A5D0D59595740CED1579EB9C6167
	],
	Granted Authorities=[
		ROLE_USER,
		SCOPE_https://www.googleapis.com/auth/userinfo.email,
		SCOPE_https://www.googleapis.com/auth/userinfo.profile,
		SCOPE_openid
	]
]
2021-01-07 23:49:49.288 TRACE 45392 --- [-nio-443-exec-3] o.s.b.f.s.DefaultListableBeanFactory     : Returning cached instance of singleton bean 'delegatingApplicationListener'
2021-01-07 23:49:49.288 TRACE 45392 --- [-nio-443-exec-3] o.s.b.f.s.DefaultListableBeanFactory     : Returning cached instance of singleton bean 'liveReloadServerEventListener'
2021-01-07 23:49:49.288 DEBUG 45392 --- [-nio-443-exec-3] o.s.s.web.DefaultRedirectStrategy        : Redirecting to https://aecaea407068.ngrok.io/login?logout
2021-01-07 23:49:49.288 DEBUG 45392 --- [-nio-443-exec-3] w.c.HttpSessionSecurityContextRepository : Stored SecurityContextImpl [
	Authentication=OAuth2AuthenticationToken [
		Principal=Name: [104514270174761409755],
		Granted Authorities: [
			[
				ROLE_USER,
				SCOPE_https://www.googleapis.com/auth/userinfo.email,
				SCOPE_https://www.googleapis.com/auth/userinfo.profile,
				SCOPE_openid
			]
		],
		User Attributes: [
			{
				at_hash=nDMOIHzTMsncSVwIc0UtMw,
				sub=104514270174761409755,
				email_verified=true,
				iss=https://accounts.google.com,
				given_name=Jin-Hua,
				locale=en,
				nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg,
				picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c,
				aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com],
				azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com,
				name=Jin-Hua Qiu,
				exp=2021-01-07T16:49:49Z,
				family_name=Qiu,
				iat=2021-01-07T15:49:49Z,
				email=lifelink.com.tw@gmail.com
			}
		],
		Credentials=[PROTECTED],
		Authenticated=true,
		Details=WebAuthenticationDetails [
			RemoteIpAddress=0:0:0:0:0:0:0:1,
			SessionId=82A9A5D0D59595740CED1579EB9C6167
		],
		Granted Authorities=[
			ROLE_USER,
			SCOPE_https://www.googleapis.com/auth/userinfo.email,
			SCOPE_https://www.googleapis.com/auth/userinfo.profile,
			SCOPE_openid
		]
	]
] to HttpSession [org.apache.catalina.session.StandardSessionFacade@5898f5de]
2021-01-07 23:49:49.288 DEBUG 45392 --- [-nio-443-exec-3] s.s.w.c.SecurityContextPersistenceFilter : Cleared SecurityContextHolder to complete request
2021-01-07 23:49:49.288 TRACE 45392 --- [-nio-443-exec-3] o.s.b.w.s.f.OrderedRequestContextFilter  : Cleared thread-bound request context: org.apache.catalina.connector.RequestFacade@499acbe3
2021-01-07 23:49:49.289 DEBUG 45392 --- [-nio-443-exec-3] o.a.coyote.http11.Http11InputBuffer      : Before fill(): [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position() [0]
2021-01-07 23:49:49.289 DEBUG 45392 --- [-nio-443-exec-3] o.a.tomcat.util.net.SocketWrapperBase    : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Read from buffer: [0]
2021-01-07 23:49:49.289 DEBUG 45392 --- [-nio-443-exec-3] org.apache.tomcat.util.net.NioEndpoint   : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Read direct from socket: [0]
2021-01-07 23:49:49.289 DEBUG 45392 --- [-nio-443-exec-3] o.a.coyote.http11.Http11InputBuffer      : Received []
2021-01-07 23:49:49.289 DEBUG 45392 --- [-nio-443-exec-3] o.apache.coyote.http11.Http11Processor   : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Status in: [OPEN_READ], State out: [OPEN]
2021-01-07 23:49:49.289 DEBUG 45392 --- [-nio-443-exec-3] org.apache.tomcat.util.net.NioEndpoint   : Registered read interest for [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]]
2021-01-07 23:49:49.289 DEBUG 45392 --- [43-ClientPoller] org.apache.tomcat.util.net.NioEndpoint   : timeout completed: keys processed=1; now=1610034589289; nextExpiration=1610034589148; keyCount=0; hasEvents=true; eval=false
2021-01-07 23:49:49.726 DEBUG 45392 --- [-nio-443-exec-4] o.a.coyote.http11.Http11InputBuffer      : Before fill(): [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position() [0]
2021-01-07 23:49:49.726 DEBUG 45392 --- [-nio-443-exec-4] o.a.tomcat.util.net.SocketWrapperBase    : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Read from buffer: [0]
2021-01-07 23:49:49.726 DEBUG 45392 --- [-nio-443-exec-4] org.apache.tomcat.util.net.NioEndpoint   : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Read direct from socket: [557]
2021-01-07 23:49:49.726 DEBUG 45392 --- [-nio-443-exec-4] o.a.coyote.http11.Http11InputBuffer      : Received [GET /login?logout HTTP/1.1
Host: aecaea407068.ngrok.io
User-Agent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.16; rv:84.0) Gecko/20100101 Firefox/84.0
Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8
Accept-Encoding: gzip, deflate, br
Accept-Language: en-US,en;q=0.5
Cache-Control: no-cache
Cookie: JSESSIONID=B69EC659825F1966870DA337996A2302
Dnt: 1
Pragma: no-cache
Referer: https://accounts.google.com.tw/
Te: trailers
Upgrade-Insecure-Requests: 1
X-Forwarded-For: 203.204.113.10
X-Forwarded-Proto: https

]
2021-01-07 23:49:49.726 DEBUG 45392 --- [-nio-443-exec-4] o.a.t.util.http.Rfc6265CookieProcessor   : Cookies: Parsing b[]: JSESSIONID=B69EC659825F1966870DA337996A2302
2021-01-07 23:49:49.726 DEBUG 45392 --- [-nio-443-exec-4] o.a.catalina.connector.CoyoteAdapter     :  Requested cookie session id is B69EC659825F1966870DA337996A2302
2021-01-07 23:49:49.726 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.authenticator.AuthenticatorBase    : Security checking request GET /login
2021-01-07 23:49:49.726 DEBUG 45392 --- [-nio-443-exec-4] org.apache.catalina.realm.RealmBase      :   No applicable constraints defined
2021-01-07 23:49:49.727 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.authenticator.AuthenticatorBase    : Not subject to any constraint
2021-01-07 23:49:49.727 DEBUG 45392 --- [-nio-443-exec-4] o.apache.catalina.core.StandardWrapper   :   Returning non-STM instance
2021-01-07 23:49:49.727 TRACE 45392 --- [-nio-443-exec-4] o.s.b.w.s.f.OrderedRequestContextFilter  : Bound request context to thread: org.apache.catalina.connector.RequestFacade@499acbe3
2021-01-07 23:49:49.727 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Trying to match request against DefaultSecurityFilterChain [RequestMatcher=any request, Filters=[org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@4baac699, org.springframework.security.web.context.SecurityContextPersistenceFilter@54bdaee7, org.springframework.security.web.header.HeaderWriterFilter@2632a0a4, org.springframework.security.web.csrf.CsrfFilter@709c4118, org.springframework.security.web.authentication.logout.LogoutFilter@5b5207ee, org.springframework.security.oauth2.client.web.OAuth2AuthorizationRequestRedirectFilter@3443904c, org.springframework.security.oauth2.client.web.OAuth2AuthorizationRequestRedirectFilter@4f6fd12d, org.springframework.security.oauth2.client.web.OAuth2LoginAuthenticationFilter@3671781e, org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter@509b0d0a, org.springframework.security.web.authentication.ui.DefaultLogoutPageGeneratingFilter@76a6f67a, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@4a183b5d, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@791c953a, org.springframework.security.web.authentication.AnonymousAuthenticationFilter@47f1b73a, org.springframework.security.oauth2.client.web.OAuth2AuthorizationCodeGrantFilter@63c3eb5d, org.springframework.security.web.session.SessionManagementFilter@463bb3b9, org.springframework.security.web.access.ExceptionTranslationFilter@615fec89, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@6619533e]] (1/1)
2021-01-07 23:49:49.727 DEBUG 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Securing GET /login?logout
2021-01-07 23:49:49.727 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking WebAsyncManagerIntegrationFilter (1/17)
2021-01-07 23:49:49.727 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking SecurityContextPersistenceFilter (2/17)
2021-01-07 23:49:49.727 TRACE 45392 --- [-nio-443-exec-4] w.c.HttpSessionSecurityContextRepository : Retrieved SecurityContextImpl [
	Authentication=OAuth2AuthenticationToken [
		Principal=Name: [104514270174761409755],
		Granted Authorities: [
			[
				ROLE_USER,
				SCOPE_https://www.googleapis.com/auth/userinfo.email,
				SCOPE_https://www.googleapis.com/auth/userinfo.profile,
				SCOPE_openid
			]
		],
		User Attributes: [
			{
				at_hash=nDMOIHzTMsncSVwIc0UtMw,
				sub=104514270174761409755,
				email_verified=true,
				iss=https://accounts.google.com,
				given_name=Jin-Hua,
				locale=en,
				nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg,
				picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c,
				aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com],
				azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com,
				name=Jin-Hua Qiu,
				exp=2021-01-07T16:49:49Z,
				family_name=Qiu,
				iat=2021-01-07T15:49:49Z,
				email=lifelink.com.tw@gmail.com
			}
		],
		Credentials=[PROTECTED],
		Authenticated=true,
		Details=WebAuthenticationDetails [
			RemoteIpAddress=0:0:0:0:0:0:0:1,
			SessionId=82A9A5D0D59595740CED1579EB9C6167
		],
		Granted Authorities=[
			ROLE_USER,
			SCOPE_https://www.googleapis.com/auth/userinfo.email,
			SCOPE_https://www.googleapis.com/auth/userinfo.profile,
			SCOPE_openid
		]
	]
] from SPRING_SECURITY_CONTEXT
2021-01-07 23:49:49.727 DEBUG 45392 --- [-nio-443-exec-4] s.s.w.c.SecurityContextPersistenceFilter : Set SecurityContextHolder to SecurityContextImpl [
	Authentication=OAuth2AuthenticationToken [
		Principal=Name: [104514270174761409755],
		Granted Authorities: [
			[
				ROLE_USER,
				SCOPE_https://www.googleapis.com/auth/userinfo.email,
				SCOPE_https://www.googleapis.com/auth/userinfo.profile,
				SCOPE_openid
			]
		],
		User Attributes: [
			{
				at_hash=nDMOIHzTMsncSVwIc0UtMw,
				sub=104514270174761409755,
				email_verified=true,
				iss=https://accounts.google.com,
				given_name=Jin-Hua,
				locale=en,
				nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg,
				picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c,
				aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com],
				azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com,
				name=Jin-Hua Qiu,
				exp=2021-01-07T16:49:49Z,
				family_name=Qiu,
				iat=2021-01-07T15:49:49Z,
				email=lifelink.com.tw@gmail.com
			}
		],
		Credentials=[PROTECTED],
		Authenticated=true,
		Details=WebAuthenticationDetails [
			RemoteIpAddress=0:0:0:0:0:0:0:1,
			SessionId=82A9A5D0D59595740CED1579EB9C6167
		],
		Granted Authorities=[
			ROLE_USER,
			SCOPE_https://www.googleapis.com/auth/userinfo.email,
			SCOPE_https://www.googleapis.com/auth/userinfo.profile,
			SCOPE_openid
		]
	]
]
2021-01-07 23:49:49.727 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking HeaderWriterFilter (3/17)
2021-01-07 23:49:49.727 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking CsrfFilter (4/17)
2021-01-07 23:49:49.727 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.csrf.CsrfFilter         : Did not protect against CSRF since request did not match CsrfNotRequired [TRACE, HEAD, GET, OPTIONS]
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking LogoutFilter (5/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.a.logout.LogoutFilter            : Did not match request to Ant [pattern='/logout', POST]
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking OAuth2AuthorizationRequestRedirectFilter (6/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking OAuth2AuthorizationRequestRedirectFilter (7/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking OAuth2LoginAuthenticationFilter (8/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] .s.o.c.w.OAuth2LoginAuthenticationFilter : Did not match request to Ant [pattern='/login/oauth2/code/*']
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking DefaultLoginPageGeneratingFilter (9/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking DefaultLogoutPageGeneratingFilter (10/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] .w.a.u.DefaultLogoutPageGeneratingFilter : Did not render default logout page since request did not match [Ant [pattern='/logout', GET]]
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking RequestCacheAwareFilter (11/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.s.HttpSessionRequestCache        : Removing DefaultSavedRequest from session if present
2021-01-07 23:49:49.728 DEBUG 45392 --- [-nio-443-exec-4] o.s.s.w.s.HttpSessionRequestCache        : Loaded matching saved request https://aecaea407068.ngrok.io/login?logout
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking SecurityContextHolderAwareRequestFilter (12/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking AnonymousAuthenticationFilter (13/17)
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.a.AnonymousAuthenticationFilter  : Did not set SecurityContextHolder since already authenticated OAuth2AuthenticationToken [Principal=Name: [104514270174761409755], Granted Authorities: [[ROLE_USER, SCOPE_https://www.googleapis.com/auth/userinfo.email, SCOPE_https://www.googleapis.com/auth/userinfo.profile, SCOPE_openid]], User Attributes: [{at_hash=nDMOIHzTMsncSVwIc0UtMw, sub=104514270174761409755, email_verified=true, iss=https://accounts.google.com, given_name=Jin-Hua, locale=en, nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg, picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c, aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com], azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com, name=Jin-Hua Qiu, exp=2021-01-07T16:49:49Z, family_name=Qiu, iat=2021-01-07T15:49:49Z, email=lifelink.com.tw@gmail.com}], Credentials=[PROTECTED], Authenticated=true, Details=WebAuthenticationDetails [RemoteIpAddress=0:0:0:0:0:0:0:1, SessionId=82A9A5D0D59595740CED1579EB9C6167], Granted Authorities=[ROLE_USER, SCOPE_https://www.googleapis.com/auth/userinfo.email, SCOPE_https://www.googleapis.com/auth/userinfo.profile, SCOPE_openid]]
2021-01-07 23:49:49.728 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking OAuth2AuthorizationCodeGrantFilter (14/17)
2021-01-07 23:49:49.728 DEBUG 45392 --- [-nio-443-exec-4] org.apache.tomcat.util.http.Parameters   : Set encoding to UTF-8
2021-01-07 23:49:49.729 DEBUG 45392 --- [-nio-443-exec-4] org.apache.tomcat.util.http.Parameters   : Decoding query null UTF-8
2021-01-07 23:49:49.729 DEBUG 45392 --- [-nio-443-exec-4] org.apache.tomcat.util.http.Parameters   : Start processing with input [logout]
2021-01-07 23:49:49.729 DEBUG 45392 --- [-nio-443-exec-4] org.apache.tomcat.util.http.Parameters   : Parameter starting at position [0] and ending at position [6] with a value of [logout] was not followed by an '=' character
2021-01-07 23:49:49.729 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking SessionManagementFilter (15/17)
2021-01-07 23:49:49.729 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking ExceptionTranslationFilter (16/17)
2021-01-07 23:49:49.729 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking FilterSecurityInterceptor (17/17)
2021-01-07 23:49:49.729 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.a.i.FilterSecurityInterceptor    : Did not re-authenticate
	OAuth2AuthenticationToken [Principal=Name: [104514270174761409755],
	Granted Authorities: [
		[
			ROLE_USER,
			SCOPE_https://www.googleapis.com/auth/userinfo.email,
			SCOPE_https://www.googleapis.com/auth/userinfo.profile,
			SCOPE_openid
		]
	],
	User Attributes: [
		{
			at_hash=nDMOIHzTMsncSVwIc0UtMw,
			sub=104514270174761409755,
			email_verified=true,
			iss=https://accounts.google.com,
			given_name=Jin-Hua,
			locale=en,
			nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg,
			picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c,
			aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com],
			azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com,
			name=Jin-Hua Qiu,
			exp=2021-01-07T16:49:49Z,
			family_name=Qiu,
			iat=2021-01-07T15:49:49Z,
			email=lifelink.com.tw@gmail.com
		}
	],
	Credentials=[PROTECTED],
	Authenticated=true,
	Details=WebAuthenticationDetails [
		RemoteIpAddress=0:0:0:0:0:0:0:1,
		SessionId=82A9A5D0D59595740CED1579EB9C6167
	],
	Granted Authorities=[
		ROLE_USER,
		SCOPE_https://www.googleapis.com/auth/userinfo.email,
		SCOPE_https://www.googleapis.com/auth/userinfo.profile,
		SCOPE_openid
	]
] before authorizing
2021-01-07 23:49:49.729 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.a.i.FilterSecurityInterceptor    : Authorizing filter invocation [GET /login?logout] with attributes [authenticated]
2021-01-07 23:49:49.729 DEBUG 45392 --- [-nio-443-exec-4] o.s.s.w.a.i.FilterSecurityInterceptor    : Authorized filter invocation [GET /login?logout] with attributes [authenticated]
2021-01-07 23:49:49.729 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.a.i.FilterSecurityInterceptor    : Did not switch RunAs authentication since RunAsManager returned null
2021-01-07 23:49:49.729 DEBUG 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Secured GET /login?logout
2021-01-07 23:49:49.731 TRACE 45392 --- [-nio-443-exec-4] o.s.web.servlet.DispatcherServlet        : GET "/login?logout", parameters={masked}, headers={masked} in DispatcherServlet 'dispatcherServlet'
2021-01-07 23:49:49.734 TRACE 45392 --- [-nio-443-exec-4] o.s.w.s.handler.SimpleUrlHandlerMapping  : Mapped to HandlerExecutionChain with [
	ResourceHttpRequestHandler [
		"classpath:/META-INF/resources/",
		"classpath:/resources/",
		"classpath:/static/",
		"classpath:/public/",
		"/"
	]
] and 3 interceptors
2021-01-07 23:49:49.735 DEBUG 45392 --- [-nio-443-exec-4] o.s.w.s.r.ResourceHttpRequestHandler     : Resource not found
2021-01-07 23:49:49.735 TRACE 45392 --- [-nio-443-exec-4] o.s.web.servlet.DispatcherServlet        : No view rendering, null ModelAndView returned.
2021-01-07 23:49:49.735 DEBUG 45392 --- [-nio-443-exec-4] o.s.web.servlet.DispatcherServlet        : Completed 404 NOT_FOUND, headers={masked}
2021-01-07 23:49:49.736 TRACE 45392 --- [-nio-443-exec-4] o.s.b.f.s.DefaultListableBeanFactory     : Returning cached instance of singleton bean 'delegatingApplicationListener'
2021-01-07 23:49:49.736 TRACE 45392 --- [-nio-443-exec-4] o.s.b.f.s.DefaultListableBeanFactory     : Returning cached instance of singleton bean 'liveReloadServerEventListener'
2021-01-07 23:49:49.736 DEBUG 45392 --- [-nio-443-exec-4] s.s.w.c.SecurityContextPersistenceFilter : Cleared SecurityContextHolder to complete request
2021-01-07 23:49:49.736 TRACE 45392 --- [-nio-443-exec-4] o.s.b.w.s.f.OrderedRequestContextFilter  : Cleared thread-bound request context: org.apache.catalina.connector.RequestFacade@499acbe3
2021-01-07 23:49:49.736 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.c.C.[Tomcat-4].[localhost]         : Processing ErrorPage[errorCode=0, location=/error]
2021-01-07 23:49:49.737 DEBUG 45392 --- [-nio-443-exec-4] o.apache.catalina.core.StandardWrapper   :   Returning non-STM instance
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.b.w.s.f.OrderedRequestContextFilter  : Bound request context to thread: org.apache.catalina.core.ApplicationHttpRequest@c5d7d77
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Trying to match request against DefaultSecurityFilterChain [RequestMatcher=any request, Filters=[org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter@4baac699, org.springframework.security.web.context.SecurityContextPersistenceFilter@54bdaee7, org.springframework.security.web.header.HeaderWriterFilter@2632a0a4, org.springframework.security.web.csrf.CsrfFilter@709c4118, org.springframework.security.web.authentication.logout.LogoutFilter@5b5207ee, org.springframework.security.oauth2.client.web.OAuth2AuthorizationRequestRedirectFilter@3443904c, org.springframework.security.oauth2.client.web.OAuth2AuthorizationRequestRedirectFilter@4f6fd12d, org.springframework.security.oauth2.client.web.OAuth2LoginAuthenticationFilter@3671781e, org.springframework.security.web.authentication.ui.DefaultLoginPageGeneratingFilter@509b0d0a, org.springframework.security.web.authentication.ui.DefaultLogoutPageGeneratingFilter@76a6f67a, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@4a183b5d, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@791c953a, org.springframework.security.web.authentication.AnonymousAuthenticationFilter@47f1b73a, org.springframework.security.oauth2.client.web.OAuth2AuthorizationCodeGrantFilter@63c3eb5d, org.springframework.security.web.session.SessionManagementFilter@463bb3b9, org.springframework.security.web.access.ExceptionTranslationFilter@615fec89, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@6619533e]] (1/1)
2021-01-07 23:49:49.738 DEBUG 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Securing GET /error?logout
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking WebAsyncManagerIntegrationFilter (1/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking SecurityContextPersistenceFilter (2/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] w.c.HttpSessionSecurityContextRepository : Retrieved SecurityContextImpl [Authentication=OAuth2AuthenticationToken [Principal=Name: [104514270174761409755], Granted Authorities: [[ROLE_USER, SCOPE_https://www.googleapis.com/auth/userinfo.email, SCOPE_https://www.googleapis.com/auth/userinfo.profile, SCOPE_openid]], User Attributes: [{at_hash=nDMOIHzTMsncSVwIc0UtMw, sub=104514270174761409755, email_verified=true, iss=https://accounts.google.com, given_name=Jin-Hua, locale=en, nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg, picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c, aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com], azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com, name=Jin-Hua Qiu, exp=2021-01-07T16:49:49Z, family_name=Qiu, iat=2021-01-07T15:49:49Z, email=lifelink.com.tw@gmail.com}], Credentials=[PROTECTED], Authenticated=true, Details=WebAuthenticationDetails [RemoteIpAddress=0:0:0:0:0:0:0:1, SessionId=82A9A5D0D59595740CED1579EB9C6167], Granted Authorities=[ROLE_USER, SCOPE_https://www.googleapis.com/auth/userinfo.email, SCOPE_https://www.googleapis.com/auth/userinfo.profile, SCOPE_openid]]] from SPRING_SECURITY_CONTEXT
2021-01-07 23:49:49.738 DEBUG 45392 --- [-nio-443-exec-4] s.s.w.c.SecurityContextPersistenceFilter : Set SecurityContextHolder to SecurityContextImpl [Authentication=OAuth2AuthenticationToken [Principal=Name: [104514270174761409755], Granted Authorities: [[ROLE_USER, SCOPE_https://www.googleapis.com/auth/userinfo.email, SCOPE_https://www.googleapis.com/auth/userinfo.profile, SCOPE_openid]], User Attributes: [{at_hash=nDMOIHzTMsncSVwIc0UtMw, sub=104514270174761409755, email_verified=true, iss=https://accounts.google.com, given_name=Jin-Hua, locale=en, nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg, picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c, aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com], azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com, name=Jin-Hua Qiu, exp=2021-01-07T16:49:49Z, family_name=Qiu, iat=2021-01-07T15:49:49Z, email=lifelink.com.tw@gmail.com}], Credentials=[PROTECTED], Authenticated=true, Details=WebAuthenticationDetails [RemoteIpAddress=0:0:0:0:0:0:0:1, SessionId=82A9A5D0D59595740CED1579EB9C6167], Granted Authorities=[ROLE_USER, SCOPE_https://www.googleapis.com/auth/userinfo.email, SCOPE_https://www.googleapis.com/auth/userinfo.profile, SCOPE_openid]]]
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking HeaderWriterFilter (3/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking CsrfFilter (4/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking LogoutFilter (5/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.a.logout.LogoutFilter            : Did not match request to Ant [pattern='/logout', POST]
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking OAuth2AuthorizationRequestRedirectFilter (6/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking OAuth2AuthorizationRequestRedirectFilter (7/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking OAuth2LoginAuthenticationFilter (8/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] .s.o.c.w.OAuth2LoginAuthenticationFilter : Did not match request to Ant [pattern='/login/oauth2/code/*']
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking DefaultLoginPageGeneratingFilter (9/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking DefaultLogoutPageGeneratingFilter (10/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking RequestCacheAwareFilter (11/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.s.HttpSessionRequestCache        : No saved request
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking SecurityContextHolderAwareRequestFilter (12/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking AnonymousAuthenticationFilter (13/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.s.w.a.AnonymousAuthenticationFilter  : Did not set SecurityContextHolder since already authenticated OAuth2AuthenticationToken [Principal=Name: [104514270174761409755], Granted Authorities: [[ROLE_USER, SCOPE_https://www.googleapis.com/auth/userinfo.email, SCOPE_https://www.googleapis.com/auth/userinfo.profile, SCOPE_openid]], User Attributes: [{at_hash=nDMOIHzTMsncSVwIc0UtMw, sub=104514270174761409755, email_verified=true, iss=https://accounts.google.com, given_name=Jin-Hua, locale=en, nonce=2t2iae-4ntlWDDiEM-JeFZCOnuxW43USh8rkPfZyTNg, picture=https://lh3.googleusercontent.com/a-/AOh14Gh2aVMtjwv_ZvlTMCkIxvy2_mBUZwENmlvy6kar=s96-c, aud=[490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com], azp=490911161339-8ffdnkh7rr3unn6rg6vl35mlj8injl1l.apps.googleusercontent.com, name=Jin-Hua Qiu, exp=2021-01-07T16:49:49Z, family_name=Qiu, iat=2021-01-07T15:49:49Z, email=lifelink.com.tw@gmail.com}], Credentials=[PROTECTED], Authenticated=true, Details=WebAuthenticationDetails [RemoteIpAddress=0:0:0:0:0:0:0:1, SessionId=82A9A5D0D59595740CED1579EB9C6167], Granted Authorities=[ROLE_USER, SCOPE_https://www.googleapis.com/auth/userinfo.email, SCOPE_https://www.googleapis.com/auth/userinfo.profile, SCOPE_openid]]
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking OAuth2AuthorizationCodeGrantFilter (14/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking SessionManagementFilter (15/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking ExceptionTranslationFilter (16/17)
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Invoking FilterSecurityInterceptor (17/17)
2021-01-07 23:49:49.738 DEBUG 45392 --- [-nio-443-exec-4] o.s.security.web.FilterChainProxy        : Secured GET /error?logout
2021-01-07 23:49:49.738 TRACE 45392 --- [-nio-443-exec-4] o.s.web.servlet.DispatcherServlet        : "ERROR" dispatch for GET "/error?logout", parameters={masked}, headers={masked} in DispatcherServlet 'dispatcherServlet'
2021-01-07 23:49:49.739 TRACE 45392 --- [-nio-443-exec-4] s.w.s.m.m.a.RequestMappingHandlerMapping : 2 matching mappings: [{ [/error], produces [text/html]}, { [/error]}]
2021-01-07 23:49:49.740 TRACE 45392 --- [-nio-443-exec-4] o.s.b.f.s.DefaultListableBeanFactory     : Returning cached instance of singleton bean 'basicErrorController'
2021-01-07 23:49:49.740 TRACE 45392 --- [-nio-443-exec-4] s.w.s.m.m.a.RequestMappingHandlerMapping : Mapped to org.springframework.boot.autoconfigure.web.servlet.error.BasicErrorController#errorHtml(HttpServletRequest, HttpServletResponse)
2021-01-07 23:49:49.747 TRACE 45392 --- [-nio-443-exec-4] o.s.web.method.HandlerMethod             : Arguments: [SecurityContextHolderAwareRequestWrapper[ org.springframework.security.web.context.HttpSessionSecurityContextRepository$SaveToSessionRequestWrapper@751f6c0b], org.springframework.security.web.context.HttpSessionSecurityContextRepository$SaveToSessionResponseWrapper@4852c03d]
2021-01-07 23:49:49.748 TRACE 45392 --- [-nio-443-exec-4] o.s.c.e.PropertySourcesPropertyResolver  : Searching for key 'spring.template.provider.cache' in PropertySource 'server.ports'
2021-01-07 23:49:49.748 TRACE 45392 --- [-nio-443-exec-4] o.s.c.e.PropertySourcesPropertyResolver  : Searching for key 'spring.template.provider.cache' in PropertySource 'configurationProperties'
2021-01-07 23:49:49.748 DEBUG 45392 --- [-nio-443-exec-4] o.s.c.e.PropertySourcesPropertyResolver  : Found key 'spring.template.provider.cache' in PropertySource 'configurationProperties' with value of type String
2021-01-07 23:49:49.749 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(freemarker.template.Configuration)
2021-01-07 23:49:49.749 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(freemarker.template.Configuration)
2021-01-07 23:49:49.749 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.749 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.750 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(freemarker.template$Configuration)
2021-01-07 23:49:49.750 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(freemarker.template$Configuration)
2021-01-07 23:49:49.750 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.750 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.751 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(com.samskivert.mustache.Template)
2021-01-07 23:49:49.751 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(com.samskivert.mustache.Template)
2021-01-07 23:49:49.751 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.751 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.751 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(com.samskivert.mustache$Template)
2021-01-07 23:49:49.752 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(com.samskivert.mustache$Template)
2021-01-07 23:49:49.752 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.752 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.752 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(groovy.text.TemplateEngine)
2021-01-07 23:49:49.752 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(groovy.text.TemplateEngine)
2021-01-07 23:49:49.753 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.753 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.753 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(groovy.text$TemplateEngine)
2021-01-07 23:49:49.753 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(groovy.text$TemplateEngine)
2021-01-07 23:49:49.754 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.754 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.754 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(org.thymeleaf.spring5.SpringTemplateEngine)
2021-01-07 23:49:49.754 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(org.thymeleaf.spring5.SpringTemplateEngine)
2021-01-07 23:49:49.754 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.755 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.755 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(org.thymeleaf.spring5$SpringTemplateEngine)
2021-01-07 23:49:49.755 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(org.thymeleaf.spring5$SpringTemplateEngine)
2021-01-07 23:49:49.755 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.755 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.756 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(org.apache.jasper.compiler.JspConfig)
2021-01-07 23:49:49.756 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(org.apache.jasper.compiler.JspConfig)
2021-01-07 23:49:49.756 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.756 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.757 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(org.apache.jasper.compiler$JspConfig)
2021-01-07 23:49:49.757 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(org.apache.jasper.compiler$JspConfig)
2021-01-07 23:49:49.757 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.757 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.757 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       : getResource(META-INF/resources/error/404.html)
2021-01-07 23:49:49.758 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   Delegating to parent classloader org.springframework.boot.devtools.restart.classloader.RestartClassLoader@1b36b2b0
2021-01-07 23:49:49.758 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   --> Resource not found, returning null
2021-01-07 23:49:49.758 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       : getResource(resources/error/404.html)
2021-01-07 23:49:49.758 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   Delegating to parent classloader org.springframework.boot.devtools.restart.classloader.RestartClassLoader@1b36b2b0
2021-01-07 23:49:49.758 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   --> Resource not found, returning null
2021-01-07 23:49:49.758 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       : getResource(static/error/404.html)
2021-01-07 23:49:49.758 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   Delegating to parent classloader org.springframework.boot.devtools.restart.classloader.RestartClassLoader@1b36b2b0
2021-01-07 23:49:49.759 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   --> Resource not found, returning null
2021-01-07 23:49:49.759 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       : getResource(public/error/404.html)
2021-01-07 23:49:49.759 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   Delegating to parent classloader org.springframework.boot.devtools.restart.classloader.RestartClassLoader@1b36b2b0
2021-01-07 23:49:49.759 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   --> Resource not found, returning null
2021-01-07 23:49:49.759 TRACE 45392 --- [-nio-443-exec-4] o.s.c.e.PropertySourcesPropertyResolver  : Searching for key 'spring.template.provider.cache' in PropertySource 'server.ports'
2021-01-07 23:49:49.759 TRACE 45392 --- [-nio-443-exec-4] o.s.c.e.PropertySourcesPropertyResolver  : Searching for key 'spring.template.provider.cache' in PropertySource 'configurationProperties'
2021-01-07 23:49:49.759 DEBUG 45392 --- [-nio-443-exec-4] o.s.c.e.PropertySourcesPropertyResolver  : Found key 'spring.template.provider.cache' in PropertySource 'configurationProperties' with value of type String
2021-01-07 23:49:49.759 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(freemarker.template.Configuration)
2021-01-07 23:49:49.759 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(freemarker.template.Configuration)
2021-01-07 23:49:49.760 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.760 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.760 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(freemarker.template$Configuration)
2021-01-07 23:49:49.760 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(freemarker.template$Configuration)
2021-01-07 23:49:49.760 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.760 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.761 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(com.samskivert.mustache.Template)
2021-01-07 23:49:49.761 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(com.samskivert.mustache.Template)
2021-01-07 23:49:49.761 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.761 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.761 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(com.samskivert.mustache$Template)
2021-01-07 23:49:49.761 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(com.samskivert.mustache$Template)
2021-01-07 23:49:49.762 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.762 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.762 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(groovy.text.TemplateEngine)
2021-01-07 23:49:49.762 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(groovy.text.TemplateEngine)
2021-01-07 23:49:49.762 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.762 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.763 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(groovy.text$TemplateEngine)
2021-01-07 23:49:49.763 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(groovy.text$TemplateEngine)
2021-01-07 23:49:49.763 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.763 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.763 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(org.thymeleaf.spring5.SpringTemplateEngine)
2021-01-07 23:49:49.763 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(org.thymeleaf.spring5.SpringTemplateEngine)
2021-01-07 23:49:49.763 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.763 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.764 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(org.thymeleaf.spring5$SpringTemplateEngine)
2021-01-07 23:49:49.764 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(org.thymeleaf.spring5$SpringTemplateEngine)
2021-01-07 23:49:49.764 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.764 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.765 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(org.apache.jasper.compiler.JspConfig)
2021-01-07 23:49:49.765 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(org.apache.jasper.compiler.JspConfig)
2021-01-07 23:49:49.765 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.765 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.765 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     findClass(org.apache.jasper.compiler$JspConfig)
2021-01-07 23:49:49.765 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :       findClassInternal(org.apache.jasper.compiler$JspConfig)
2021-01-07 23:49:49.766 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Returning ClassNotFoundException
2021-01-07 23:49:49.766 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :     --> Passing on ClassNotFoundException
2021-01-07 23:49:49.766 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       : getResource(META-INF/resources/error/4xx.html)
2021-01-07 23:49:49.766 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   Delegating to parent classloader org.springframework.boot.devtools.restart.classloader.RestartClassLoader@1b36b2b0
2021-01-07 23:49:49.766 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   --> Resource not found, returning null
2021-01-07 23:49:49.766 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       : getResource(resources/error/4xx.html)
2021-01-07 23:49:49.766 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   Delegating to parent classloader org.springframework.boot.devtools.restart.classloader.RestartClassLoader@1b36b2b0
2021-01-07 23:49:49.766 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   --> Resource not found, returning null
2021-01-07 23:49:49.767 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       : getResource(static/error/4xx.html)
2021-01-07 23:49:49.767 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   Delegating to parent classloader org.springframework.boot.devtools.restart.classloader.RestartClassLoader@1b36b2b0
2021-01-07 23:49:49.767 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   --> Resource not found, returning null
2021-01-07 23:49:49.767 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       : getResource(public/error/4xx.html)
2021-01-07 23:49:49.767 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   Delegating to parent classloader org.springframework.boot.devtools.restart.classloader.RestartClassLoader@1b36b2b0
2021-01-07 23:49:49.767 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.loader.WebappClassLoaderBase       :   --> Resource not found, returning null
2021-01-07 23:49:49.770 TRACE 45392 --- [-nio-443-exec-4] o.s.b.f.s.DefaultListableBeanFactory     : Returning cached instance of singleton bean 'error'
2021-01-07 23:49:49.770 TRACE 45392 --- [-nio-443-exec-4] o.s.web.servlet.DispatcherServlet        : Rendering view [org.springframework.boot.autoconfigure.web.servlet.error.ErrorMvcAutoConfiguration$StaticView@71439f61] 
2021-01-07 23:49:49.770 DEBUG 45392 --- [-nio-443-exec-4] o.s.web.servlet.DispatcherServlet        : Exiting from "ERROR" dispatch, status 404, headers={masked}
2021-01-07 23:49:49.770 DEBUG 45392 --- [-nio-443-exec-4] s.s.w.c.SecurityContextPersistenceFilter : Cleared SecurityContextHolder to complete request
2021-01-07 23:49:49.770 TRACE 45392 --- [-nio-443-exec-4] o.s.b.w.s.f.OrderedRequestContextFilter  : Cleared thread-bound request context: org.apache.catalina.core.ApplicationHttpRequest@c5d7d77
2021-01-07 23:49:49.770 DEBUG 45392 --- [-nio-443-exec-4] o.a.c.c.C.[.[.[/].[dispatcherServlet]    :  Disabling the response for further output
2021-01-07 23:49:49.771 DEBUG 45392 --- [-nio-443-exec-4] o.a.coyote.http11.Http11InputBuffer      : Before fill(): [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position() [0]
2021-01-07 23:49:49.771 DEBUG 45392 --- [-nio-443-exec-4] o.a.tomcat.util.net.SocketWrapperBase    : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Read from buffer: [0]
2021-01-07 23:49:49.771 DEBUG 45392 --- [-nio-443-exec-4] org.apache.tomcat.util.net.NioEndpoint   : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Read direct from socket: [0]
2021-01-07 23:49:49.771 DEBUG 45392 --- [-nio-443-exec-4] o.a.coyote.http11.Http11InputBuffer      : Received []
2021-01-07 23:49:49.771 DEBUG 45392 --- [-nio-443-exec-4] o.apache.coyote.http11.Http11Processor   : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Status in: [OPEN_READ], State out: [OPEN]
2021-01-07 23:49:49.771 DEBUG 45392 --- [-nio-443-exec-4] org.apache.tomcat.util.net.NioEndpoint   : Registered read interest for [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]]
2021-01-07 23:49:50.229 DEBUG 45392 --- [-nio-443-exec-5] o.a.coyote.http11.Http11InputBuffer      : Before fill(): [true], parsingRequestLine: [true], parsingRequestLinePhase: [0], parsingRequestLineStart: [0], byteBuffer.position() [0]
2021-01-07 23:49:50.229 DEBUG 45392 --- [-nio-443-exec-5] o.a.tomcat.util.net.SocketWrapperBase    : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Read from buffer: [0]
2021-01-07 23:49:50.229 DEBUG 45392 --- [-nio-443-exec-5] org.apache.tomcat.util.net.NioEndpoint   : Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@50b4acf9:org.apache.tomcat.util.net.SecureNioChannel@5e73489f:java.nio.channels.SocketChannel[connected local=/0:0:0:0:0:0:0:1:443 remote=/0:0:0:0:0:0:0:1:56293]], Read direct from socket: [477]