[ 
https://issues.apache.org/jira/browse/IGNITE-14921?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
 ]

Alexey Scherbakov updated IGNITE-14921:
---------------------------------------
    Description: 
{noformat}
2021-06-17 12:54:17:578 +0300 [main] INFO ITCliServiceTest - >>>>>>>>>>>>>>> 
Start test method: testChangePeers
2021-06-17 12:54:17:578 +0300 [main] INFO ITCliServiceTest - >>>>>>>>>>>>>>> 
Start test method: testChangePeers2021-06-17 12:54:26:228 +0300 [main] INFO 
FSMCallerImpl - Starts FSMCaller successfully.2021-06-17 12:54:26:262 +0300 
[main] WARN LocalSnapshotStorage - No data for snapshot reader 
D:\work\ignite-3\modules\raft\jraft_test_1455162015862\192.168.0.107_5003\snapshot.
2021-06-17 12:54:26:276 +0300 [main] INFO NodeImpl - Node 
<CliServiceTest/192.168.0.107:5003> init, term=0, lastLogId=LogId [index=0, 
term=0], 
conf=192.168.0.107:5003,192.168.0.107:5004,192.168.0.107:5005,192.168.0.107:5103/learner,192.168.0.107:5104/learner,
 oldConf=.2021-06-17 12:54:27:224 +0300 
[JRaft-ElectionTimer-192.168.0.107:5003-0] INFO NodeImpl - Node 
<CliServiceTest/192.168.0.107:5003> term 0 start preVote.2021-06-17 
12:54:27:477 +0300 [JRaft-ElectionTimer-192.168.0.107:5003-0] ERROR 
RepeatedTimer - Run timer failed.
java.lang.NullPointerException at 
io.scalecube.cluster.ClusterImpl.requestResponse(ClusterImpl.java:419) at 
org.apache.ignite.network.scalecube.ScaleCubeMessagingService.invoke(ScaleCubeMessagingService.java:123)
 at 
org.apache.ignite.raft.jraft.rpc.impl.IgniteRpcClient.send(IgniteRpcClient.java:130)
 at 
org.apache.ignite.raft.jraft.rpc.impl.IgniteRpcClient.invokeAsync(IgniteRpcClient.java:124)
 at 
org.apache.ignite.raft.jraft.rpc.impl.AbstractClientService.invokeWithDone(AbstractClientService.java:199)
 at 
org.apache.ignite.raft.jraft.rpc.impl.AbstractClientService.connect(AbstractClientService.java:130)
 at org.apache.ignite.raft.jraft.core.NodeImpl.preVote(NodeImpl.java:2668) at 
org.apache.ignite.raft.jraft.core.NodeImpl.handleElectionTimeout(NodeImpl.java:614)
 at org.apache.ignite.raft.jraft.core.NodeImpl$2.onTrigger(NodeImpl.java:910) 
at org.apache.ignite.raft.jraft.util.RepeatedTimer.run(RepeatedTimer.java:80) 
at 
org.apache.ignite.raft.jraft.util.RepeatedTimer.lambda$schedule$0(RepeatedTimer.java:177)
 at 
org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$HashedWheelTimeout.expire(HashedWheelTimer.java:577)
 at 
org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$HashedWheelBucket.expireTimeouts(HashedWheelTimer.java:649)
 at 
org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$Worker.run(HashedWheelTimer.java:383)
 at java.base/java.lang.Thread.run(Thread.java:834)
2021-06-17 12:54:28:348 +0300 [main] INFO Cluster - [null][doStart] Starting, 
config: ClusterConfig[metadata=null, metadataTimeout=1000, 
metadataCodec=io.scalecube.cluster.metadata.JdkMetadataCodec@2eee3069, 
memberAlias='192.168.0.107:5003', externalHost='null', externalPort=null, 
transportConfig=TransportConfig[port=0, isSecured=false, connectTimeout=1000, 
messageCodec=io.scalecube.cluster.transport.api.JdkMessageCodec@2da59753, 
maxFrameLength=2097152, 
transportFactory=org.apache.ignite.network.scalecube.DelegatingTransportFactory@5629510],
 failureDetectorConfig=FailureDetectorConfig[pingInterval=500, pingTimeout=200, 
pingReqMembers=1], gossipConfig=GossipConfig[gossipFanout=3, gossipInterval=10, 
gossipRepeatMult=2, gossipSegmentationThreshold=1000], 
membershipConfig=MembershipConfig[seedMembers=[192.168.0.107:5003, 
192.168.0.107:5004, 192.168.0.107:5005], syncInterval=1000, syncTimeout=3000, 
suspicionMult=1, namespace='default', removedMembersHistorySize=42]]
2021-06-17 12:54:28:501 +0300 [JRaft-ElectionTimer-192.168.0.107:5003-0] INFO 
NodeImpl - Node <CliServiceTest/192.168.0.107:5003> term 0 start preVote. 
{noformat}

  was:
{noformat}
2021-06-17 12:54:17:578 +0300 [main] INFO ITCliServiceTest - >>>>>>>>>>>>>>> 
Start test method: testChangePeers2021-06-17 12:54:17:578 +0300 [main] INFO 
ITCliServiceTest - >>>>>>>>>>>>>>> Start test method: testChangePeers2021-06-17 
12:54:26:228 +0300 [main] INFO FSMCallerImpl - Starts FSMCaller 
successfully.2021-06-17 12:54:26:262 +0300 [main] WARN LocalSnapshotStorage - 
No data for snapshot reader 
D:\work\ignite-3\modules\raft\jraft_test_1455162015862\192.168.0.107_5003\snapshot.2021-06-17
 12:54:26:276 +0300 [main] INFO NodeImpl - Node 
