search

apache / shardingsphere

Distributed SQL transaction & query engine for data sharding, scaling, encryption, and more - on any database.
Apache License 2.0
19.87k stars 6.73k forks source link

seata+sharding jdbc,execute insert error：java.sql.SQLFeatureNotSupportedException: executeQuery with SQL for PreparedStatement #7966

Closed niudadan closed 3 years ago

niudadan commented 3 years ago

pom version: sharding-transaction-base-seata-at：4.1.0 sharding-jdbc-spring-boot-starter:4.1.1 seata-spring-boot-starter:1.3.0

start log: 2020-10-30 12:07:36.426 [main] INFO com.mozhe.sync.SyncServiceApplication Line:655 - The following profiles are active: common,dev,common-dev,datasource-sync-dev log4j:WARN No appenders could be found for logger (com.alibaba.dubbo.common.logger.LoggerFactory). log4j:WARN Please initialize the log4j system properly. 2020-10-30 12:07:37.335 [main] INFO o.s.d.r.config.RepositoryConfigurationDelegate Line:249 - Multiple Spring Data modules found, entering strict repository configuration mode! 2020-10-30 12:07:37.336 [main] INFO o.s.d.r.config.RepositoryConfigurationDelegate Line:127 - Bootstrapping Spring Data MongoDB repositories in DEFAULT mode. 2020-10-30 12:07:37.374 [main] INFO o.s.d.r.config.RepositoryConfigurationDelegate Line:187 - Finished Spring Data repository scanning in 34ms. Found 0 MongoDB repository interfaces. 2020-10-30 12:07:37.385 [main] INFO o.s.d.r.config.RepositoryConfigurationDelegate Line:249 - Multiple Spring Data modules found, entering strict repository configuration mode! 2020-10-30 12:07:37.386 [main] INFO o.s.d.r.config.RepositoryConfigurationDelegate Line:127 - Bootstrapping Spring Data Redis repositories in DEFAULT mode. 2020-10-30 12:07:37.400 [main] INFO o.s.d.r.config.RepositoryConfigurationDelegate Line:187 - Finished Spring Data repository scanning in 6ms. Found 0 Redis repository interfaces. 2020-10-30 12:07:37.644 [main] INFO o.springframework.cloud.context.scope.GenericScope Line:295 - BeanFactory id=a12fbe9b-f542-3c3b-a5cc-d3e12cac93fa 2020-10-30 12:07:37.650 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'io.seata.spring.boot.autoconfigure.SeataAutoConfiguration' of type [io.seata.spring.boot.autoconfigure.SeataAutoConfiguration$$EnhancerBySpringCGLIB$$16dc8722] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.658 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'springApplicationContextProvider' of type [io.seata.spring.boot.autoconfigure.provider.SpringApplicationContextProvider] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.684 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'failureHandler' of type [io.seata.tm.api.DefaultFailureHandlerImpl] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.833 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'mozhe-sync' of type [com.alibaba.dubbo.config.ApplicationConfig] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.839 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'zookeeper' of type [com.alibaba.dubbo.config.RegistryConfig] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.843 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'com.alibaba.dubbo.config.MonitorConfig' of type [com.alibaba.dubbo.config.MonitorConfig] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.843 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'bookService' of type [com.alibaba.dubbo.config.spring.ReferenceBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.847 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'chapterContentService' of type [com.alibaba.dubbo.config.spring.ReferenceBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.862 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'stringToNoneShardingStrategyConfigurationConverter' of type [org.apache.shardingsphere.spring.boot.converter.StringToNoneShardingStrategyConfigurationConverter] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.865 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'spring.cloud.alibaba.seata-io.seata.spring.boot.autoconfigure.properties.SpringCloudAlibabaConfiguration' of type [io.seata.spring.boot.autoconfigure.properties.SpringCloudAlibabaConfiguration] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.867 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'seata-io.seata.spring.boot.autoconfigure.properties.SeataProperties' of type [io.seata.spring.boot.autoconfigure.properties.SeataProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.868 [main] INFO i.s.s.boot.autoconfigure.SeataAutoConfiguration Line:65 - Automatically configure Seata 2020-10-30 12:07:37.968 [main] INFO io.seata.config.FileConfiguration Line:121 - The configuration file used is registry.conf 2020-10-30 12:07:37.978 [main] INFO io.seata.config.ConfigurationFactory Line:65 - load Configuration:FileConfiguration$$EnhancerByCGLIB$$862af1eb 2020-10-30 12:07:37.984 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'configProperties' of type [io.seata.spring.boot.autoconfigure.properties.config.ConfigProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.986 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'configFileProperties' of type [io.seata.spring.boot.autoconfigure.properties.config.ConfigFileProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:37.989 [main] INFO io.seata.config.FileConfiguration Line:121 - The configuration file used is file.conf 2020-10-30 12:07:37.989 [main] INFO io.seata.config.ConfigurationFactory Line:123 - load Configuration:FileConfiguration$$EnhancerByCGLIB$$862af1eb 2020-10-30 12:07:38.038 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'serviceProperties' of type [io.seata.spring.boot.autoconfigure.properties.client.ServiceProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.042 [main] INFO i.seata.spring.annotation.GlobalTransactionScanner Line:164 - Initializing Global Transaction Clients ... 2020-10-30 12:07:38.050 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'threadFactoryProperties' of type [io.seata.spring.boot.autoconfigure.properties.client.ThreadFactoryProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.053 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'transportProperties' of type [io.seata.spring.boot.autoconfigure.properties.client.TransportProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.114 [main] INFO io.seata.core.rpc.netty.NettyClientBootstrap Line:147 - NettyClientBootstrap has started 2020-10-30 12:07:38.115 [main] INFO i.seata.spring.annotation.GlobalTransactionScanner Line:172 - Transaction Manager Client is initialized. applicationId[seata] txServiceGroup[my_test_tx_group] 2020-10-30 12:07:38.124 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'rmProperties' of type [io.seata.spring.boot.autoconfigure.properties.client.RmProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.124 [main] INFO io.seata.rm.datasource.AsyncWorker Line:125 - Async Commit Buffer Limit: 10000 2020-10-30 12:07:38.125 [main] INFO io.seata.rm.datasource.xa.ResourceManagerXA Line:40 - ResourceManagerXA init ... 2020-10-30 12:07:38.130 [main] INFO io.seata.core.rpc.netty.NettyClientBootstrap Line:147 - NettyClientBootstrap has started 2020-10-30 12:07:38.131 [main] INFO i.seata.spring.annotation.GlobalTransactionScanner Line:177 - Resource Manager is initialized. applicationId[seata] txServiceGroup[my_test_tx_group] 2020-10-30 12:07:38.131 [main] INFO i.seata.spring.annotation.GlobalTransactionScanner Line:181 - Global Transaction Clients are initialized. 2020-10-30 12:07:38.152 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'spring.shardingsphere.sharding-org.apache.shardingsphere.shardingjdbc.spring.boot.sharding.SpringBootShardingRuleConfigurationProperties' of type [org.apache.shardingsphere.shardingjdbc.spring.boot.sharding.SpringBootShardingRuleConfigurationProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.154 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'spring.shardingsphere.masterslave-org.apache.shardingsphere.shardingjdbc.spring.boot.masterslave.SpringBootMasterSlaveRuleConfigurationProperties' of type [org.apache.shardingsphere.shardingjdbc.spring.boot.masterslave.SpringBootMasterSlaveRuleConfigurationProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.156 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'spring.shardingsphere.encrypt-org.apache.shardingsphere.shardingjdbc.spring.boot.encrypt.SpringBootEncryptRuleConfigurationProperties' of type [org.apache.shardingsphere.shardingjdbc.spring.boot.encrypt.SpringBootEncryptRuleConfigurationProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.159 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'spring.shardingsphere.shadow-org.apache.shardingsphere.shardingjdbc.spring.boot.shadow.SpringBootShadowRuleConfigurationProperties' of type [org.apache.shardingsphere.shardingjdbc.spring.boot.shadow.SpringBootShadowRuleConfigurationProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.161 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'spring.shardingsphere-org.apache.shardingsphere.shardingjdbc.spring.boot.common.SpringBootPropertiesConfigurationProperties' of type [org.apache.shardingsphere.shardingjdbc.spring.boot.common.SpringBootPropertiesConfigurationProperties] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.345 [main] INFO o.s.c.s.PostProcessorRegistrationDelegate$BeanPostProcessorChecker Line:335 - Bean 'org.apache.shardingsphere.shardingjdbc.spring.boot.SpringBootConfiguration' of type [org.apache.shardingsphere.shardingjdbc.spring.boot.SpringBootConfiguration$$EnhancerBySpringCGLIB$$e113701f] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying) 2020-10-30 12:07:38.678 [main] INFO o.s.boot.web.embedded.tomcat.TomcatWebServer Line:108 - Tomcat initialized with port(s): 9082 (http) 2020-10-30 12:07:38.688 [main] INFO org.apache.coyote.http11.Http11NioProtocol Line:173 - Initializing ProtocolHandler ["http-nio-9082"] 2020-10-30 12:07:38.689 [main] INFO org.apache.catalina.core.StandardService Line:173 - Starting service [Tomcat] 2020-10-30 12:07:38.689 [main] INFO org.apache.catalina.core.StandardEngine Line:173 - Starting Servlet engine: [Apache Tomcat/9.0.38] 2020-10-30 12:07:38.840 [main] INFO o.a.c.core.ContainerBase.[Tomcat].[localhost].[/] Line:173 - Initializing Spring embedded WebApplicationContext 2020-10-30 12:07:38.840 [main] INFO o.s.b.w.s.c.ServletWebServerApplicationContext Line:285 - Root WebApplicationContext: initialization completed in 2398 ms Loading class com.mysql.jdbc.Driver'. This is deprecated. The new driver class iscom.mysql.cj.jdbc.Driver'. The driver is automatically registered via the SPI and manual loading of the driver class is generally unnecessary. 2020-10-30 12:07:39.125 [main] INFO com.alibaba.druid.pool.DruidDataSource Line:930 - {dataSource-1} inited 2020-10-30 12:07:39.234 [main] INFO com.alibaba.druid.pool.DruidDataSource Line:930 - {dataSource-2} inited 2020-10-30 12:07:39.319 [main] INFO o.a.shardingsphere.core.log.ConfigurationLogger Line:104 - ShardingRuleConfiguration: defaultDataSourceName: ds0 tables: t_document: actualDataNodes: ds0.t_document_0$->{1..6} logicTable: t_document tableStrategy: standard: preciseAlgorithmClassName: com.mozhe.sync.sharding.DocumentShardingAlgorithm shardingColumn: uid t_document_change: actualDataNodes: ds0.t_document_change202009,ds0.t_document_change202010,ds0.t_document_change202011 logicTable: t_document_change tableStrategy: standard: preciseAlgorithmClassName: com.mozhe.sync.sharding.DocumentChangeShardingAlgorithm shardingColumn: create_time t_chapter: actualDataNodes: ds0.t_chapter$->{1..5} logicTable: t_chapter tableStrategy: standard: preciseAlgorithmClassName: com.mozhe.sync.sharding.ChapterShardingAlgorithm shardingColumn: uid t_chapter_content: actualDataNodes: ds1.t_chapter_content$->{1..5} logicTable: t_chapter_content tableStrategy: standard: preciseAlgorithmClassName: com.mozhe.sync.sharding.ChapterContentShardingAlgorithm shardingColumn: uid

2020-10-30 12:07:39.320 [main] INFO o.a.shardingsphere.core.log.ConfigurationLogger Line:104 - Properties: sql.show: 'true'

2020-10-30 12:07:39.333 [main] INFO ShardingSphere-metadata Line:131 - Loading 4 logic tables' meta data. 2020-10-30 12:07:39.372 [main] INFO ShardingSphere-metadata Line:70 - Loading 26 tables' meta data. 2020-10-30 12:07:39.480 [main] INFO ShardingSphere-metadata Line:59 - Meta data load finished, cost 160 milliseconds. 2020-10-30 12:07:39.487 [main] INFO io.seata.config.FileConfiguration Line:121 - The configuration file used is seata.conf 2020-10-30 12:07:39.559 [main] INFO io.seata.core.rpc.netty.NettyClientChannelManager Line:99 - will connect to 127.0.0.1:8091 2020-10-30 12:07:39.560 [main] INFO io.seata.core.rpc.netty.RmNettyRemotingClient Line:244 - RM will register :jdbc:mysql://127.0.0.1:3306/mozhe_sync 2020-10-30 12:07:39.563 [main] INFO io.seata.core.rpc.netty.NettyPoolableFactory Line:56 - NettyPool create channel to transactionRole:RMROLE,address:127.0.0.1:8091,msg:< RegisterRMRequest{resourceIds='jdbc:mysql://127.0.0.1:3306/mozhe_sync', applicationId='seata', transactionServiceGroup='my_test_tx_group'} > 2020-10-30 12:07:39.859 [main] INFO io.seata.core.rpc.netty.RmNettyRemotingClient Line:151 - register RM success. client version:1.3.0, server version:1.3.0,channel:[id: 0x4017f0c1, L:/127.0.0.1:65143 - R:/127.0.0.1:8091] 2020-10-30 12:07:39.866 [main] INFO io.seata.core.rpc.netty.NettyPoolableFactory Line:81 - register success, cost 49 ms, version:1.3.0,role:RMROLE,channel:[id: 0x4017f0c1, L:/127.0.0.1:65143 - R:/127.0.0.1:8091] 2020-10-30 12:07:39.866 [main] INFO io.seata.core.rpc.netty.RmNettyRemotingClient Line:189 - will register resourceId:jdbc:mysql://127.0.0.1:3306/mozhe 2020-10-30 12:07:39.868 [NettyClientSelector_RMROLE_1_1] INFO io.seata.rm.AbstractRMHandler Line:155 - the rm client received response msg [version=1.3.0,extraData=null,identified=true,resultCode=null,msg=null] from tc server. 2020-10-30 12:07:39.870 [main] INFO i.s.s.a.datasource.SeataAutoDataSourceProxyCreator Line:45 - Auto proxy of [shardingDataSource] 2020-10-30 12:07:39.875 [main] INFO org.springframework.aop.framework.CglibAopProxy Line:262 - Unable to proxy interface-implementing method [public final org.apache.shardingsphere.shardingjdbc.jdbc.core.connection.ShardingConnection org.apache.shardingsphere.shardingjdbc.jdbc.core.datasource.ShardingDataSource.getConnection()] because it is marked as final: Consider using interface-based JDK proxies instead! 2020-10-30 12:07:39.875 [main] INFO org.springframework.aop.framework.CglibAopProxy Line:262 - Unable to proxy interface-implementing method [public final void org.apache.shardingsphere.shardingjdbc.jdbc.adapter.AbstractDataSourceAdapter.close() throws java.lang.Exception] because it is marked as final: Consider using interface-based JDK proxies instead! 2020-10-30 12:07:39.876 [main] INFO org.springframework.aop.framework.CglibAopProxy Line:262 - Unable to proxy interface-implementing method [public final java.sql.Connection org.apache.shardingsphere.shardingjdbc.jdbc.adapter.AbstractDataSourceAdapter.getConnection(java.lang.String,java.lang.String) throws java.sql.SQLException] because it is marked as final: Consider using interface-based JDK proxies instead! 2020-10-30 12:07:39.876 [main] INFO org.springframework.aop.framework.CglibAopProxy Line:262 - Unable to proxy interface-implementing method [public final java.util.logging.Logger org.apache.shardingsphere.shardingjdbc.jdbc.adapter.AbstractDataSourceAdapter.getParentLogger()] because it is marked as final: Consider using interface-based JDK proxies instead! 2020-10-30 12:07:39.876 [main] INFO org.springframework.aop.framework.CglibAopProxy Line:262 - Unable to proxy interface-implementing method [public final int org.apache.shardingsphere.shardingjdbc.jdbc.unsupported.AbstractUnsupportedOperationDataSource.getLoginTimeout() throws java.sql.SQLException] because it is marked as final: Consider using interface-based JDK proxies instead! 2020-10-30 12:07:39.876 [main] INFO org.springframework.aop.framework.CglibAopProxy Line:262 - Unable to proxy interface-implementing method [public final void org.apache.shardingsphere.shardingjdbc.jdbc.unsupported.AbstractUnsupportedOperationDataSource.setLoginTimeout(int) throws java.sql.SQLException] because it is marked as final: Consider using interface-based JDK proxies instead! 2020-10-30 12:07:39.876 [main] INFO org.springframework.aop.framework.CglibAopProxy Line:262 - Unable to proxy interface-implementing method [public final java.lang.Object org.apache.shardingsphere.shardingjdbc.jdbc.adapter.WrapperAdapter.unwrap(java.lang.Class) throws java.sql.SQLException] because it is marked as final: Consider using interface-based JDK proxies instead! 2020-10-30 12:07:39.877 [main] INFO org.springframework.aop.framework.CglibAopProxy Line:262 - Unable to proxy interface-implementing method [public final boolean org.apache.shardingsphere.shardingjdbc.jdbc.adapter.WrapperAdapter.isWrapperFor(java.lang.Class)] because it is marked as final: Consider using interface-based JDK proxies instead! 2020-10-30 12:07:40.259 [main] INFO o.s.scheduling.concurrent.ThreadPoolTaskExecutor Line:181 - Initializing ExecutorService 2020-10-30 12:07:40.260 [main] INFO o.s.scheduling.concurrent.ThreadPoolTaskExecutor Line:181 - Initializing ExecutorService 'threadPoolTaskExecutor' 2020-10-30 12:07:40.297 [main] WARN t.m.m.mapperhelper.resolve.DefaultEntityResolve Line:154 - 通用 Mapper 警告信息: <[EntityColumn{table=t_document, property='documentType', column='document_type', javaType=int, jdbcType=null, typeHandler=null, id=false, identity=false, blob=false, generator='null', orderBy='null', orderPriority='0', insertable=true, updatable=true, order=DEFAULT}]> 使用了基本类型，基本类型在动态 SQL 中由于存在默认值，因此任何时候都不等于 null，建议修改基本类型为对应的包装类型! 2020-10-30 12:07:40.297 [main] WARN t.m.m.mapperhelper.resolve.DefaultEntityResolve Line:154 - 通用 Mapper 警告信息: <[EntityColumn{table=t_document, property='status', column='status', javaType=int, jdbcType=null, typeHandler=null, id=false, identity=false, blob=false, generator='null', orderBy='null', orderPriority='0', insertable=true, updatable=true, order=DEFAULT}]> 使用了基本类型，基本类型在动态 SQL 中由于存在默认值，因此任何时候都不等于 null，建议修改基本类型为对应的包装类型! 2020-10-30 12:07:41.494 [main] INFO org.mongodb.driver.cluster Line:71 - Cluster created with settings {hosts=[127.0.0.1:27017], mode=SINGLE, requiredClusterType=UNKNOWN, serverSelectionTimeout='30000 ms'} 2020-10-30 12:07:41.542 [cluster-ClusterId{value='5f9b918dc242e61a75038cce', description='null'}-127.0.0.1:27017] INFO org.mongodb.driver.connection Line:71 - Opened connection [connectionId{localValue:1, serverValue:450}] to 127.0.0.1:27017 2020-10-30 12:07:41.546 [cluster-ClusterId{value='5f9b918dc242e61a75038cce', description='null'}-127.0.0.1:27017] INFO org.mongodb.driver.cluster Line:71 - Monitor thread successfully connected to server with description ServerDescription{address=127.0.0.1:27017, type=STANDALONE, state=CONNECTED, ok=true, minWireVersion=0, maxWireVersion=9, maxDocumentSize=16777216, logicalSessionTimeoutMinutes=30, roundTripTimeNanos=2412670} 2020-10-30 12:07:41.901 [main] INFO org.apache.curator.utils.Compatibility Line:41 - Running in ZooKeeper 3.4.x compatibility mode 2020-10-30 12:07:41.926 [main] INFO o.a.curator.framework.imps.CuratorFrameworkImpl Line:290 - Starting 2020-10-30 12:07:41.931 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:zookeeper.version=3.4.6-1569965, built on 02/20/2014 09:09 GMT 2020-10-30 12:07:41.931 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:host.name=DESKTOP-F2C8IF8 2020-10-30 12:07:41.931 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:java.version=1.8.0_181 2020-10-30 12:07:41.932 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:java.vendor=Oracle Corporation 2020-10-30 12:07:41.932 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:java.home=D:\tools dev\Java\jdk1.8.0_181\jre 2020-10-30 12:07:41.932 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:java.class.path=D:\tools dev\Java\jdk1.8.0_181\jre\lib\charsets.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\deploy.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\access-bridge-64.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\cldrdata.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\dnsns.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\jaccess.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\jfxrt.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\localedata.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\nashorn.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\sunec.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\sunjce_provider.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\sunmscapi.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\sunpkcs11.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\ext\zipfs.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\javaws.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\jce.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\jfr.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\jfxswt.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\jsse.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\management-agent.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\plugin.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\resources.jar;D:\tools dev\Java\jdk1.8.0_181\jre\lib\rt.jar;D:\work space\mozhe\IdeaProjects\mozhe\mozhe-sync\mozhe-sync-service\target\classes;D:\work space\mozhe\IdeaProjects\mozhe\mozhe-sync\mozhe-sync-mapper\target\classes;D:\work space\mozhe\IdeaProjects\mozhe\mozhe-sync\mozhe-sync-interface\target\classes;D:\work space\mozhe\IdeaProjects\mozhe\mozhe-transfer\mozhe-transfer-interface\target\classes;D:\work space\mozhe\IdeaProjects\mozhe\mozhe-manager\mozhe-manager-interface\target\classes;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter-data-mongodb\2.3.4.RELEASE\spring-boot-starter-data-mongodb-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter\2.3.4.RELEASE\spring-boot-starter-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot\2.3.4.RELEASE\spring-boot-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter-logging\2.3.4.RELEASE\spring-boot-starter-logging-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\apache\logging\log4j\log4j-to-slf4j\2.13.3\log4j-to-slf4j-2.13.3.jar;D:\tools dev\maven-3.6.1\repo\org\apache\logging\log4j\log4j-api\2.13.3\log4j-api-2.13.3.jar;D:\tools dev\maven-3.6.1\repo\org\slf4j\jul-to-slf4j\1.7.30\jul-to-slf4j-1.7.30.jar;D:\tools dev\maven-3.6.1\repo\org\yaml\snakeyaml\1.26\snakeyaml-1.26.jar;D:\tools dev\maven-3.6.1\repo\org\mongodb\mongodb-driver-sync\4.0.5\mongodb-driver-sync-4.0.5.jar;D:\tools dev\maven-3.6.1\repo\org\mongodb\bson\4.0.5\bson-4.0.5.jar;D:\tools dev\maven-3.6.1\repo\org\mongodb\mongodb-driver-core\4.0.5\mongodb-driver-core-4.0.5.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\data\spring-data-mongodb\3.0.4.RELEASE\spring-data-mongodb-3.0.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-tx\5.2.9.RELEASE\spring-tx-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-beans\5.2.9.RELEASE\spring-beans-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-expression\5.2.9.RELEASE\spring-expression-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\data\spring-data-commons\2.3.4.RELEASE\spring-data-commons-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\io\seata\seata-spring-boot-starter\1.3.0\seata-spring-boot-starter-1.3.0.jar;D:\tools dev\maven-3.6.1\repo\io\seata\seata-all\1.3.0\seata-all-1.3.0.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-all\4.1.52.Final\netty-all-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\com\typesafe\config\1.2.1\config-1.2.1.jar;D:\tools dev\maven-3.6.1\repo\commons-lang\commons-lang\2.6\commons-lang-2.6.jar;D:\tools dev\maven-3.6.1\repo\commons-pool\commons-pool\1.6\commons-pool-1.6.jar;D:\tools dev\maven-3.6.1\repo\cglib\cglib\3.1\cglib-3.1.jar;D:\tools dev\maven-3.6.1\repo\org\ow2\asm\asm\4.2\asm-4.2.jar;D:\tools dev\maven-3.6.1\repo\aopalliance\aopalliance\1.0\aopalliance-1.0.jar;D:\tools dev\maven-3.6.1\repo\com\github\ben-manes\caffeine\caffeine\2.8.5\caffeine-2.8.5.jar;D:\tools dev\maven-3.6.1\repo\org\checkerframework\checker-qual\3.4.1\checker-qual-3.4.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-jdbc-spring-boot-starter\4.1.1\sharding-jdbc-spring-boot-starter-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-spring-boot-util\4.1.1\sharding-spring-boot-util-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-core-common\4.1.1\sharding-core-common-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-common\4.1.1\shardingsphere-common-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-spi\4.1.1\shardingsphere-spi-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-core-api\4.1.1\sharding-core-api-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\encrypt-core-api\4.1.1\encrypt-core-api-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\encrypt-core-common\4.1.1\encrypt-core-common-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\codehaus\groovy\groovy\2.4.5\groovy-2.4.5-indy.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-transaction-spring\4.1.1\sharding-transaction-spring-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-jdbc-core\4.1.1\sharding-jdbc-core-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-sql92\4.1.1\shardingsphere-sql-parser-sql92-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-engine\4.1.1\shardingsphere-sql-parser-engine-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-spi\4.1.1\shardingsphere-sql-parser-spi-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-statement\4.1.1\shardingsphere-sql-parser-statement-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\commons\commons-collections4\4.2\commons-collections4-4.2.jar;D:\tools dev\maven-3.6.1\repo\org\antlr\antlr4-runtime\4.7.2\antlr4-runtime-4.7.2.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-mysql\4.1.1\shardingsphere-sql-parser-mysql-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-postgresql\4.1.1\shardingsphere-sql-parser-postgresql-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-oracle\4.1.1\shardingsphere-sql-parser-oracle-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-sqlserver\4.1.1\shardingsphere-sql-parser-sqlserver-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-core-route\4.1.1\sharding-core-route-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\master-slave-core-route\4.1.1\master-slave-core-route-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-core-rewrite\4.1.1\sharding-core-rewrite-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\encrypt-core-rewrite\4.1.1\encrypt-core-rewrite-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shadow-core-rewrite\4.1.1\shadow-core-rewrite-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-core-execute\4.1.1\sharding-core-execute-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-core-merge\4.1.1\sharding-core-merge-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\encrypt-core-merge\4.1.1\encrypt-core-merge-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\org\slf4j\jcl-over-slf4j\1.7.30\jcl-over-slf4j-1.7.30.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-transaction-base-seata-at\4.1.0\sharding-transaction-base-seata-at-4.1.0.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\sharding-transaction-core\4.1.0\sharding-transaction-core-4.1.0.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-pluggable\4.1.0\shardingsphere-pluggable-4.1.0.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-sql-parser-binder\4.1.0\shardingsphere-sql-parser-binder-4.1.0.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-route\4.1.0\shardingsphere-route-4.1.0.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-rewrite-engine\4.1.0\shardingsphere-rewrite-engine-4.1.0.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-executor\4.1.0\shardingsphere-executor-4.1.0.jar;D:\tools dev\maven-3.6.1\repo\org\apache\shardingsphere\shardingsphere-merge\4.1.0\shardingsphere-merge-4.1.0.jar;D:\work space\mozhe\IdeaProjects\mozhe\mozhe-common\target\classes;D:\work space\mozhe\IdeaProjects\mozhe\mozhe-manager\mozhe-manager-model\target\classes;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter-web\2.3.4.RELEASE\spring-boot-starter-web-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter-json\2.3.4.RELEASE\spring-boot-starter-json-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\com\fasterxml\jackson\datatype\jackson-datatype-jdk8\2.11.2\jackson-datatype-jdk8-2.11.2.jar;D:\tools dev\maven-3.6.1\repo\com\fasterxml\jackson\datatype\jackson-datatype-jsr310\2.11.2\jackson-datatype-jsr310-2.11.2.jar;D:\tools dev\maven-3.6.1\repo\com\fasterxml\jackson\module\jackson-module-parameter-names\2.11.2\jackson-module-parameter-names-2.11.2.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-web\5.2.9.RELEASE\spring-web-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-webmvc\5.2.9.RELEASE\spring-webmvc-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter-jdbc\2.3.4.RELEASE\spring-boot-starter-jdbc-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\com\zaxxer\HikariCP\3.4.5\HikariCP-3.4.5.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-jdbc\5.2.9.RELEASE\spring-jdbc-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\junit\junit\4.13\junit-4.13.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-core\5.2.9.RELEASE\spring-core-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-jcl\5.2.9.RELEASE\spring-jcl-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter-aop\2.3.4.RELEASE\spring-boot-starter-aop-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-aop\5.2.9.RELEASE\spring-aop-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\aspectj\aspectjweaver\1.9.6\aspectjweaver-1.9.6.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter-tomcat\2.3.4.RELEASE\spring-boot-starter-tomcat-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\jakarta\annotation\jakarta.annotation-api\1.3.5\jakarta.annotation-api-1.3.5.jar;D:\tools dev\maven-3.6.1\repo\org\apache\tomcat\embed\tomcat-embed-core\9.0.38\tomcat-embed-core-9.0.38.jar;D:\tools dev\maven-3.6.1\repo\org\glassfish\jakarta.el\3.0.3\jakarta.el-3.0.3.jar;D:\tools dev\maven-3.6.1\repo\org\apache\tomcat\embed\tomcat-embed-websocket\9.0.38\tomcat-embed-websocket-9.0.38.jar;D:\tools dev\maven-3.6.1\repo\commons-codec\commons-codec\1.14\commons-codec-1.14.jar;D:\tools dev\maven-3.6.1\repo\com\google\guava\guava\23.0\guava-23.0.jar;D:\tools dev\maven-3.6.1\repo\com\google\code\findbugs\jsr305\1.3.9\jsr305-1.3.9.jar;D:\tools dev\maven-3.6.1\repo\com\google\errorprone\error_prone_annotations\2.0.18\error_prone_annotations-2.0.18.jar;D:\tools dev\maven-3.6.1\repo\com\google\j2objc\j2objc-annotations\1.1\j2objc-annotations-1.1.jar;D:\tools dev\maven-3.6.1\repo\org\codehaus\mojo\animal-sniffer-annotations\1.14\animal-sniffer-annotations-1.14.jar;D:\tools dev\maven-3.6.1\repo\mysql\mysql-connector-java\8.0.21\mysql-connector-java-8.0.21.jar;D:\tools dev\maven-3.6.1\repo\org\mybatis\mybatis-spring\1.3.1\mybatis-spring-1.3.1.jar;D:\tools dev\maven-3.6.1\repo\org\mybatis\mybatis\3.4.5\mybatis-3.4.5.jar;D:\tools dev\maven-3.6.1\repo\tk\mybatis\mapper\4.1.4\mapper-4.1.4.jar;D:\tools dev\maven-3.6.1\repo\javax\persistence\persistence-api\1.0\persistence-api-1.0.jar;D:\tools dev\maven-3.6.1\repo\com\github\pagehelper\pagehelper\5.1.2\pagehelper-5.1.2.jar;D:\tools dev\maven-3.6.1\repo\com\github\jsqlparser\jsqlparser\1.0\jsqlparser-1.0.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\fastjson\1.2.54\fastjson-1.2.54.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\druid-spring-boot-starter\1.1.10\druid-spring-boot-starter-1.1.10.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\druid\1.1.10\druid-1.1.10.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-autoconfigure\2.3.4.RELEASE\spring-boot-autoconfigure-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\boot\spring-boot-starter-data-redis\2.3.4.RELEASE\spring-boot-starter-data-redis-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\data\spring-data-redis\2.3.4.RELEASE\spring-data-redis-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\data\spring-data-keyvalue\2.3.4.RELEASE\spring-data-keyvalue-2.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-oxm\5.2.9.RELEASE\spring-oxm-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-context-support\5.2.9.RELEASE\spring-context-support-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\io\lettuce\lettuce-core\5.3.4.RELEASE\lettuce-core-5.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\redis\clients\jedis\3.3.0\jedis-3.3.0.jar;D:\tools dev\maven-3.6.1\repo\org\apache\commons\commons-pool2\2.8.1\commons-pool2-2.8.1.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\cloud\spring-cloud-starter-alibaba-nacos-discovery\2.2.2.RELEASE\spring-cloud-starter-alibaba-nacos-discovery-2.2.2.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\nacos\nacos-client\1.3.2\nacos-client-1.3.2.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\nacos\nacos-common\1.3.2\nacos-common-1.3.2.jar;D:\tools dev\maven-3.6.1\repo\org\apache\httpcomponents\httpasyncclient\4.1.4\httpasyncclient-4.1.4.jar;D:\tools dev\maven-3.6.1\repo\org\apache\httpcomponents\httpcore-nio\4.4.13\httpcore-nio-4.4.13.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\nacos\nacos-api\1.3.2\nacos-api-1.3.2.jar;D:\tools dev\maven-3.6.1\repo\io\prometheus\simpleclient\0.5.0\simpleclient-0.5.0.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\spring\spring-context-support\1.0.9\spring-context-support-1.0.9.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-commons\2.2.5.RELEASE\spring-cloud-commons-2.2.5.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\security\spring-security-crypto\5.3.4.RELEASE\spring-security-crypto-5.3.4.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-context\2.2.5.RELEASE\spring-cloud-context-2.2.5.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-starter-netflix-ribbon\2.2.5.RELEASE\spring-cloud-starter-netflix-ribbon-2.2.5.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-netflix-ribbon\2.2.5.RELEASE\spring-cloud-netflix-ribbon-2.2.5.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-netflix-archaius\2.2.5.RELEASE\spring-cloud-netflix-archaius-2.2.5.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-starter-netflix-archaius\2.2.5.RELEASE\spring-cloud-starter-netflix-archaius-2.2.5.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\commons-configuration\commons-configuration\1.8\commons-configuration-1.8.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\ribbon\ribbon\2.3.0\ribbon-2.3.0.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\ribbon\ribbon-transport\2.3.0\ribbon-transport-2.3.0.jar;D:\tools dev\maven-3.6.1\repo\io\reactivex\rxnetty-contexts\0.4.9\rxnetty-contexts-0.4.9.jar;D:\tools dev\maven-3.6.1\repo\io\reactivex\rxnetty-servo\0.4.9\rxnetty-servo-0.4.9.jar;D:\tools dev\maven-3.6.1\repo\javax\inject\javax.inject\1\javax.inject-1.jar;D:\tools dev\maven-3.6.1\repo\io\reactivex\rxnetty\0.4.9\rxnetty-0.4.9.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\ribbon\ribbon-core\2.3.0\ribbon-core-2.3.0.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\ribbon\ribbon-httpclient\2.3.0\ribbon-httpclient-2.3.0.jar;D:\tools dev\maven-3.6.1\repo\commons-collections\commons-collections\3.2.2\commons-collections-3.2.2.jar;D:\tools dev\maven-3.6.1\repo\com\sun\jersey\jersey-client\1.19.1\jersey-client-1.19.1.jar;D:\tools dev\maven-3.6.1\repo\com\sun\jersey\jersey-core\1.19.1\jersey-core-1.19.1.jar;D:\tools dev\maven-3.6.1\repo\javax\ws\rs\jsr311-api\1.1.1\jsr311-api-1.1.1.jar;D:\tools dev\maven-3.6.1\repo\com\sun\jersey\contribs\jersey-apache-client4\1.19.1\jersey-apache-client4-1.19.1.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\servo\servo-core\0.10.1\servo-core-0.10.1.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\servo\servo-internal\0.10.1\servo-internal-0.10.1.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\netflix-commons\netflix-commons-util\0.1.1\netflix-commons-util-0.1.1.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\ribbon\ribbon-loadbalancer\2.3.0\ribbon-loadbalancer-2.3.0.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\netflix-commons\netflix-statistics\0.1.1\netflix-statistics-0.1.1.jar;D:\tools dev\maven-3.6.1\repo\io\reactivex\rxjava\1.3.8\rxjava-1.3.8.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-starter-openfeign\2.2.2.RELEASE\spring-cloud-starter-openfeign-2.2.2.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-starter\2.2.2.RELEASE\spring-cloud-starter-2.2.2.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\security\spring-security-rsa\1.0.9.RELEASE\spring-security-rsa-1.0.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\bouncycastle\bcpkix-jdk15on\1.64\bcpkix-jdk15on-1.64.jar;D:\tools dev\maven-3.6.1\repo\org\bouncycastle\bcprov-jdk15on\1.64\bcprov-jdk15on-1.64.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\cloud\spring-cloud-openfeign-core\2.2.2.RELEASE\spring-cloud-openfeign-core-2.2.2.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\io\github\openfeign\form\feign-form-spring\3.8.0\feign-form-spring-3.8.0.jar;D:\tools dev\maven-3.6.1\repo\io\github\openfeign\form\feign-form\3.8.0\feign-form-3.8.0.jar;D:\tools dev\maven-3.6.1\repo\commons-fileupload\commons-fileupload\1.4\commons-fileupload-1.4.jar;D:\tools dev\maven-3.6.1\repo\io\github\openfeign\feign-core\10.7.4\feign-core-10.7.4.jar;D:\tools dev\maven-3.6.1\repo\io\github\openfeign\feign-slf4j\10.7.4\feign-slf4j-10.7.4.jar;D:\tools dev\maven-3.6.1\repo\io\github\openfeign\feign-hystrix\10.7.4\feign-hystrix-10.7.4.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\archaius\archaius-core\0.7.6\archaius-core-0.7.6.jar;D:\tools dev\maven-3.6.1\repo\com\netflix\hystrix\hystrix-core\1.5.18\hystrix-core-1.5.18.jar;D:\tools dev\maven-3.6.1\repo\org\hdrhistogram\HdrHistogram\2.1.9\HdrHistogram-2.1.9.jar;D:\tools dev\maven-3.6.1\repo\commons-logging\commons-logging\1.2\commons-logging-1.2.jar;D:\tools dev\maven-3.6.1\repo\org\apache\commons\commons-lang3\3.7\commons-lang3-3.7.jar;D:\tools dev\maven-3.6.1\repo\commons-io\commons-io\1.3.2\commons-io-1.3.2.jar;D:\tools dev\maven-3.6.1\repo\org\jsoup\jsoup\1.9.2\jsoup-1.9.2.jar;D:\tools dev\maven-3.6.1\repo\net\lingala\zip4j\zip4j\1.3.2\zip4j-1.3.2.jar;D:\tools dev\maven-3.6.1\repo\com\squareup\okhttp3\okhttp\3.5.0\okhttp-3.5.0.jar;D:\tools dev\maven-3.6.1\repo\com\squareup\okio\okio\1.11.0\okio-1.11.0.jar;D:\tools dev\maven-3.6.1\repo\javax\javaee-api\7.0\javaee-api-7.0.jar;D:\tools dev\maven-3.6.1\repo\com\sun\mail\javax.mail\1.5.0\javax.mail-1.5.0.jar;D:\tools dev\maven-3.6.1\repo\com\google\code\gson\gson\2.8.5\gson-2.8.5.jar;D:\tools dev\maven-3.6.1\repo\org\redisson\redisson\3.8.1\redisson-3.8.1.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-common\4.1.52.Final\netty-common-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-codec\4.1.52.Final\netty-codec-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-buffer\4.1.52.Final\netty-buffer-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-transport\4.1.52.Final\netty-transport-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-resolver\4.1.52.Final\netty-resolver-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-resolver-dns\4.1.52.Final\netty-resolver-dns-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-codec-dns\4.1.52.Final\netty-codec-dns-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-handler\4.1.52.Final\netty-handler-4.1.52.Final.jar;D:\tools dev\maven-3.6.1\repo\javax\cache\cache-api\1.1.1\cache-api-1.1.1.jar;D:\tools dev\maven-3.6.1\repo\io\projectreactor\reactor-core\3.3.10.RELEASE\reactor-core-3.3.10.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\reactivestreams\reactive-streams\1.0.3\reactive-streams-1.0.3.jar;D:\tools dev\maven-3.6.1\repo\com\fasterxml\jackson\dataformat\jackson-dataformat-yaml\2.11.2\jackson-dataformat-yaml-2.11.2.jar;D:\tools dev\maven-3.6.1\repo\com\fasterxml\jackson\core\jackson-core\2.11.2\jackson-core-2.11.2.jar;D:\tools dev\maven-3.6.1\repo\com\fasterxml\jackson\core\jackson-databind\2.11.2\jackson-databind-2.11.2.jar;D:\tools dev\maven-3.6.1\repo\com\fasterxml\jackson\core\jackson-annotations\2.11.2\jackson-annotations-2.11.2.jar;D:\tools dev\maven-3.6.1\repo\net\bytebuddy\byte-buddy\1.10.14\byte-buddy-1.10.14.jar;D:\tools dev\maven-3.6.1\repo\org\jodd\jodd-bean\3.7.1\jodd-bean-3.7.1.jar;D:\tools dev\maven-3.6.1\repo\org\jodd\jodd-core\3.7.1\jodd-core-3.7.1.jar;D:\tools dev\maven-3.6.1\repo\com\alipay\alipay-sdk\1.0.0\alipay-sdk-1.0.0.jar;D:\tools dev\maven-3.6.1\repo\com\aliyun\oss\aliyun-sdk-oss\2.8.3\aliyun-sdk-oss-2.8.3.jar;D:\tools dev\maven-3.6.1\repo\org\apache\httpcomponents\httpclient\4.5.12\httpclient-4.5.12.jar;D:\tools dev\maven-3.6.1\repo\org\apache\httpcomponents\httpcore\4.4.13\httpcore-4.4.13.jar;D:\tools dev\maven-3.6.1\repo\org\jdom\jdom\1.1\jdom-1.1.jar;D:\tools dev\maven-3.6.1\repo\com\aliyun\aliyun-java-sdk-sts\2.1.6\aliyun-java-sdk-sts-2.1.6.jar;D:\tools dev\maven-3.6.1\repo\com\taobao\taobao-sdk-auto\1.0\taobao-sdk-auto-1.0.jar;D:\tools dev\maven-3.6.1\repo\com\aliyun\aliyun-java-sdk-core\4.1.1\aliyun-java-sdk-core-4.1.1.jar;D:\tools dev\maven-3.6.1\repo\javax\xml\bind\jaxb-api\2.3.1\jaxb-api-2.3.1.jar;D:\tools dev\maven-3.6.1\repo\javax\activation\javax.activation-api\1.2.0\javax.activation-api-1.2.0.jar;D:\tools dev\maven-3.6.1\repo\com\sun\xml\bind\jaxb-core\2.1.14\jaxb-core-2.1.14.jar;D:\tools dev\maven-3.6.1\repo\com\sun\xml\bind\jaxb-impl\2.1\jaxb-impl-2.1.jar;D:\tools dev\maven-3.6.1\repo\javax\activation\activation\1.1.1\activation-1.1.1.jar;D:\tools dev\maven-3.6.1\repo\com\aliyun\aliyun-java-sdk-green\3.5.1\aliyun-java-sdk-green-3.5.1.jar;D:\tools dev\maven-3.6.1\repo\com\github\wxpay\WXPay-SDK-Java\0.0.4\WXPay-SDK-Java-0.0.4.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\dubbo\2.6.2\dubbo-2.6.2.jar;D:\tools dev\maven-3.6.1\repo\org\springframework\spring-context\5.2.9.RELEASE\spring-context-5.2.9.RELEASE.jar;D:\tools dev\maven-3.6.1\repo\org\jboss\netty\netty\3.2.5.Final\netty-3.2.5.Final.jar;D:\tools dev\maven-3.6.1\repo\org\apache\zookeeper\zookeeper\3.4.6\zookeeper-3.4.6.jar;D:\tools dev\maven-3.6.1\repo\jline\jline\0.9.94\jline-0.9.94.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty\3.7.0.Final\netty-3.7.0.Final.jar;D:\tools dev\maven-3.6.1\repo\org\apache\rocketmq\rocketmq-client\4.5.2\rocketmq-client-4.5.2.jar;D:\tools dev\maven-3.6.1\repo\org\apache\rocketmq\rocketmq-common\4.5.2\rocketmq-common-4.5.2.jar;D:\tools dev\maven-3.6.1\repo\org\apache\rocketmq\rocketmq-remoting\4.5.2\rocketmq-remoting-4.5.2.jar;D:\tools dev\maven-3.6.1\repo\org\apache\rocketmq\rocketmq-logging\4.5.2\rocketmq-logging-4.5.2.jar;D:\tools dev\maven-3.6.1\repo\io\netty\netty-tcnative-boringssl-static\2.0.34.Final\netty-tcnative-boringssl-static-2.0.34.Final.jar;D:\tools dev\maven-3.6.1\repo\com\github\sgroschupf\zkclient\0.1\zkclient-0.1.jar;D:\tools dev\maven-3.6.1\repo\log4j\log4j\1.2.14\log4j-1.2.14.jar;D:\tools dev\maven-3.6.1\repo\org\apache\curator\curator-framework\4.0.1\curator-framework-4.0.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\curator\curator-client\4.0.1\curator-client-4.0.1.jar;D:\tools dev\maven-3.6.1\repo\org\apache\curator\curator-recipes\4.0.1\curator-recipes-4.0.1.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\csp\sentinel-core\1.7.0\sentinel-core-1.7.0.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\csp\sentinel-dubbo-adapter\1.7.0\sentinel-dubbo-adapter-1.7.0.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\csp\sentinel-transport-simple-http\1.7.0\sentinel-transport-simple-http-1.7.0.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\csp\sentinel-transport-common\1.7.0\sentinel-transport-common-1.7.0.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\csp\sentinel-datasource-extension\1.8.0\sentinel-datasource-extension-1.8.0.jar;D:\tools dev\maven-3.6.1\repo\com\alibaba\csp\sentinel-parameter-flow-control\1.7.0\sentinel-parameter-flow-control-1.7.0.jar;D:\tools dev\maven-3.6.1\repo\com\googlecode\concurrentlinkedhashmap\concurrentlinkedhashmap-lru\1.4.2\concurrentlinkedhashmap-lru-1.4.2.jar;D:\tools dev\maven-3.6.1\repo\org\javassist\javassist\3.18.1-GA\javassist-3.18.1-GA.jar;D:\tools dev\maven-3.6.1\repo\org\slf4j\slf4j-api\1.7.25\slf4j-api-1.7.25.jar;D:\tools dev\maven-3.6.1\repo\ch\qos\logback\logback-classic\1.2.3\logback-classic-1.2.3.jar;D:\tools dev\maven-3.6.1\repo\ch\qos\logback\logback-core\1.2.3\logback-core-1.2.3.jar;D:\tools dev\maven-3.6.1\repo\org\projectlombok\lombok\1.18.6\lombok-1.18.6.jar;D:\tools dev\maven-3.6.1\repo\cn\com\analysys\javasdk\4.1.0\javasdk-4.1.0.jar;D:\tools dev\maven-3.6.1\repo\com\huaweicloud\esdk-obs-java\3.20.1\esdk-obs-java-3.20.1.jar;D:\tools dev\maven-3.6.1\repo\com\mozhe\sso\mz-sso-sdk\1.0\mz-sso-sdk-1.0.jar;D:\tools dev\maven-3.6.1\repo\com\mozhe\docsync\DocSync\4.1\DocSync-4.1.jar;D:\tools dev\maven-3.6.1\repo\com\mozhe\docsync\ProtobufAdapter\1.4\ProtobufAdapter-1.4.jar;D:\tools dev\maven-3.6.1\repo\com\google\protobuf\protobuf-java\3.13.0\protobuf-java-3.13.0.jar;D:\tools dev\maven-3.6.1\repo\com\mozhe\docsync\JsonAdapter\0.1\JsonAdapter-0.1.jar;D:\tools dev\JetBrains\IntelliJ IDEA 2019.3.3\lib\idea_rt.jar;C:\Users\mozhe.IntelliJIdea2019.3\system\captureAgent\debugger-agent.jar 2020-10-30 12:07:41.932 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:java.library.path=D:\tools dev\Java\jdk1.8.0_181\bin;C:\Windows\Sun\Java\bin;C:\Windows\system32;C:\Windows;D:\tools dev\xshell\;C:\Program Files (x86)\Common Files\Oracle\Java\javapath;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;"D:\tools dev\Java\jdk1.8.0_181\bin;D:\tools dev\Java\jdk1.8.0_181\jre\bin";D:\tools dev\Git\cmd;D:\tools dev\maven-3.6.1\bin;D:\tools dev\nodejs\;D:\tools dev\Python27;D:\tools dev\maven-3.6.1\lib;C:\Users\mozhe\AppData\Local\Microsoft\WindowsApps;;D:\tools dev\Microsoft VS Code\bin;C:\Users\mozhe\AppData\Roaming\npm;. 2020-10-30 12:07:41.933 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:java.io.tmpdir=C:\Users\mozhe\AppData\Local\Temp\ 2020-10-30 12:07:41.933 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:java.compiler= 2020-10-30 12:07:41.933 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:os.name=Windows 10 2020-10-30 12:07:41.933 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:os.arch=amd64 2020-10-30 12:07:41.933 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:os.version=10.0 2020-10-30 12:07:41.933 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:user.name=mozhe 2020-10-30 12:07:41.933 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:user.home=C:\Users\mozhe 2020-10-30 12:07:41.933 [main] INFO org.apache.zookeeper.ZooKeeper Line:100 - Client environment:user.dir=D:\work space\mozhe\IdeaProjects\mozhe 2020-10-30 12:07:41.935 [main] INFO org.apache.zookeeper.ZooKeeper Line:438 - Initiating client connection, connectString=127.0.0.1:2181 sessionTimeout=60000 watcher=org.apache.curator.ConnectionState@1a1e38ab 2020-10-30 12:07:41.947 [main-SendThread(127.0.0.1:2181)] INFO org.apache.zookeeper.ClientCnxn Line:975 - Opening socket connection to server 127.0.0.1/127.0.0.1:2181. Will not attempt to authenticate using SASL (unknown error) 2020-10-30 12:07:41.948 [main-SendThread(127.0.0.1:2181)] INFO org.apache.zookeeper.ClientCnxn Line:852 - Socket connection established to 127.0.0.1/127.0.0.1:2181, initiating session 2020-10-30 12:07:41.948 [main] INFO o.a.curator.framework.imps.CuratorFrameworkImpl Line:332 - Default schema 2020-10-30 12:07:41.988 [main-SendThread(127.0.0.1:2181)] INFO org.apache.zookeeper.ClientCnxn Line:1235 - Session establishment complete on server 127.0.0.1/127.0.0.1:2181, sessionid = 0x10000095343003a, negotiated timeout = 40000 2020-10-30 12:07:42.000 [main-EventThread] INFO o.a.curator.framework.state.ConnectionStateManager Line:237 - State change: CONNECTED INFO: log output type is: file INFO: log charset is: utf-8 INFO: log base dir is: C:\Users\mozhe\logs\csp\ INFO: log name use pid is: false 2020-10-30 12:07:42.402 [main] INFO i.seata.spring.annotation.GlobalTransactionScanner Line:231 - Bean[com.mozhe.sync.service.impl.TransferServiceImpl] with name [transferServiceImpl] would use interceptor [io.seata.spring.annotation.GlobalTransactionalInterceptor] 2020-10-30 12:07:42.414 [main] INFO com.mozhe.common.config.SpringShutdownHook Line:24 - [SpringShutdownHook] Register ShutdownHook.... 2020-10-30 12:07:42.429 [main] INFO com.mozhe.common.utils.RedissonUtil Line:60 - 成功连接Redis Server,redis://127.0.0.1:6379,dev 2020-10-30 12:07:42.732 [main] INFO org.redisson.Version Line:41 - Redisson 3.8.1 2020-10-30 12:07:42.929 [redisson-netty-4-6] INFO org.redisson.connection.pool.MasterConnectionPool Line:144 - 32 connections initialized for 127.0.0.1/127.0.0.1:6379 2020-10-30 12:07:42.930 [redisson-netty-4-7] INFO o.r.connection.pool.MasterPubSubConnectionPool Line:144 - 1 connections initialized for 127.0.0.1/127.0.0.1:6379 2020-10-30 12:07:43.125 [main] INFO i.seata.spring.annotation.GlobalTransactionScanner Line:231 - Bean[com.mozhe.sync.service.impl.TransferServiceImpl] with name [transferService] would use interceptor [io.seata.spring.annotation.GlobalTransactionalInterceptor] 2020-10-30 12:07:43.145 [main] WARN com.netflix.config.sources.URLConfigurationSource Line:121 - No URLs will be polled as dynamic configuration sources. 2020-10-30 12:07:43.146 [main] INFO com.netflix.config.sources.URLConfigurationSource Line:122 - To enable URLs as dynamic configuration sources, define System property archaius.configurationSource.additionalUrls or make config.properties available on classpath. 2020-10-30 12:07:43.151 [main] WARN com.netflix.config.sources.URLConfigurationSource Line:121 - No URLs will be polled as dynamic configuration sources. 2020-10-30 12:07:43.151 [main] INFO com.netflix.config.sources.URLConfigurationSource Line:122 - To enable URLs as dynamic configuration sources, define System property archaius.configurationSource.additionalUrls or make config.properties available on classpath. 2020-10-30 12:07:44.616 [main] INFO org.springframework.cloud.commons.util.InetUtils Line:170 - Cannot determine local hostname 2020-10-30 12:07:45.985 [main] INFO org.springframework.cloud.commons.util.InetUtils Line:170 - Cannot determine local hostname 2020-10-30 12:07:46.283 [main] INFO org.apache.coyote.http11.Http11NioProtocol Line:173 - Starting ProtocolHandler ["http-nio-9082"] 2020-10-30 12:07:46.301 [main] INFO o.s.boot.web.embedded.tomcat.TomcatWebServer Line:220 - Tomcat started on port(s): 9082 (http) with context path '' 2020-10-30 12:07:46.309 [main] INFO c.a.cloud.nacos.registry.NacosServiceRegistry Line:71 - nacos registry, DEFAULT_GROUP mozhe-sync 192.168.200.1:9082 register finished 2020-10-30 12:07:47.455 [main] INFO org.springframework.cloud.commons.util.InetUtils Line:170 - Cannot determine local hostname 2020-10-30 12:07:47.799 [main] INFO com.mozhe.sync.SyncServiceApplication Line:61 - Started SyncServiceApplication in 14.732 seconds (JVM running for 15.69) 2020-10-30 12:07:47.801 [main] INFO com.mozhe.sync.SyncServiceApplication Line:23 - -------------------complate Sync service--------------------------

run log 2020-10-30 13:04:42.028 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO io.seata.tm.TransactionManagerHolder Line:40 - TransactionManager Singleton io.seata.tm.DefaultTransactionManager@e04a4 2020-10-30 13:04:42.075 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO io.seata.tm.api.DefaultGlobalTransaction Line:108 - Begin new global transaction [192.168.129.1:8091:65427292176781312] 2020-10-30 13:04:42.079 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:47 - 开始全局事务，XID = 192.168.129.1:8091:65427292176781312 2020-10-30 13:04:42.079 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:219 - ------------同步书籍分组开始---------------- 2020-10-30 13:04:42.079 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:220 - 同步书籍分组入参，userUuid:3d47f19529a040c5bfa6cf6500324c2d,newUserId:2 2020-10-30 13:04:44.202 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:222 - 同步书籍分组内容:[] 2020-10-30 13:04:44.203 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - ==> Preparing: select user_sequence from t_user_sequence where user_id = ? limit 1 2020-10-30 13:04:44.238 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - ==> Parameters: 2(Long) 2020-10-30 13:04:44.240 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: select user_sequence from t_user_sequence where user_id = ? limit 1 2020-10-30 13:04:44.240 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@2eb7f24d, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@69946f2e), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@69946f2e, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=19, distinctRow=false, projections=[ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty)]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@7d22a8fa, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@7a78b415, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@6a874785, containsSubquery=false) 2020-10-30 13:04:44.240 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: select user_sequence from t_user_sequence where user_id = ? limit 1 ::: [2] 2020-10-30 13:04:44.244 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - <== Total: 1 上传 -> sequence:246 userId:2 2020-10-30 13:04:44.245 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - ==> Preparing: select user_sequence from t_user_sequence where user_id = ? limit 1 2020-10-30 13:04:44.245 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - ==> Parameters: 2(Long) 2020-10-30 13:04:44.246 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: select user_sequence from t_user_sequence where user_id = ? limit 1 2020-10-30 13:04:44.246 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@2eb7f24d, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@774a6c7e), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@774a6c7e, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=19, distinctRow=false, projections=[ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty)]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@2721b67d, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@2e34df5, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@27605a7a, containsSubquery=false) 2020-10-30 13:04:44.246 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: select user_sequence from t_user_sequence where user_id = ? limit 1 ::: [2] 2020-10-30 13:04:44.247 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - <== Total: 1 2020-10-30 13:04:44.256 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO c.m.s.s.impl.MySqlDocumentBasicDataCenterImpl Line:69 - 开始全局事务，XID = 192.168.129.1:8091:65427292176781312 2020-10-30 13:04:44.257 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.updateUserSequence Line:159 - ==> Preparing: update t_user_sequence set user_sequence = ? where user_id = ? 2020-10-30 13:04:44.260 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.updateUserSequence Line:159 - ==> Parameters: 246(Long), 2(Long) 2020-10-30 13:04:44.321 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: SELECT FROM t_user_sequence LIMIT 1 2020-10-30 13:04:44.321 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@3935478b, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@4c404dc), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@4c404dc, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=7, distinctRow=false, projections=[ShorthandProjection(owner=Optional.empty, actualColumns=[ColumnProjection(owner=null, name=id, alias=Optional.empty), ColumnProjection(owner=null, name=user_id, alias=Optional.empty), ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty), ColumnProjection(owner=null, name=create_time, alias=Optional.empty), ColumnProjection(owner=null, name=update_time, alias=Optional.empty)])]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@3d783b1a, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@6268f7d8, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@7172ed01, containsSubquery=false) 2020-10-30 13:04:44.322 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT FROM t_user_sequence LIMIT 1 2020-10-30 13:04:44.346 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: SELECT id, user_sequence FROM t_user_sequence WHERE user_id = ? FOR UPDATE 2020-10-30 13:04:44.347 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@436cb21c, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@3245e367), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@3245e367, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=23, distinctRow=false, projections=[ColumnProjection(owner=null, name=id, alias=Optional.empty), ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty)]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@7b9e7d49, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@1cb9c6d6, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@3a637b0f, containsSubquery=false) 2020-10-30 13:04:44.347 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT id, user_sequence FROM t_user_sequence WHERE user_id = ? FOR UPDATE ::: [2] 2020-10-30 13:04:44.358 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: update t_user_sequence set user_sequence = ? where user_id = ? 2020-10-30 13:04:44.358 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: UpdateStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.UpdateStatement@6aaf9bef, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@6575b4d8), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@6575b4d8) 2020-10-30 13:04:44.358 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: update t_user_sequence set user_sequence = ? where user_id = ? ::: [246, 2] 2020-10-30 13:04:44.364 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: SELECT id, user_sequence FROM t_user_sequence WHERE (id ) in ( (?) ) 2020-10-30 13:04:44.364 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@15a670fc, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@6bef3636), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@6bef3636, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=23, distinctRow=false, projections=[ColumnProjection(owner=null, name=id, alias=Optional.empty), ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty)]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@262035a9, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@3e114249, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@1816f4e7, containsSubquery=false) 2020-10-30 13:04:44.364 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT id, user_sequence FROM t_user_sequence WHERE (id ) in ( (?) ) ::: [6] 2020-10-30 13:04:44.365 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.updateUserSequence Line:159 - <== Updates: 1 2020-10-30 13:04:44.477 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: INSERT INTO undo_log (branch_id, xid, context, rollback_info, log_status, log_created, log_modified) VALUES (?, ?, ?, ?, ?, now(6), now(6)) 2020-10-30 13:04:44.477 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: InsertStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.InsertStatement@222bda59, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@373222b0), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@373222b0, columnNames=[branch_id, xid, context, rollback_info, log_status, log_created, log_modified], insertValueContexts=[InsertValueContext(parametersCount=5, valueExpressions=[ParameterMarkerExpressionSegment(startIndex=109, stopIndex=109, parameterMarkerIndex=0), ParameterMarkerExpressionSegment(startIndex=112, stopIndex=112, parameterMarkerIndex=1), ParameterMarkerExpressionSegment(startIndex=115, stopIndex=115, parameterMarkerIndex=2), ParameterMarkerExpressionSegment(startIndex=118, stopIndex=118, parameterMarkerIndex=3), ParameterMarkerExpressionSegment(startIndex=121, stopIndex=121, parameterMarkerIndex=4), org.apache.shardingsphere.sql.parser.sql.segment.dml.item.ExpressionProjectionSegment@7c1e61c9, org.apache.shardingsphere.sql.parser.sql.segment.dml.item.ExpressionProjectionSegment@4ed8901e], parameters=[65427301962092545, 192.168.129.1:8091:65427292176781312, serializer=jackson, javax.sql.rowset.serial.SerialBlob@cc7e0246, 0])], generatedKeyContext=Optional.empty) 2020-10-30 13:04:44.477 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: INSERT INTO undo_log (branch_id, xid, context, rollback_info, log_status, log_created, log_modified) VALUES (?, ?, ?, ?, ?, now(6), now(6)) ::: [65427301962092545, 192.168.129.1:8091:65427292176781312, serializer=jackson, javax.sql.rowset.serial.SerialBlob@cc7e0246, 0] 2020-10-30 13:04:44.514 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:240 - 同步书籍分组新老ID对应关系:{} 2020-10-30 13:04:44.514 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:241 - ------------同步书籍分组结束---------------- 2020-10-30 13:04:44.515 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:91 - ------------同步书籍开始---------------- 2020-10-30 13:04:44.515 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:92 - 同步书籍入参，userUuid:3d47f19529a040c5bfa6cf6500324c2d,newUserId:2 2020-10-30 13:04:45.104 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO com.mozhe.sync.service.impl.TransferServiceImpl Line:94 - 同步书籍内容:[{"bookTypeId":0,"bookUuid":"a1a8956e13a79627b5084ec48af7cc9f","brief":"","createTime":1584645753000,"fee":0.0,"groupUuid":"","id":1483651,"imageUrl":"http://mzcz-image.oss-cn-hangzhou.aliyuncs.com/images/defalut_book.png","name":"耿耿于怀观光团","pushTime":1585932602000,"quickInputContent":"[]","sort":100,"status":1,"updateTime":1585932602000,"userUuid":"3d47f19529a040c5bfa6cf6500324c2d"},{"bookTypeId":0,"bookUuid":"12f618974acb4e26816f50f39cb3f8a2","brief":"","createTime":1585932578000,"fee":0.0,"groupUuid":"","id":1545447,"imageUrl":"https://mzcz-image.oss-cn-hangzhou.aliyuncs.com/images/1594637242967.jpg?Expires=1909997243&OSSAccessKeyId=LTAIn3yAXcNaGyDT&Signature=5ULXoFVMz9gxA5GUtBpJPn%2B5HEs%3D","name":"公司信息","pushTime":1594684052000,"quickInputContent":"","sort":200,"status":0,"updateTime":1594684052000,"userUuid":"3d47f19529a040c5bfa6cf6500324c2d"},{"bookTypeId":14,"bookUuid":"1ff4b39801a2ad0a14517b2f7d13f576","brief":"","createTime":1586112885000,"fee":0.0,"groupUuid":"","id":1552726,"imageUrl":"null&width=375&height=500","name":"工作内容","pushTime":1598886530000,"quickInputContent":"[]","sort":100,"status":0,"updateTime":1598886530000,"userUuid":"3d47f19529a040c5bfa6cf6500324c2d"},{"bookTypeId":1,"bookUuid":"e0c6ae26f98b4bb7b69dfc98e39756ad","brief":"","createTime":1586878762000,"fee":0.0,"groupUuid":"","id":1579229,"imageUrl":"https://mzcz-image.oss-cn-hangzhou.aliyuncs.com/images/1594690293007.jpg?Expires=1910050283&OSSAccessKeyId=LTAIn3yAXcNaGyDT&Signature=p%2FbHLuMMF6Xv8FWjPivQ8icgQ8M%3D&width=960&height=1280","name":"墨者的故事","pushTime":1594737088000,"quickInputContent":"","sort":0,"status":0,"updateTime":1594737088000,"userUuid":"3d47f19529a040c5bfa6cf6500324c2d"},{"bookTypeId":0,"bookUuid":"d7f1618b26304f30bce3c6e468e003c9","brief":"","createTime":1586921766000,"fee":0.0,"groupUuid":"","id":1599528,"imageUrl":"https://mzcz-image.oss-cn-hangzhou.aliyuncs.com/images/1594690312859.jpg?Expires=1910050303&OSSAccessKeyId=LTAIn3yAXcNaGyDT&Signature=46bzVuLvJ%2BnhD9exTbQxebV9Z50%3D&width=960&height=1280","name":"测试","pushTime":1594737105000,"quickInputContent":"","sort":300,"status":0,"updateTime":1594737105000,"userUuid":"3d47f19529a040c5bfa6cf6500324c2d"},{"bookTypeId":0,"bookUuid":"9ad8c5ac93574159a0f15e661178b049","createTime":1591052813000,"fee":0.0,"id":1781043,"imageUrl":"http://mzcz-image.oss-cn-hangzhou.aliyuncs.com/images/defalut_book.png","name":"pome","pushTime":1591052813000,"sort":400,"status":0,"updateTime":1591052813000,"userUuid":"3d47f19529a040c5bfa6cf6500324c2d"},{"bookTypeId":0,"bookUuid":"205ffdf2cb964ae4867872bdd955ac79","brief":"","createTime":1594684560000,"fee":0.0,"id":1888109,"imageUrl":"https://mzcz-image.oss-cn-hangzhou.aliyuncs.com/images/1594637860737.jpg?Expires=1909997855&OSSAccessKeyId=LTAIn3yAXcNaGyDT&Signature=faLCLdyhLw%2Bfperk3ahdS13J8SA%3D","name":"111","pushTime":1594684666000,"sort":500,"status":0,"updateTime":1594684666000,"userUuid":"3d47f19529a040c5bfa6cf6500324c2d"},{"bookTypeId":0,"bookUuid":"5316b1d596fc429783457c587989b5f7","brief":"","createTime":1599071320000,"fee":0.0,"groupUuid":"","id":2033960,"imageUrl":"https://mzcz-image.oss-cn-hangzhou.aliyuncs.com/images/1599456896935.jpg?Expires=1914816890&OSSAccessKeyId=LTAIYzTxnk86G9nT&Signature=SAVCFAgxaEcw0oOMdl%2B0rM9UqD4%3D","name":"新版墨者","pushTime":1599503701000,"sort":600,"status":0,"updateTime":1599503701000,"userUuid":"3d47f19529a040c5bfa6cf6500324c2d"}] 2020-10-30 13:04:45.105 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - ==> Preparing: select user_sequence from t_user_sequence where user_id = ? limit 1 2020-10-30 13:04:45.105 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - ==> Parameters: 2(Long) 2020-10-30 13:04:45.105 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: select user_sequence from t_user_sequence where user_id = ? limit 1 2020-10-30 13:04:45.105 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@2eb7f24d, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@2af870a9), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@2af870a9, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=19, distinctRow=false, projections=[ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty)]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@3e1a3138, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@1fbb7355, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@3d8ef703, containsSubquery=false) 2020-10-30 13:04:45.106 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: select user_sequence from t_user_sequence where user_id = ? limit 1 ::: [2] 2020-10-30 13:04:45.106 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - <== Total: 1 上传 -> sequence:246 userId:2 2020-10-30 13:04:45.107 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - ==> Preparing: select user_sequence from t_user_sequence where user_id = ? limit 1 2020-10-30 13:04:45.107 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - ==> Parameters: 2(Long) 2020-10-30 13:04:45.107 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: select user_sequence from t_user_sequence where user_id = ? limit 1 2020-10-30 13:04:45.107 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@2eb7f24d, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@7f03208b), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@7f03208b, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=19, distinctRow=false, projections=[ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty)]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@35ffe687, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@344deea6, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@394df043, containsSubquery=false) 2020-10-30 13:04:45.108 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: select user_sequence from t_user_sequence where user_id = ? limit 1 ::: [2] 2020-10-30 13:04:45.108 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.findUserSequence Line:159 - <== Total: 1 2020-10-30 13:04:45.109 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO c.m.s.s.impl.MySqlDocumentBasicDataCenterImpl Line:69 - 开始全局事务，XID = 192.168.129.1:8091:65427292176781312 2020-10-30 13:04:45.110 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.updateUserSequence Line:159 - ==> Preparing: update t_user_sequence set user_sequence = ? where user_id = ? 2020-10-30 13:04:45.110 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.updateUserSequence Line:159 - ==> Parameters: 254(Long), 2(Long) 2020-10-30 13:04:45.113 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: SELECT id, user_sequence FROM t_user_sequence WHERE user_id = ? FOR UPDATE 2020-10-30 13:04:45.113 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@436cb21c, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@75d794a7), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@75d794a7, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=23, distinctRow=false, projections=[ColumnProjection(owner=null, name=id, alias=Optional.empty), ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty)]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@dd23c63, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@654a2114, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@55ac33e7, containsSubquery=false) 2020-10-30 13:04:45.113 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT id, user_sequence FROM t_user_sequence WHERE user_id = ? FOR UPDATE ::: [2] 2020-10-30 13:04:45.114 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: update t_user_sequence set user_sequence = ? where user_id = ? 2020-10-30 13:04:45.114 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: UpdateStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.UpdateStatement@6aaf9bef, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@344c220e), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@344c220e) 2020-10-30 13:04:45.114 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: update t_user_sequence set user_sequence = ? where user_id = ? ::: [254, 2] 2020-10-30 13:04:45.115 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: SELECT id, user_sequence FROM t_user_sequence WHERE (id ) in ( (?) ) 2020-10-30 13:04:45.115 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@15a670fc, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@cb1c6b), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@cb1c6b, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=23, distinctRow=false, projections=[ColumnProjection(owner=null, name=id, alias=Optional.empty), ColumnProjection(owner=null, name=user_sequence, alias=Optional.empty)]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@23c51e14, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@74a4ad71, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@21adbdb9, containsSubquery=false) 2020-10-30 13:04:45.115 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT id, user_sequence FROM t_user_sequence WHERE (id ) in ( (?) ) ::: [6] 2020-10-30 13:04:45.115 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG c.m.s.mapper.UserSequenceMapper.updateUserSequence Line:159 - <== Updates: 1 2020-10-30 13:04:45.123 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG com.mozhe.sync.mapper.DocumentMapper.insert Line:159 - ==> Preparing: INSERT INTO t_document ( id,uid,sid,document_type,document_change,sequence,status,create_time,update_time ) VALUES( ?,?,?,?,?,?,?,?,? ) 2020-10-30 13:04:45.124 [DubboServerHandler-10.198.75.60:20002-thread-3] DEBUG com.mozhe.sync.mapper.DocumentMapper.insert Line:159 - ==> Parameters: null, 2(String), 771721255152783360(String), 11(Integer), -1(Long), 247(Long), 0(Integer), 2020-10-30 13:04:45.116(Timestamp), 2020-10-30 13:04:45.116(Timestamp) 2020-10-30 13:04:45.130 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: SELECT FROM t_document LIMIT 1 2020-10-30 13:04:45.131 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@18ee56a7, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@607d5c18), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@607d5c18, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=7, distinctRow=false, projections=[ShorthandProjection(owner=Optional.empty, actualColumns=[ColumnProjection(owner=null, name=id, alias=Optional.empty), ColumnProjection(owner=null, name=uid, alias=Optional.empty), ColumnProjection(owner=null, name=sid, alias=Optional.empty), ColumnProjection(owner=null, name=document_type, alias=Optional.empty), ColumnProjection(owner=null, name=document_change, alias=Optional.empty), ColumnProjection(owner=null, name=sequence, alias=Optional.empty), ColumnProjection(owner=null, name=status, alias=Optional.empty), ColumnProjection(owner=null, name=create_time, alias=Optional.empty), ColumnProjection(owner=null, name=update_time, alias=Optional.empty)])]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@12c9aef7, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@1b4b1a84, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@717a3c24, containsSubquery=false) 2020-10-30 13:04:45.131 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT FROM t_document_01 LIMIT 1 2020-10-30 13:04:45.131 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT FROM t_document_02 LIMIT 1 2020-10-30 13:04:45.131 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT FROM t_document_03 LIMIT 1 2020-10-30 13:04:45.131 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT FROM t_document_04 LIMIT 1 2020-10-30 13:04:45.131 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT FROM t_document_05 LIMIT 1 2020-10-30 13:04:45.132 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT FROM t_document_06 LIMIT 1 ["t_document_01","t_document_02","t_document_03","t_document_04","t_document_05","t_document_06"] {"columnName":"uid","logicTableName":"t_document","value":"2"} t_document_03 2020-10-30 13:04:45.148 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Logic SQL: INSERT INTO t_document ( id,uid,sid,document_type,document_change,sequence,status,create_time,update_time ) VALUES( ?,?,?,?,?,?,?,?,? ) 2020-10-30 13:04:45.149 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - SQLStatement: InsertStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.InsertStatement@42e0b5ee, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@7b8e9f80), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@7b8e9f80, columnNames=[id, uid, sid, document_type, document_change, sequence, status, create_time, update_time], insertValueContexts=[InsertValueContext(parametersCount=9, valueExpressions=[ParameterMarkerExpressionSegment(startIndex=117, stopIndex=117, parameterMarkerIndex=0), ParameterMarkerExpressionSegment(startIndex=119, stopIndex=119, parameterMarkerIndex=1), ParameterMarkerExpressionSegment(startIndex=121, stopIndex=121, parameterMarkerIndex=2), ParameterMarkerExpressionSegment(startIndex=123, stopIndex=123, parameterMarkerIndex=3), ParameterMarkerExpressionSegment(startIndex=125, stopIndex=125, parameterMarkerIndex=4), ParameterMarkerExpressionSegment(startIndex=127, stopIndex=127, parameterMarkerIndex=5), ParameterMarkerExpressionSegment(startIndex=129, stopIndex=129, parameterMarkerIndex=6), ParameterMarkerExpressionSegment(startIndex=131, stopIndex=131, parameterMarkerIndex=7), ParameterMarkerExpressionSegment(startIndex=133, stopIndex=133, parameterMarkerIndex=8)], parameters=[null, 2, 771721255152783360, 11, -1, 247, 0, 2020-10-30 13:04:45.116, 2020-10-30 13:04:45.116])], generatedKeyContext=Optional.empty) 2020-10-30 13:04:45.149 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: INSERT INTO t_document_03 ( id,uid,sid,document_type,document_change,sequence,status,create_time,update_time ) VALUES(?, ?, ?, ?, ?, ?, ?, ?, ?) ::: [null, 2, 771721255152783360, 11, -1, 247, 0, 2020-10-30 13:04:45.116, 2020-10-30 13:04:45.116] 2020-10-30 13:04:45.152 [DubboServerHandler-10.198.75.60:20002-thread-3] WARN i.s.rm.datasource.exec.mysql.MySQLInsertExecutor Line:132 - Fail to get auto-generated keys, use 'SELECT LAST_INSERT_ID()' instead. Be cautious, statement could be polluted. Recommend you set the statement to return generated keys. 2020-10-30 13:04:45.242 [rpcDispatch_RMROLE_1_1_12] INFO i.s.c.r.processor.client.RmBranchRollbackProcessor Line:56 - rm handle branch rollback process:xid=192.168.129.1:8091:65427292176781312,branchId=65427301962092545,branchType=AT,resourceId=jdbc:mysql://127.0.0.1:3306/mozhe_sync,applicationData=null 2020-10-30 13:04:45.244 [rpcDispatch_RMROLE_1_1_12] INFO io.seata.rm.AbstractRMHandler Line:123 - Branch Rollbacking: 192.168.129.1:8091:65427292176781312 65427301962092545 jdbc:mysql://127.0.0.1:3306/mozhe_sync 2020-10-30 13:04:45.246 [rpcDispatch_RMROLE_1_1_12] INFO ShardingSphere-SQL Line:74 - Logic SQL: SELECT FROM undo_log WHERE branch_id = ? AND xid = ? FOR UPDATE 2020-10-30 13:04:45.246 [rpcDispatch_RMROLE_1_1_12] INFO ShardingSphere-SQL Line:74 - SQLStatement: SelectStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.SelectStatement@6b584d7d, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@17af8a14), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@17af8a14, projectionsContext=ProjectionsContext(startIndex=7, stopIndex=7, distinctRow=false, projections=[ShorthandProjection(owner=Optional.empty, actualColumns=[ColumnProjection(owner=null, name=id, alias=Optional.empty), ColumnProjection(owner=null, name=branch_id, alias=Optional.empty), ColumnProjection(owner=null, name=xid, alias=Optional.empty), ColumnProjection(owner=null, name=context, alias=Optional.empty), ColumnProjection(owner=null, name=rollback_info, alias=Optional.empty), ColumnProjection(owner=null, name=log_status, alias=Optional.empty), ColumnProjection(owner=null, name=log_created, alias=Optional.empty), ColumnProjection(owner=null, name=log_modified, alias=Optional.empty)])]), groupByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.groupby.GroupByContext@25fbb2fc, orderByContext=org.apache.shardingsphere.sql.parser.binder.segment.select.orderby.OrderByContext@504d043f, paginationContext=org.apache.shardingsphere.sql.parser.binder.segment.select.pagination.PaginationContext@79d788ee, containsSubquery=false) 2020-10-30 13:04:45.246 [rpcDispatch_RMROLE_1_1_12] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: SELECT * FROM undo_log WHERE branch_id = ? AND xid = ? FOR UPDATE ::: [65427301962092545, 192.168.129.1:8091:65427292176781312] 2020-10-30 13:04:45.271 [rpcDispatch_RMROLE_1_1_12] INFO io.seata.rm.datasource.undo.AbstractUndoExecutor Line:233 - Stop rollback because there is no data change between the before data snapshot and the after data snapshot. 2020-10-30 13:04:45.273 [rpcDispatch_RMROLE_1_1_12] INFO ShardingSphere-SQL Line:74 - Logic SQL: DELETE FROM undo_log WHERE branch_id = ? AND xid = ? 2020-10-30 13:04:45.273 [rpcDispatch_RMROLE_1_1_12] INFO ShardingSphere-SQL Line:74 - SQLStatement: DeleteStatementContext(super=CommonSQLStatementContext(sqlStatement=org.apache.shardingsphere.sql.parser.sql.statement.dml.DeleteStatement@1ccfada3, tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@5a0f9829), tablesContext=org.apache.shardingsphere.sql.parser.binder.segment.table.TablesContext@5a0f9829) 2020-10-30 13:04:45.273 [rpcDispatch_RMROLE_1_1_12] INFO ShardingSphere-SQL Line:74 - Actual SQL: ds0 ::: DELETE FROM undo_log WHERE branch_id = ? AND xid = ? ::: [65427301962092545, 192.168.129.1:8091:65427292176781312] 2020-10-30 13:04:45.370 [rpcDispatch_RMROLE_1_1_12] INFO io.seata.rm.datasource.undo.AbstractUndoLogManager Line:312 - xid 192.168.129.1:8091:65427292176781312 branch 65427301962092545, undo_log deleted with GlobalFinished 2020-10-30 13:04:45.371 [rpcDispatch_RMROLE_1_1_12] INFO io.seata.rm.AbstractRMHandler Line:131 - Branch Rollbacked result: PhaseTwo_Rollbacked 2020-10-30 13:04:45.656 [DubboServerHandler-10.198.75.60:20002-thread-3] INFO io.seata.tm.api.DefaultGlobalTransaction Line:179 - [192.168.129.1:8091:65427292176781312] rollback status: Rollbacked

