前言
1.问题背景
偶尔会出现登录请求出错的情况，一旦失败就会短时间内再也登录不上，更换浏览器或者刷新可能会暂时解决这个问题。
项目运行日志如下：
2022-07-21 09:43:40.946 DEBUG 8644 --- [http-nio-0.0.0.0-8080-exec-4] org.hibernate.SQL : select useraccoun0_.id as id1_65_, useraccoun0_.created_by_id as created23_65_, useraccoun0_.date_created as date_cre2_65_, useraccoun0_.is_valid as is_valid3_65_, useraccoun0_.last_update as last_upd4_65_, useraccoun0_.updated_by_id as updated24_65_, useraccoun0_.account_expired as account_5_65_, useraccoun0_.account_locked as account_6_65_, useraccoun0_.confirm_password as confirm_7_65_, useraccoun0_.department_id as departm25_65_, useraccoun0_.district as district8_65_, useraccoun0_.email as email9_65_, useraccoun0_.id_number as id_numb10_65_, useraccoun0_.id_type as id_type11_65_, useraccoun0_.image_url as image_u12_65_, useraccoun0_.is_admin as is_admi13_65_, useraccoun0_.name as name14_65_, useraccoun0_.need_approve as need_ap15_65_, useraccoun0_.open_id as open_id16_65_, useraccoun0_.password as passwor17_65_, useraccoun0_.password_expired as passwor18_65_, useraccoun0_.phone_number as phone_n19_65_, useraccoun0_.phone_reginal_number as phone_r20_65_, useraccoun0_.reference_user_id as referen26_65_, useraccoun0_.role_id as role_id27_65_, useraccoun0_.user_type as user_ty21_65_, useraccoun0_.username as usernam22_65_ from user_account useraccoun0_ where useraccoun0_.username=?
2022-07-21 09:43:40.947 DEBUG 8644 --- [http-nio-0.0.0.0-8080-exec-4] org.hibernate.SQL : select role0_.id as id1_56_0_, role0_.description as descript2_56_0_, role0_.is_valid as is_valid3_56_0_, role0_.name as name4_56_0_, role0_.role_name as role_nam5_56_0_, roleprivil1_.role_id as role_id1_57_1_, roleprivil2_.id as role_pri2_57_1_, roleprivil2_.id as id1_58_2_, roleprivil2_.privileges_id as privileg2_58_2_, roleprivil2_.role_id as role_id3_58_2_, privileges3_.id as id1_45_3_, privileges3_.parent_id as parent_i2_45_3_, privileges3_.privilege_code as privileg3_45_3_, privileges3_.privilege_name as privileg4_45_3_, privileges3_.privilege_path as privileg5_45_3_, privileges3_.privilege_type as privileg6_45_3_, role4_.id as id1_56_4_, role4_.description as descript2_56_4_, role4_.is_valid as is_valid3_56_4_, role4_.name as name4_56_4_, role4_.role_name as role_nam5_56_4_ from role role0_ left outer join role_role_privileges roleprivil1_ on role0_.id=roleprivil1_.role_id left outer join role_privileges roleprivil2_ on roleprivil1_.role_privileges_id=roleprivil2_.id left outer join privileges privileges3_ on roleprivil2_.privileges_id=privileges3_.id left outer join role role4_ on roleprivil2_.role_id=role4_.id where role0_.id=?
2022-07-21 09:43:40.951 DEBUG 8644 --- [http-nio-0.0.0.0-8080-exec-4] org.hibernate.SQL : select usertorole0_.user_account_id as user_acc1_66_0_, usertorole0_.user_to_roles_id as user_to_2_66_0_, usertorole1_.id as id1_68_1_, usertorole1_.role_id as role_id2_68_1_, usertorole1_.user_account_id as user_acc3_68_1_, role2_.id as id1_56_2_, role2_.description as descript2_56_2_, role2_.is_valid as is_valid3_56_2_, role2_.name as name4_56_2_, role2_.role_name as role_nam5_56_2_, useraccoun3_.id as id1_65_3_, useraccoun3_.created_by_id as created23_65_3_, useraccoun3_.date_created as date_cre2_65_3_, useraccoun3_.is_valid as is_valid3_65_3_, useraccoun3_.last_update as last_upd4_65_3_, useraccoun3_.updated_by_id as updated24_65_3_, useraccoun3_.account_expired as account_5_65_3_, useraccoun3_.account_locked as account_6_65_3_, useraccoun3_.confirm_password as confirm_7_65_3_, useraccoun3_.department_id as departm25_65_3_, useraccoun3_.district as district8_65_3_, useraccoun3_.email as email9_65_3_, useraccoun3_.id_number as id_numb10_65_3_, useraccoun3_.id_type as id_type11_65_3_, useraccoun3_.image_url as image_u12_65_3_, useraccoun3_.is_admin as is_admi13_65_3_, useraccoun3_.name as name14_65_3_, useraccoun3_.need_approve as need_ap15_65_3_, useraccoun3_.open_id as open_id16_65_3_, useraccoun3_.password as passwor17_65_3_, useraccoun3_.password_expired as passwor18_65_3_, useraccoun3_.phone_number as phone_n19_65_3_, useraccoun3_.phone_reginal_number as phone_r20_65_3_, useraccoun3_.reference_user_id as referen26_65_3_, useraccoun3_.role_id as role_id27_65_3_, useraccoun3_.user_type as user_ty21_65_3_, useraccoun3_.username as usernam22_65_3_, useraccoun4_.id as id1_65_4_, useraccoun4_.created_by_id as created23_65_4_, useraccoun4_.date_created as date_cre2_65_4_, useraccoun4_.is_valid as is_valid3_65_4_, useraccoun4_.last_update as last_upd4_65_4_, useraccoun4_.updated_by_id as updated24_65_4_, useraccoun4_.account_expired as account_5_65_4_, useraccoun4_.account_locked as account_6_65_4_, useraccoun4_.confirm_password as confirm_7_65_4_, useraccoun4_.department_id as departm25_65_4_, useraccoun4_.district as district8_65_4_, useraccoun4_.email as email9_65_4_, useraccoun4_.id_number as id_numb10_65_4_, useraccoun4_.id_type as id_type11_65_4_, useraccoun4_.image_url as image_u12_65_4_, useraccoun4_.is_admin as is_admi13_65_4_, useraccoun4_.name as name14_65_4_, useraccoun4_.need_approve as need_ap15_65_4_, useraccoun4_.open_id as open_id16_65_4_, useraccoun4_.password as passwor17_65_4_, useraccoun4_.password_expired as passwor18_65_4_, useraccoun4_.phone_number as phone_n19_65_4_, useraccoun4_.phone_reginal_number as phone_r20_65_4_, useraccoun4_.reference_user_id as referen26_65_4_, useraccoun4_.role_id as role_id27_65_4_, useraccoun4_.user_type as user_ty21_65_4_, useraccoun4_.username as usernam22_65_4_, useraccoun5_.id as id1_65_5_, useraccoun5_.created_by_id as created23_65_5_, useraccoun5_.date_created as date_cre2_65_5_, useraccoun5_.is_valid as is_valid3_65_5_, useraccoun5_.last_update as last_upd4_65_5_, useraccoun5_.updated_by_id as updated24_65_5_, useraccoun5_.account_expired as account_5_65_5_, useraccoun5_.account_locked as account_6_65_5_, useraccoun5_.confirm_password as confirm_7_65_5_, useraccoun5_.department_id as departm25_65_5_, useraccoun5_.district as district8_65_5_, useraccoun5_.email as email9_65_5_, useraccoun5_.id_number as id_numb10_65_5_, useraccoun5_.id_type as id_type11_65_5_, useraccoun5_.image_url as image_u12_65_5_, useraccoun5_.is_admin as is_admi13_65_5_, useraccoun5_.name as name14_65_5_, useraccoun5_.need_approve as need_ap15_65_5_, useraccoun5_.open_id as open_id16_65_5_, useraccoun5_.password as passwor17_65_5_, useraccoun5_.password_expired as passwor18_65_5_, useraccoun5_.phone_number as phone_n19_65_5_, useraccoun5_.phone_reginal_number as phone_r20_65_5_, useraccoun5_.reference_user_id as referen26_65_5_, useraccoun5_.role_id as role_id27_65_5_, useraccoun5_.user_type as user_ty21_65_5_, useraccoun5_.username as usernam22_65_5_, department6_.id as id1_11_6_, department6_.created_by_id as created_9_11_6_, department6_.date_created as date_cre2_11_6_, department6_.is_valid as is_valid3_11_6_, department6_.last_update as last_upd4_11_6_, department6_.updated_by_id as updated10_11_6_, department6_.description as descript5_11_6_, department6_.management_district as manageme6_11_6_, department6_.name as name7_11_6_, department6_.name_code as name_cod8_11_6_, useraccoun7_.id as id1_65_7_, useraccoun7_.created_by_id as created23_65_7_, useraccoun7_.date_created as date_cre2_65_7_, useraccoun7_.is_valid as is_valid3_65_7_, useraccoun7_.last_update as last_upd4_65_7_, useraccoun7_.updated_by_id as updated24_65_7_, useraccoun7_.account_expired as account_5_65_7_, useraccoun7_.account_locked as account_6_65_7_, useraccoun7_.confirm_password as confirm_7_65_7_, useraccoun7_.department_id as departm25_65_7_, useraccoun7_.district as district8_65_7_, useraccoun7_.email as email9_65_7_, useraccoun7_.id_number as id_numb10_65_7_, useraccoun7_.id_type as id_type11_65_7_, useraccoun7_.image_url as image_u12_65_7_, useraccoun7_.is_admin as is_admi13_65_7_, useraccoun7_.name as name14_65_7_, useraccoun7_.need_approve as need_ap15_65_7_, useraccoun7_.open_id as open_id16_65_7_, useraccoun7_.password as passwor17_65_7_, useraccoun7_.password_expired as passwor18_65_7_, useraccoun7_.phone_number as phone_n19_65_7_, useraccoun7_.phone_reginal_number as phone_r20_65_7_, useraccoun7_.reference_user_id as referen26_65_7_, useraccoun7_.role_id as role_id27_65_7_, useraccoun7_.user_type as user_ty21_65_7_, useraccoun7_.username as usernam22_65_7_, role8_.id as id1_56_8_, role8_.description as descript2_56_8_, role8_.is_valid as is_valid3_56_8_, role8_.name as name4_56_8_, role8_.role_name as role_nam5_56_8_ from user_account_user_to_roles usertorole0_ inner join user_to_role usertorole1_ on usertorole0_.user_to_roles_id=usertorole1_.id left outer join role role2_ on usertorole1_.role_id=role2_.id left outer join user_account useraccoun3_ on usertorole1_.user_account_id=useraccoun3_.id left outer join user_account useraccoun4_ on useraccoun3_.created_by_id=useraccoun4_.id left outer join user_account useraccoun5_ on useraccoun3_.updated_by_id=useraccoun5_.id left outer join department department6_ on useraccoun3_.department_id=department6_.id left outer join user_account useraccoun7_ on useraccoun3_.reference_user_id=useraccoun7_.id left outer join role role8_ on useraccoun3_.role_id=role8_.id where usertorole0_.user_account_id=?
2022-07-21 09:43:41.053 DEBUG 8644 --- [http-nio-0.0.0.0-8080-exec-4] org.hibernate.SQL : select * from role where id in (select role_id from user_to_role role where user_account_id = ?)
2022-07-21 09:43:41.058 DEBUG 8644 --- [http-nio-0.0.0.0-8080-exec-4] org.hibernate.SQL : insert into user_token (created_by_id, date_created, is_valid, last_update, updated_by_id, token, user_account_id, id) values (?, ?, ?, ?, ?, ?, ?, ?)
2022-07-21 09:43:41.066 WARN 8644 --- [http-nio-0.0.0.0-8080-exec-4] o.h.engine.jdbc.spi.SqlExceptionHelper : SQL Error: 1062, SQLState: 23000
2022-07-21 09:43:41.066 ERROR 8644 --- [http-nio-0.0.0.0-8080-exec-4] o.h.engine.jdbc.spi.SqlExceptionHelper : (conn=2673) Duplicate entry '1300' for key 'PRIMARY'
2022-07-21 09:43:41.067 INFO 8644 --- [http-nio-0.0.0.0-8080-exec-4] o.h.e.j.b.internal.AbstractBatchImpl : HHH000010: On release of batch it still contained JDBC statements
2022-07-21 09:43:41.080 ERROR 8644 --- [http-nio-0.0.0.0-8080-exec-4] o.a.c.c.C.[.[.[/].[dispatcherServlet] : Servlet.service() for servlet [dispatcherServlet] in context with path [] threw exception [Request processing failed; nested exception is org.springframework.dao.DataIntegrityViolationException: could not execute statement; SQL [n/a]; constraint [PRIMARY]; nested exception is org.hibernate.exception.ConstraintViolationException: could not execute statement] with root cause
java.sql.SQLException: Duplicate entry '1300' for key 'PRIMARY'
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readErrorPacket(AbstractQueryProtocol.java:1681) ~[mariadb-java-client-2.7.2.jar!/:na]
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.readPacket(AbstractQueryProtocol.java:1543) ~[mariadb-java-client-2.7.2.jar!/:na]
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.getResult(AbstractQueryProtocol.java:1506) ~[mariadb-java-client-2.7.2.jar!/:na]
at org.mariadb.jdbc.internal.protocol.AbstractQueryProtocol.executeQuery(AbstractQueryProtocol.java:316) ~[mariadb-java-client-2.7.2.jar!/:na]
at org.mariadb.jdbc.ClientSidePreparedStatement.executeInternal(ClientSidePreparedStatement.java:220) ~[mariadb-java-client-2.7.2.jar!/:na]
at org.mariadb.jdbc.ClientSidePreparedStatement.execute(ClientSidePreparedStatement.java:149) ~[mariadb-java-client-2.7.2.jar!/:na]
at org.mariadb.jdbc.ClientSidePreparedStatement.executeUpdate(ClientSidePreparedStatement.java:181) ~[mariadb-java-client-2.7.2.jar!/:na]
at jdk.internal.reflect.GeneratedMethodAccessor374.invoke(Unknown Source) ~[na:na]
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:na]
at java.base/java.lang.reflect.Method.invoke(Method.java:568) ~[na:na]
at org.apache.tomcat.jdbc.pool.StatementFacade$StatementProxy.invoke(StatementFacade.java:114) ~[tomcat-jdbc-9.0.44.jar!/:na]
at jdk.proxy2/jdk.proxy2.$Proxy130.executeUpdate(Unknown Source) ~[na:na]
at org.hibernate.engine.jdbc.internal.ResultSetReturnImpl.executeUpdate(ResultSetReturnImpl.java:197) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.engine.jdbc.batch.internal.NonBatchingBatch.addToBatch(NonBatchingBatch.java:46) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:3375) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.persister.entity.AbstractEntityPersister.insert(AbstractEntityPersister.java:3908) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.action.internal.EntityInsertAction.execute(EntityInsertAction.java:107) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:604) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.engine.spi.ActionQueue.lambda$executeActions$1(ActionQueue.java:478) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at java.base/java.util.LinkedHashMap.forEach(LinkedHashMap.java:721) ~[na:na]
at org.hibernate.engine.spi.ActionQueue.executeActions(ActionQueue.java:475) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.event.internal.AbstractFlushingEventListener.performExecutions(AbstractFlushingEventListener.java:344) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.event.internal.DefaultFlushEventListener.onFlush(DefaultFlushEventListener.java:40) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.event.service.internal.EventListenerGroupImpl.fireEventOnEachListener(EventListenerGroupImpl.java:107) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.internal.SessionImpl.doFlush(SessionImpl.java:1407) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.internal.SessionImpl.managedFlush(SessionImpl.java:489) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.internal.SessionImpl.flushBeforeTransactionCompletion(SessionImpl.java:3290) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.internal.SessionImpl.beforeTransactionCompletion(SessionImpl.java:2425) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.engine.jdbc.internal.JdbcCoordinatorImpl.beforeTransactionCompletion(JdbcCoordinatorImpl.java:449) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.beforeCompletionCallback(JdbcResourceLocalTransactionCoordinatorImpl.java:183) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl.access$300(JdbcResourceLocalTransactionCoordinatorImpl.java:40) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.resource.transaction.backend.jdbc.internal.JdbcResourceLocalTransactionCoordinatorImpl$TransactionDriverControlImpl.commit(JdbcResourceLocalTransactionCoordinatorImpl.java:281) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.hibernate.engine.transaction.internal.TransactionImpl.commit(TransactionImpl.java:101) ~[hibernate-core-5.6.9.Final.jar!/:5.6.9.Final]
at org.springframework.orm.jpa.JpaTransactionManager.doCommit(JpaTransactionManager.java:562) ~[spring-orm-5.3.5.jar!/:5.3.5]
at org.springframework.transaction.support.AbstractPlatformTransactionManager.processCommit(AbstractPlatformTransactionManager.java:743) ~[spring-tx-5.3.5.jar!/:5.3.5]
at org.springframework.transaction.support.AbstractPlatformTransactionManager.commit(AbstractPlatformTransactionManager.java:711) ~[spring-tx-5.3.5.jar!/:5.3.5]
at org.springframework.transaction.interceptor.TransactionAspectSupport.commitTransactionAfterReturning(TransactionAspectSupport.java:654) ~[spring-tx-5.3.5.jar!/:5.3.5]
at org.springframework.transaction.interceptor.TransactionAspectSupport.invokeWithinTransaction(TransactionAspectSupport.java:407) ~[spring-tx-5.3.5.jar!/:5.3.5]
at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:119) ~[spring-tx-5.3.5.jar!/:5.3.5]
at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:186) ~[spring-aop-5.3.5.jar!/:5.3.5]
at org.springframework.aop.framework.CglibAopProxy$CglibMethodInvocation.proceed(CglibAopProxy.java:750) ~[spring-aop-5.3.5.jar!/:5.3.5]
at org.springframework.aop.framework.CglibAopProxy$DynamicAdvisedInterceptor.intercept(CglibAopProxy.java:692) ~[spring-aop-5.3.5.jar!/:5.3.5]
at com.beyondsoft.sabg.testlab.service.core.impl.UserServiceImpl$$EnhancerBySpringCGLIB$$fc6510b4.login(<generated>) ~[classes!/:0.0.1-SNAPSHOT]
at com.beyondsoft.sabg.testlab.controller.user.LoginAndLogoutController.login(LoginAndLogoutController.java:88) ~[classes!/:0.0.1-SNAPSHOT]
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:na]
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77) ~[na:na]
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[na:na]
at java.base/java.lang.reflect.Method.invoke(Method.java:568) ~[na:na]
at org.springframework.web.method.support.InvocableHandlerMethod.doInvoke(InvocableHandlerMethod.java:197) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:141) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:106) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:894) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:808) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:87) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:1060) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:962) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:1006) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:909) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:652) ~[tomcat-embed-core-9.0.44.jar!/:4.0.FR]
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:883) ~[spring-webmvc-5.3.5.jar!/:5.3.5]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:733) ~[tomcat-embed-core-9.0.44.jar!/:4.0.FR]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:227) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53) ~[tomcat-embed-websocket-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:327) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:115) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:81) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:119) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:126) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:81) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:105) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:149) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:63) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilterInternal(BasicAuthenticationFilter.java:149) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at com.beyondsoft.sabg.testlab.security.jwt.JwtTokenFilter.doFilter(JwtTokenFilter.java:45) ~[classes!/:0.0.1-SNAPSHOT]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:103) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:89) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.web.filter.CorsFilter.doFilterInternal(CorsFilter.java:91) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.header.HeaderWriterFilter.doHeadersAfter(HeaderWriterFilter.java:90) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.header.HeaderWriterFilter.doFilterInternal(HeaderWriterFilter.java:75) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:110) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:80) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:55) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:336) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:211) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:183) ~[spring-security-web-5.4.5.jar!/:5.4.5]
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:358) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:271) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.springframework.web.filter.RequestContextFilter.doFilterInternal(RequestContextFilter.java:100) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.springframework.web.filter.FormContentFilter.doFilterInternal(FormContentFilter.java:93) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.springframework.web.filter.CharacterEncodingFilter.doFilterInternal(CharacterEncodingFilter.java:201) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:119) ~[spring-web-5.3.5.jar!/:5.3.5]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:189) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:162) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:202) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:97) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:542) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:143) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:92) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:78) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:357) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:374) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:65) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:893) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1707) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) ~[na:na]
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) ~[na:na]
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) ~[tomcat-embed-core-9.0.44.jar!/:9.0.44]
at java.base/java.lang.Thread.run(Thread.java:833) ~[na:na]查看运行日志看出，报错原因: java.sql.SQLException: Duplicate entry '1300' for key 'PRIMARY'
因为重复的主键而报错，头大！！！
仔细的查看代码和数据库数据，确定是因为保存token时主键重复。
代码如下：
@Override
@Transactional
public List<Map<String, Object>> login(String username, String password) {
Map<String, Object> userInfoMap = new HashMap<>();
List<Map<String, Object>> userInfo = new ArrayList<Map<String, Object>>();
try {
Authentication auth = authenticationManager
.authenticate(new UsernamePasswordAuthenticationToken(username, password));
UserAccount account = (UserAccount) auth.getPrincipal();
Map<String, Object> accountMap = getUserPublicInfo(account);
userInfo.add(accountMap);
String token = jwtTokenProvider.createToken(username);
UserToken t = new UserToken();
t.setToken(token);
t.setUserAccount(account);
userInfoMap.put("token", token);
userInfo.add(userInfoMap);
tokenRepository.save(t);
return userInfo;
} catch (AuthenticationException e) {
userInfoMap.put("error", "账号登陆错误!");
userInfo.add(userInfoMap);
log.debug("Authentication error: %s", username);
}
return null;
}public class UserToken extends AbstractEntity {
String token;
@ManyToOne
UserAccount userAccount;
public String getToken() {
return token;
}
public void setToken(String token) {
this.token = token;
}
public UserAccount getUserAccount() {
return userAccount;
}
public void setUserAccount(UserAccount userAccount) {
this.userAccount = userAccount;
}
}2.解决问题：
2.1.引起数据重复的原因有哪些
表象原因：如网络延迟、用户连点、并发等，都有可能引起数据库被重复插入。
可能原因：如主键没有设置自增、插入线程频率过高，没有处置好事务，造成插入SQL执行顺序混乱等。
2.2.解决思路
首先问题产生是因为有重复主键，谁产生的这个问题，是在登录接口中调用保存token时产生。
解决1：
设置主键自增
然而本身我们就设置了主键自增，所以并不是这个问题引起的。
猜想：是不是save哪里有问题
save使用的是springboot JPA中的save()方法，查看JPA的save方法的实现。
JPA 的 save 默认会判断是否为新数据，若为新数据则 insert / persist，否则 update / merge。
具体实现是先select后insert/update,查询没有该数据就插入数据，有则更新。
jpa save方法源码：
@Transactional
@Override
public <S extends T> S save(S entity) {
Assert.notNull(entity, "Entity must not be null.");
if (entityInformation.isNew(entity)) {
em.persist(entity);
return entity;
} else {
return em.merge(entity);
}
}save方法运行sql
org.hibernate.SQL : select max(id) from user_token
org.hibernate.SQL : insert into user_token (created_by_id, date_created, is_valid, last_update, updated_by_id, token, user_account_id, id) values (?, ?, ?, ?, ?, ?, ?, ?)"select max(id) from user_token" 获取最大id号，因为是主键设置的是自增，最大id号将作为新插入数据的主键id。
从这个思路出发，我们使用的是mysql数据库，本身我们数据库插入表的主键id是自增的，作为数据库主键而言，唯一性已经不能保证不会出现插入表数据有多个锁的情况，所以报错重复的主键冲突，会不会是因为jpa在保存时先find后再save，在这个过程db报错。
解决2：
在实体类中实现 Persistable interface 的 isNew method，固定返回 true，则在 JPA save 时一定会执行 insert sql，代码如下：
@Entity
public class UserToken extends AbstractEntity implements Persistable{
String token;
@ManyToOne
UserAccount userAccount;
public String getToken() {
return token;
}
public void setToken(String token) {
this.token = token;
}
public UserAccount getUserAccount() {
return userAccount;
}
public void setUserAccount(UserAccount userAccount) {
this.userAccount = userAccount;
}
@Override
public boolean isNew() {
return true;
}
}上面这种方式除外，还可以不对实体做改变，直接 Repository 自定义 Query。
然而并没有解决我的问题。
猜测：会不会不仅只是这个save引起的，可能还有别的原因
从这个思路重新出发，查看代码，发现在UserToken实体对用户有关联关系，那会不会是因为对于一个关联的外键表存在一个唯一的约束，然而你又对这个唯一的约束新增一个同样的字段。所以我去查看了一下新增的这个关系表对应的外键是否存在，结果存在，查看JPA一对多的关系是否选择是同时合并，和同时持久化操作，结果没有，从这点可以试试是不是这个原因引起的。补充：如果是同时持久化操作就会在更新外键表的时候自己修改主表，主表根据ID修改，如果没有ID就会新增一个主表数据。
ALL
级联所有实体状态转换
PERSIST
级联实体持久化操作
MERGE
级联实体合并操作
REMOVE
级联实体删除操作
REFRESH
级联实体刷新操作
DETACH
级联实体分离操作
@Cascade(value = CascadeType.ALL)
@ManyToOne(fetch = FetchType.EAGER)
UserAccount userAccount;
(@OneToMany(cascade = {CascadeType.ALL} ,fetch= FetchType.EAGER))
到此我的问题解决！！！如果你的问题还未解决，可以考虑除去save之外的原因，比如：业务上是否有问题等。
从头梳理一下，发现还是有问题，需要注意的是CascadeType.ALL尽量不要乱用，all在所有情况下均进行关联操作，即save-update和delete，做删除操作时会导致关联实体删除，如果你的需求不需要关联删除就不能使用all。
最终方案是：
@Cascade(value = CascadeType.SAVE_UPDATE)
@ManyToOne(fetch = FetchType.EAGER)
UserAccount userAccount;
补充：cascade属性的可能值有
all: 所有情况下均进行关联操作，即save-update和delete。
none: 所有情况下均不进行关联操作。这是默认值。
save-update: 在执行save/update/saveOrUpdate时进行关联操作，例如：当保存A，同时保存关联对象B，不需要手动执行save(B)。
delete: 在执行delete 时进行关联操作，例如：当删除A时，同时删除关联对象B。
merge：merge方法产生的效果来看，它和saveOrUpdate()方法相似，根据参数有无id或id是否已经存在来理解merge()方法。个人认为这样更容易理解，而且从执行他们两个方法而产生的sql语句来看是一样的。
all-delete-orphan: 所有级联操作，当一个节点在对象图中成为孤儿节点时，删除该节点。
hibernate 3已经将cascade当中的选项做了修改，现在已经没有了all-delete-orphan这个选项，虽然hibernate内部还是支持这个选项。
转载至：https://www.cnblogs.com/sx-jd/p/16506769.html
注意：本文归作者所有，未经作者允许，不得转载