<CliServiceTest/192.168.0.107:5003> init, term=0, lastLogId=LogId [index=0, 
term=0], 
conf=192.168.0.107:5003,192.168.0.107:5004,192.168.0.107:5005,192.168.0.107:5103/learner,192.168.0.107:5104/learner,
 oldConf=.2021-06-17 12:54:27:224 +0300 
[JRaft-ElectionTimer-192.168.0.107:5003-0] INFO NodeImpl - Node 
<CliServiceTest/192.168.0.107:5003> term 0 start preVote.2021-06-17 
12:54:27:477 +0300 [JRaft-ElectionTimer-192.168.0.107:5003-0] ERROR 
RepeatedTimer - Run timer failed.java.lang.NullPointerException at 
io.scalecube.cluster.ClusterImpl.requestResponse(ClusterImpl.java:419) at 
org.apache.ignite.network.scalecube.ScaleCubeMessagingService.invoke(ScaleCubeMessagingService.java:123)
 at 
org.apache.ignite.raft.jraft.rpc.impl.IgniteRpcClient.send(IgniteRpcClient.java:130)
 at 
org.apache.ignite.raft.jraft.rpc.impl.IgniteRpcClient.invokeAsync(IgniteRpcClient.java:124)
 at 
org.apache.ignite.raft.jraft.rpc.impl.AbstractClientService.invokeWithDone(AbstractClientService.java:199)
 at 
org.apache.ignite.raft.jraft.rpc.impl.AbstractClientService.connect(AbstractClientService.java:130)
 at org.apache.ignite.raft.jraft.core.NodeImpl.preVote(NodeImpl.java:2668) at 
org.apache.ignite.raft.jraft.core.NodeImpl.handleElectionTimeout(NodeImpl.java:614)
 at org.apache.ignite.raft.jraft.core.NodeImpl$2.onTrigger(NodeImpl.java:910) 
at org.apache.ignite.raft.jraft.util.RepeatedTimer.run(RepeatedTimer.java:80) 
at 
org.apache.ignite.raft.jraft.util.RepeatedTimer.lambda$schedule$0(RepeatedTimer.java:177)
 at 
org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$HashedWheelTimeout.expire(HashedWheelTimer.java:577)
 at 
org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$HashedWheelBucket.expireTimeouts(HashedWheelTimer.java:649)
 at 
org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$Worker.run(HashedWheelTimer.java:383)
 at java.base/java.lang.Thread.run(Thread.java:834)2021-06-17 12:54:28:348 
+0300 [main] INFO Cluster - [null][doStart] Starting, config: 
ClusterConfig[metadata=null, metadataTimeout=1000, 
metadataCodec=io.scalecube.cluster.metadata.JdkMetadataCodec@2eee3069, 
memberAlias='192.168.0.107:5003', externalHost='null', externalPort=null, 
transportConfig=TransportConfig[port=0, isSecured=false, connectTimeout=1000, 
messageCodec=io.scalecube.cluster.transport.api.JdkMessageCodec@2da59753, 
maxFrameLength=2097152, 
transportFactory=org.apache.ignite.network.scalecube.DelegatingTransportFactory@5629510],
 failureDetectorConfig=FailureDetectorConfig[pingInterval=500, pingTimeout=200, 
pingReqMembers=1], gossipConfig=GossipConfig[gossipFanout=3, gossipInterval=10, 
gossipRepeatMult=2, gossipSegmentationThreshold=1000], 
membershipConfig=MembershipConfig[seedMembers=[192.168.0.107:5003, 
192.168.0.107:5004, 192.168.0.107:5005], syncInterval=1000, syncTimeout=3000, 
suspicionMult=1, namespace='default', removedMembersHistorySize=42]]2021-06-17 
12:54:28:501 +0300 [JRaft-ElectionTimer-192.168.0.107:5003-0] INFO NodeImpl - 
Node <CliServiceTest/192.168.0.107:5003> term 0 start preVote. {noformat}


