linghengqian commented on issue #13234:
URL:
https://github.com/apache/shardingsphere/issues/13234#issuecomment-954798185
With the help of @zjcnb, I confirmed the two questions corresponding to this
issue. The first question is the JAR package that I used in the custom sharding
algorithm class used in `CLASS_BASE`, and the
`org.apache.shardingsphere:shardingsphere-jdbc-core-spring-boot-starter` is
`5.0.0-beta`, which does not correspond to the `5.0.0-RC1` version of
`ShardingSphere-Proxy` running this JAR, so use it instead This problem was
first confirmed after `ShardingSphere-Proxy` `5.0.0-beta`.
The second problem is the situation mentioned in the article of this issue.
Running `start.bat` under the `Windows` platform, can only connect to the local
`zookeeper` `3.7.0`, and cannot connect to the cloud server's `zookeeper`
`3.7.0`. After multiple `Windows` environment tests, it remains the same.
When starting `start.sh` in the Linux environment, it can connect to the
cloud's `zookeeper` `3.7.0` normally. I ensured that the JDK used by the
`windows` and `linux` environments are both `Eclipse Adoptium` `8u302`, tested
three sets of `ShardingSphere-Proxy` instances and two sets of `zookeeper`
instances, and verified them on three devices.
I confirmed that `digest` is normally verified by `ShardingSphere-Proxy`
`5.0.0-beta`, this is no problem. After @zjcnb verification,
`ShardingSphere-Proxy` `5.0.0-RC1` started normally. There is no special
problem with `start.sh`, and there are still problems with the `start.bat` of
testing `ShardingSphere-Proxy` `5.0.0-RC1` under my `windows 10`.
The error message under the `windows` platform is as follows.(In order to
facilitate the display of the issue, I still use `127.0.0.1` to replace the
`ip` of `log`)
```shell
[INFO ] 2021-10-29 22:21:55.339 [Curator-Framework-0]
o.a.c.f.imps.CuratorFrameworkImpl - backgroundOperationsLoop exiting
[INFO ] 2021-10-29 22:22:02.445 [main-SendThread(127.0.0.1:2181)]
org.apache.zookeeper.ClientCnxn - Opening socket connection to server
127.0.0.1/127.0.0.1:2181.
[INFO ] 2021-10-29 22:22:02.446 [main-SendThread(127.0.0.1:2181)]
org.apache.zookeeper.ClientCnxn - SASL config status: Will not attempt to
authenticate using SASL (unknown error)
[INFO ] 2021-10-29 22:22:02.458 [main-SendThread(127.0.0.1:2181)]
org.apache.zookeeper.ClientCnxn - Socket connection established, initiating
session, client: /192.168.1.103:61474, server: 127.0.0.1/127.0.0.1:2181
[INFO ] 2021-10-29 22:22:02.481 [main-SendThread(127.0.0.1:2181)]
org.apache.zookeeper.ClientCnxn - Session establishment complete on server
127.0.0.1/127.0.0.1:2181, session id = 0x1000d6a118f0047, negotiated timeout =
40000
[WARN ] 2021-10-29 22:22:02.506 [main-SendThread(127.0.0.1:2181)]
org.apache.zookeeper.ClientCnxn - An exception was thrown while closing send
thread for session 0x1000d6a118f0047.
org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read
additional data from server sessionid 0x1000d6a118f0047, likely server has
closed socket
at
org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:75)
at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:348)
at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1262)
[INFO ] 2021-10-29 22:22:02.616 [main] org.apache.zookeeper.ZooKeeper -
Session: 0x1000d6a118f0047 closed
[INFO ] 2021-10-29 22:22:02.616 [main-EventThread]
org.apache.zookeeper.ClientCnxn - EventThread shut down for session:
0x1000d6a118f0047
Exception in thread "main"
org.apache.shardingsphere.governance.repository.api.exception.GovernanceException:
org.apache.zookeeper.KeeperException$OperationTimeoutException:
KeeperErrorCode = OperationTimeout
at
org.apache.shardingsphere.governance.repository.zookeeper.handler.CuratorZookeeperExceptionHandler.handleException(CuratorZookeeperExceptionHandler.java:51)
at
org.apache.shardingsphere.governance.repository.zookeeper.CuratorZookeeperRepository.initCuratorClient(CuratorZookeeperRepository.java:127)
at
org.apache.shardingsphere.governance.repository.zookeeper.CuratorZookeeperRepository.init(CuratorZookeeperRepository.java:81)
at
org.apache.shardingsphere.governance.core.registry.RegistryCenterRepositoryFactory.newInstance(RegistryCenterRepositoryFactory.java:49)
at
org.apache.shardingsphere.governance.core.GovernanceFacade.init(GovernanceFacade.java:58)
at
org.apache.shardingsphere.proxy.initializer.impl.GovernanceBootstrapInitializer.getProxyConfiguration(GovernanceBootstrapInitializer.java:58)
at
org.apache.shardingsphere.proxy.initializer.impl.AbstractBootstrapInitializer.init(AbstractBootstrapInitializer.java:66)
at org.apache.shardingsphere.proxy.Bootstrap.main(Bootstrap.java:48)
Caused by: org.apache.zookeeper.KeeperException$OperationTimeoutException:
KeeperErrorCode = OperationTimeout
at
org.apache.shardingsphere.governance.repository.zookeeper.CuratorZookeeperRepository.initCuratorClient(CuratorZookeeperRepository.java:124)
... 6 more
```
The following is the normal startup log in the `linux` environment.(In order
to facilitate the display of the issue, I still use `127.0.0.1` to replace the
`ip` of `log`)
```shell
[INFO ] 2021-10-29 22:03:30.173 [main] org.apache.zookeeper.ZooKeeper -
Initiating client connection, connectString=113.107.163.210:7500
sessionTimeout=60000 watcher=org.apache.curator.ConnectionState@5c33f1a9
[INFO ] 2021-10-29 22:03:30.184 [main] org.apache.zookeeper.common.X509Util
- Setting -D jdk.tls.rejectClientInitiatedRenegotiation=true to disable
client-initiated TLS renegotiation
[INFO ] 2021-10-29 22:03:30.195 [main] o.apache.zookeeper.ClientCnxnSocket -
jute.maxbuffer value is 1048575 Bytes
[INFO ] 2021-10-29 22:03:30.208 [main] org.apache.zookeeper.ClientCnxn -
zookeeper.request.timeout value is 0. feature enabled=false
[INFO ] 2021-10-29 22:03:30.222 [main-SendThread(113.107.163.210:7500)]
org.apache.zookeeper.ClientCnxn - Opening socket connection to server
127.0.0.1/127.0.0.1:2181.
[INFO ] 2021-10-29 22:03:30.223 [main-SendThread(113.107.163.210:7500)]
org.apache.zookeeper.ClientCnxn - SASL config status: Will not attempt to
authenticate using SASL (unknown error)
[INFO ] 2021-10-29 22:03:30.235 [main] o.a.c.f.imps.CuratorFrameworkImpl -
Default schema
[INFO ] 2021-10-29 22:03:30.241 [main-SendThread(113.107.163.210:7500)]
org.apache.zookeeper.ClientCnxn - Socket connection established, initiating
session, client: /172.18.235.48:54470, server: 127.0.0.1/127.0.0.1:2181
[INFO ] 2021-10-29 22:03:30.272 [main-SendThread(113.107.163.210:7500)]
org.apache.zookeeper.ClientCnxn - Session establishment complete on server
127.0.0.1/127.0.0.1:2181, session id = 0x1000d6a118f0046, negotiated timeout =
40000
[INFO ] 2021-10-29 22:03:30.286 [main-EventThread]
o.a.c.f.state.ConnectionStateManager - State change: CONNECTED
[INFO ] 2021-10-29 22:03:30.333 [main-EventThread]
o.a.c.framework.imps.EnsembleTracker - New config event received: {}
[INFO ] 2021-10-29 22:03:30.333 [main-EventThread]
o.a.c.framework.imps.EnsembleTracker - New config event received: {}
[INFO ] 2021-10-29 22:03:31.243 [main] o.apache.curator.utils.Compatibility
- Using org.apache.zookeeper.server.quorum.MultipleAddresses
[INFO ] 2021-10-29 22:03:31.463 [main] com.zaxxer.hikari.HikariDataSource -
HikariPool-1 - Starting...
[INFO ] 2021-10-29 22:03:31.851 [main] com.zaxxer.hikari.HikariDataSource -
HikariPool-1 - Start completed.
[INFO ] 2021-10-29 22:03:31.854 [main] com.zaxxer.hikari.HikariDataSource -
HikariPool-1 - Starting...
[INFO ] 2021-10-29 22:03:31.959 [main] com.zaxxer.hikari.HikariDataSource -
HikariPool-1 - Start completed.
[INFO ] 2021-10-29 22:03:31.959 [main] com.zaxxer.hikari.HikariDataSource -
HikariPool-1 - Shutdown initiated...
[INFO ] 2021-10-29 22:03:31.973 [main] com.zaxxer.hikari.HikariDataSource -
HikariPool-1 - Shutdown completed.
[INFO ] 2021-10-29 22:03:35.590 [main] c.a.icatch.provider.imp.AssemblerImp
- Loaded
jar:file:/home/heqiheng/apache-shardingsphere-5.0.0-beta-shardingsphere-proxy-bin/lib/transactions-4.0.6.jar!/transactions-defaults.properties
[INFO ] 2021-10-29 22:03:35.592 [main] c.a.icatch.provider.imp.AssemblerImp
- Loaded
jar:file:/home/heqiheng/apache-shardingsphere-5.0.0-beta-shardingsphere-proxy-bin/lib/shardingsphere-transaction-xa-atomikos-5.0.0-beta.jar!/transactions.properties
[WARN ] 2021-10-29 22:03:35.595 [main] c.a.icatch.provider.imp.AssemblerImp
- Thanks for using Atomikos! Evaluate
http://www.atomikos.com/Main/ExtremeTransactions for advanced features and
professional support
or register at http://www.atomikos.com/Main/RegisterYourDownload to disable
this message and receive FREE tips & advice
Thanks for using Atomikos! Evaluate
http://www.atomikos.com/Main/ExtremeTransactions for advanced features and
professional support
or register at http://www.atomikos.com/Main/RegisterYourDownload to disable
this message and receive FREE tips & advice
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.default_max_wait_time_on_shutdown =
9223372036854775807
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.allow_subtransactions = true
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.recovery_delay = 300000
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.automatic_resource_registration = false
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.oltp_max_retries = 5
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.client_demarcation = false
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.threaded_2pc = false
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.serial_jta_transactions = false
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.log_base_dir = ./logs
[INFO ] 2021-10-29 22:03:35.609 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.rmi_export_class = none
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.max_actives = 10000
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.checkpoint_interval = 50000
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.enable_logging = true
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.log_base_name = xa_tx
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.max_timeout = 300000
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.trust_client_tm = false
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: java.naming.factory.initial =
com.sun.jndi.rmi.registry.RegistryContextFactory
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.tm_unique_name = 172.18.235.48.tm
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.forget_orphaned_log_entries_delay = 86400000
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.oltp_retry_interval = 10000
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: java.naming.provider.url = rmi://localhost:1099
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.force_shutdown_on_vm_exit = false
[INFO ] 2021-10-29 22:03:35.610 [main] c.a.icatch.provider.imp.AssemblerImp
- USING: com.atomikos.icatch.default_jta_timeout = 300000
[INFO ] 2021-10-29 22:03:35.612 [main] c.a.icatch.provider.imp.AssemblerImp
- Using default (local) logging and recovery...
[INFO ] 2021-10-29 22:03:35.773 [main] c.a.d.xa.XATransactionalResource -
resource-1-ds_0: refreshed XAResource
[INFO ] 2021-10-29 22:03:35.796 [main]
o.a.s.p.i.i.AbstractBootstrapInitializer - Database name is `MySQL`, version is
`5.6.50-log`
[INFO ] 2021-10-29 22:03:36.059 [epollEventLoopGroup-2-1]
i.n.handler.logging.LoggingHandler - [id: 0xca09a11f] REGISTERED
[INFO ] 2021-10-29 22:03:36.063 [epollEventLoopGroup-2-1]
i.n.handler.logging.LoggingHandler - [id: 0xca09a11f] BIND: 0.0.0.0/0.0.0.0:3398
[INFO ] 2021-10-29 22:03:36.067 [epollEventLoopGroup-2-1]
i.n.handler.logging.LoggingHandler - [id: 0xca09a11f, L:/0.0.0.0:3398] ACTIVE
[INFO ] 2021-10-29 22:03:36.067 [main] o.a.s.p.frontend.ShardingSphereProxy
- ShardingSphere-Proxy start success.
```
According to my test results, the `start.bat` of `shardingsphere-proxy`
`5.0.0-beta` and `5.0.0-RC1` both showed abnormal conditions under the
`windows` platform. Hope to have friends Can give more tests.
I will change the title of the issue in order to facilitate the search of
latecomers.
--
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
To unsubscribe, e-mail: notifications-unsubscr...@shardingsphere.apache.org
For queries about this service, please contact Infrastructure at:
us...@infra.apache.org