java.lang.RuntimeException: org.springframework.dao.InvalidDataAccessApiUsageException:

Error updating database. Cause: java.sql.SQLFeatureNotSupportedException: executeQuery with SQL for PreparedStatement

The error may involve com.mozhe.sync.mapper.DocumentMapper.insert-Inline

The error occurred while setting parameters

SQL: INSERT INTO t_document ( id,uid,sid,document_type,document_change,sequence,status,create_time,update_time ) VALUES( ?,?,?,?,?,?,?,?,? )

Cause: java.sql.SQLFeatureNotSupportedException: executeQuery with SQL for PreparedStatement

; executeQuery with SQL for PreparedStatement; nested exception is java.sql.SQLFeatureNotSupportedException: executeQuery with SQL for PreparedStatement org.springframework.dao.InvalidDataAccessApiUsageException:

Error updating database. Cause: java.sql.SQLFeatureNotSupportedException: executeQuery with SQL for PreparedStatement

The error may involve com.mozhe.sync.mapper.DocumentMapper.insert-Inline

The error occurred while setting parameters

SQL: INSERT INTO t_document ( id,uid,sid,document_type,document_change,sequence,status,create_time,update_time ) VALUES( ?,?,?,?,?,?,?,?,? )

Cause: java.sql.SQLFeatureNotSupportedException: executeQuery with SQL for PreparedStatement

; executeQuery with SQL for PreparedStatement; nested exception is java.sql.SQLFeatureNotSupportedException: executeQuery with SQL for PreparedStatement at org.springframework.jdbc.support.SQLExceptionSubclassTranslator.doTranslate(SQLExceptionSubclassTranslator.java:96) at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:72) at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:81) at org.mybatis.spring.MyBatisExceptionTranslator.translateExceptionIfPossible(MyBatisExceptionTranslator.java:73) at org.mybatis.spring.SqlSessionTemplate$SqlSessionInterceptor.invoke(SqlSessionTemplate.java:446) at com.sun.proxy.$Proxy96.insert(Unknown Source) at org.mybatis.spring.SqlSessionTemplate.insert(SqlSessionTemplate.java:278) at org.apache.ibatis.binding.MapperMethod.execute(MapperMethod.java:57) at org.apache.ibatis.binding.MapperProxy.invoke(MapperProxy.java:59) at com.sun.proxy.$Proxy107.insert(Unknown Source)

kimmking commented 3 years ago

According to logs, something with seata is wrong.