> NPE in ClusterImpl on node start
> --------------------------------
>
>                 Key: IGNITE-14921
>                 URL: https://issues.apache.org/jira/browse/IGNITE-14921
>             Project: Ignite
>          Issue Type: Task
>            Reporter: Alexey Scherbakov
>            Priority: Major
>              Labels: ignite-3
>             Fix For: 3.0.0-alpha3
>
>
> {noformat}
> 2021-06-17 12:54:17:578 +0300 [main] INFO ITCliServiceTest - >>>>>>>>>>>>>>> 
> Start test method: testChangePeers
> 2021-06-17 12:54:17:578 +0300 [main] INFO ITCliServiceTest - >>>>>>>>>>>>>>> 
> Start test method: testChangePeers2021-06-17 12:54:26:228 +0300 [main] INFO 
> FSMCallerImpl - Starts FSMCaller successfully.2021-06-17 12:54:26:262 +0300 
> [main] WARN LocalSnapshotStorage - No data for snapshot reader 
> D:\work\ignite-3\modules\raft\jraft_test_1455162015862\192.168.0.107_5003\snapshot.
> 2021-06-17 12:54:26:276 +0300 [main] INFO NodeImpl - Node 
> <CliServiceTest/192.168.0.107:5003> init, term=0, lastLogId=LogId [index=0, 
> term=0], 
> conf=192.168.0.107:5003,192.168.0.107:5004,192.168.0.107:5005,192.168.0.107:5103/learner,192.168.0.107:5104/learner,
>  oldConf=.2021-06-17 12:54:27:224 +0300 
> [JRaft-ElectionTimer-192.168.0.107:5003-0] INFO NodeImpl - Node 
> <CliServiceTest/192.168.0.107:5003> term 0 start preVote.2021-06-17 
> 12:54:27:477 +0300 [JRaft-ElectionTimer-192.168.0.107:5003-0] ERROR 
> RepeatedTimer - Run timer failed.
> java.lang.NullPointerException at 
> io.scalecube.cluster.ClusterImpl.requestResponse(ClusterImpl.java:419) at 
> org.apache.ignite.network.scalecube.ScaleCubeMessagingService.invoke(ScaleCubeMessagingService.java:123)
>  at 
> org.apache.ignite.raft.jraft.rpc.impl.IgniteRpcClient.send(IgniteRpcClient.java:130)
>  at 
> org.apache.ignite.raft.jraft.rpc.impl.IgniteRpcClient.invokeAsync(IgniteRpcClient.java:124)
>  at 
> org.apache.ignite.raft.jraft.rpc.impl.AbstractClientService.invokeWithDone(AbstractClientService.java:199)
>  at 
> org.apache.ignite.raft.jraft.rpc.impl.AbstractClientService.connect(AbstractClientService.java:130)
>  at org.apache.ignite.raft.jraft.core.NodeImpl.preVote(NodeImpl.java:2668) at 
> org.apache.ignite.raft.jraft.core.NodeImpl.handleElectionTimeout(NodeImpl.java:614)
>  at org.apache.ignite.raft.jraft.core.NodeImpl$2.onTrigger(NodeImpl.java:910) 
> at org.apache.ignite.raft.jraft.util.RepeatedTimer.run(RepeatedTimer.java:80) 
> at 
> org.apache.ignite.raft.jraft.util.RepeatedTimer.lambda$schedule$0(RepeatedTimer.java:177)
>  at 
> org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$HashedWheelTimeout.expire(HashedWheelTimer.java:577)
>  at 
> org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$HashedWheelBucket.expireTimeouts(HashedWheelTimer.java:649)
>  at 
> org.apache.ignite.raft.jraft.util.timer.HashedWheelTimer$Worker.run(HashedWheelTimer.java:383)
>  at java.base/java.lang.Thread.run(Thread.java:834)
> 2021-06-17 12:54:28:348 +0300 [main] INFO Cluster - [null][doStart] Starting, 
> config: ClusterConfig[metadata=null, metadataTimeout=1000, 
> metadataCodec=io.scalecube.cluster.metadata.JdkMetadataCodec@2eee3069, 
> memberAlias='192.168.0.107:5003', externalHost='null', externalPort=null, 
> transportConfig=TransportConfig[port=0, isSecured=false, connectTimeout=1000, 
> messageCodec=io.scalecube.cluster.transport.api.JdkMessageCodec@2da59753, 
> maxFrameLength=2097152, 
> transportFactory=org.apache.ignite.network.scalecube.DelegatingTransportFactory@5629510],
>  failureDetectorConfig=FailureDetectorConfig[pingInterval=500, 
> pingTimeout=200, pingReqMembers=1], gossipConfig=GossipConfig[gossipFanout=3, 
> gossipInterval=10, gossipRepeatMult=2, gossipSegmentationThreshold=1000], 
> membershipConfig=MembershipConfig[seedMembers=[192.168.0.107:5003, 
> 192.168.0.107:5004, 192.168.0.107:5005], syncInterval=1000, syncTimeout=3000, 
> suspicionMult=1, namespace='default', removedMembersHistorySize=42]]
> 2021-06-17 12:54:28:501 +0300 [JRaft-ElectionTimer-192.168.0.107:5003-0] INFO 
> NodeImpl - Node <CliServiceTest/192.168.0.107:5003> term 0 start preVote. 
> {noformat}



--
This message was sent by Atlassian Jira
(v8.3.4#803005)

Reply via email to