search

Consensys / quorum-tools

Tools for running Quorum clusters and integration tests
Other
51 stars 33 forks source link

No etherbase set and no accounts found as default #1

Open bailantaotao opened 7 years ago

bailantaotao commented 7 years ago

Hello,

Following Installation were stuck on stack exec -- local-new command.

WARN [06-27|13:50:10] No etherbase set and no accounts found as default 
WARN [06-27|13:50:10] No etherbase set and no accounts found as default 
WARN [06-27|13:50:10] No etherbase set and no accounts found as default

How to fix it?

bts commented 7 years ago

Thanks for filing an issue. As a starting point, which version of geth are you using? Please paste the output from geth version.

bailantaotao commented 7 years ago 
➜  go-ethereum git:(dynamic-raft-membership) ✗ geth version                                  
Geth
Version: 1.6.0-stable
Git Commit: facc47cb5cec97b22c815a0a6118816a98f39876
Architecture: amd64
Protocol Versions: [63 62]
Network Id: 1
Go Version: go1.8.1
Operating System: darwin
bailantaotao commented 7 years ago

Hello, The message can be solved after setting Quorum Geth as global primary application.

But currently get stuck in sudo whoami && stack test Looks like the test: private state test do nothing after performing initial election succeeded. This is normal behavior?

full log:

➜  quorum-tools git:(master) sudo whoami && stack test
Password:
root
quorum-tools-0.0.1: test (suite: raft)

cycle test
12:32:26.823948000000: waiting for initial nodes to assume raft roles
12:32:30.775490000000: starting test with a pause
12:32:32.952361000000: waiting before adding node 4
12:32:34.954015000000: adding node 4
12:32:35.090726000000: waiting before removing node 1
12:32:37.095260000000: removing node 1
12:32:39.324327000000: waiting before adding node 5
12:32:41.325594000000: adding node 5
12:32:41.447324000000: waiting before removing node 2
12:32:43.452742000000: removing node 2
12:32:45.697513000000: waiting before adding node 6
12:32:47.698514000000: adding node 6
12:32:48.046233000000: waiting before removing node 3
12:32:50.051570000000: removing node 3
Right ()

leader partition test
test #0
12:32:59.071827000000: awaiting a successful raft election
12:33:01.660155000000: initial election succeeded
12:33:01.660665000000: starting test with a pause
12:33:03.665689000000: starting spammer
12:33:04.666372000000: partitioning
12:33:17.048023000000: unpartitioning
12:33:22.053481000000: ending test
Right ()

initial member leave/rejoin test
12:33:27.711147000000: starting test with a pause
12:33:30.719047000000: waiting before removing node 1
12:33:32.724761000000: removing node 1
12:33:33.881356000000: waiting before adding node 4
12:33:35.886644000000: adding node 4
Right ()

newcomer leave/rejoin test
12:33:43.339602000000: starting test with a pause
12:33:46.344749000000: waiting before adding node 3
12:33:48.349956000000: adding node 3
12:33:52.485751000000: waiting before removing node 3
12:33:54.487092000000: removing node 3
12:33:56.610677000000: waiting before adding node 4
12:33:58.616391000000: adding node 4
Right ()

private state test
test #0
12:34:04.690323000000: awaiting a successful raft election
12:34:06.992686000000: initial election succeeded
bts commented 7 years ago

I just talked to @joelburget, and it seems like contract creation is probably timing out in this test.

Ultimately it would probably be best for us to add a timeout combinator -- if too much time elapses, e.g. around sending a tx and waiting for it to get into the chain, we could dump all logs during that time.

In the mean time, could you post your geth logs (geth1.log, geth2.log, geth3.log) so we can see what's going on?

bailantaotao commented 7 years ago

ok,

geth1.out

I0710 12:03:05.864920 ethdb/database.go:81] Allotted 128MB cache and 1024 file handles to /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth1/geth/chaindata
I0710 12:03:05.876192 ethdb/database.go:174] closed db:/Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth1/geth/chaindata
I0710 12:03:05.877713 node/node.go:179] instance: Geth/v1.5.0-unstable-9918e6f9/darwin/go1.7.3
I0710 12:03:05.877746 ethdb/database.go:81] Allotted 128MB cache and 1024 file handles to /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth1/geth/chaindata
I0710 12:03:05.941420 eth/backend.go:177] Protocol Versions: [63 62], Network Id: 1418
I0710 12:03:05.942609 core/blockchain.go:225] Last header: #0 [79b3613e…] TD=0
I0710 12:03:05.942630 core/blockchain.go:226] Last block: #0 [79b3613e…] TD=0
I0710 12:03:05.942641 core/blockchain.go:227] Fast block: #0 [79b3613e…] TD=0
I0710 12:03:05.963338 p2p/server.go:328] Starting Server
I0710 12:03:05.963459 raft/handler.go:132] starting raft protocol handler
I0710 12:03:05.972806 p2p/server.go:582] Listening on [::]:30401
I0710 12:03:05.991985 raft/persistence.go:48] loaded the latest applied index: 0
I0710 12:03:05.992217 raft/wal.go:43] replaying WAL
I0710 12:03:06.015870 p2p/nat/nat.go:111] mapped network port tcp:30401 -> 30401 (ethereum p2p) using NAT-PMP(192.168.1.1)
I0710 12:03:06.387064 raft/wal.go:26] loading WAL
I0710 12:03:06.389972 raft/handler.go:444] local raft ID is 1
I0710 12:03:06.389995 raft/handler.go:456] starting a new raft log with an initial cluster size of 3.
2017-07-10 12:03:06.390117 I | rafthttp: starting peer 2...
2017-07-10 12:03:06.390212 I | rafthttp: started HTTP pipelining with peer 2
2017-07-10 12:03:06.390618 I | rafthttp: started streaming with peer 2 (writer)
2017-07-10 12:03:06.390924 I | rafthttp: started streaming with peer 2 (writer)
2017-07-10 12:03:06.391606 I | rafthttp: started peer 2
2017-07-10 12:03:06.391637 I | rafthttp: added peer 2
2017-07-10 12:03:06.391672 I | rafthttp: starting peer 3...
2017-07-10 12:03:06.391687 I | rafthttp: started HTTP pipelining with peer 3
2017-07-10 12:03:06.391712 I | rafthttp: started streaming with peer 2 (stream Message reader)
2017-07-10 12:03:06.391856 I | rafthttp: started streaming with peer 2 (stream MsgApp v2 reader)
2017-07-10 12:03:06.392091 I | rafthttp: started streaming with peer 3 (writer)
2017-07-10 12:03:06.392687 I | rafthttp: started streaming with peer 3 (writer)
2017-07-10 12:03:06.393105 I | rafthttp: started peer 3
2017-07-10 12:03:06.393134 I | rafthttp: added peer 3
2017-07-10 12:03:06.393140 I | rafthttp: started streaming with peer 3 (stream MsgApp v2 reader)
raft2017/07/10 12:03:06 INFO: 1 became follower at term 0
raft2017/07/10 12:03:06 INFO: newRaft 1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
raft2017/07/10 12:03:06 INFO: 1 became follower at term 1
2017-07-10 12:03:06.393249 I | rafthttp: started streaming with peer 3 (stream Message reader)
I0710 12:03:06.401222 node/node.go:344] IPC endpoint opened: /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth1/geth.ipc
2017-07-10 12:03:06.406662 I | rafthttp: peer 3 became active
2017-07-10 12:03:06.406684 I | rafthttp: established a TCP streaming connection with peer 3 (stream MsgApp v2 reader)
2017-07-10 12:03:06.407401 I | rafthttp: established a TCP streaming connection with peer 3 (stream Message reader)
I0710 12:03:06.417707 node/node.go:414] HTTP endpoint opened: http://localhost:40401
2017-07-10 12:03:06.471618 I | rafthttp: established a TCP streaming connection with peer 3 (stream Message writer)
2017-07-10 12:03:06.474168 I | rafthttp: peer 2 became active
2017-07-10 12:03:06.474196 I | rafthttp: established a TCP streaming connection with peer 2 (stream MsgApp v2 writer)
2017-07-10 12:03:06.474366 I | rafthttp: established a TCP streaming connection with peer 2 (stream Message writer)
2017-07-10 12:03:06.475888 I | rafthttp: established a TCP streaming connection with peer 3 (stream MsgApp v2 writer)
2017-07-10 12:03:06.497730 I | rafthttp: established a TCP streaming connection with peer 2 (stream MsgApp v2 reader)
2017-07-10 12:03:06.500979 I | rafthttp: established a TCP streaming connection with peer 2 (stream Message reader)
I0710 12:03:06.684990 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 1
I0710 12:03:06.685017 raft/snapshot.go:80] start snapshot [applied index: 1 | last snapshot index: 0]
I0710 12:03:06.751783 raft/snapshot.go:95] compacted log at index 1
I0710 12:03:06.751805 raft/persistence.go:54] persisted the latest applied index: 1
I0710 12:03:06.753364 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 2
I0710 12:03:06.753381 raft/snapshot.go:80] start snapshot [applied index: 2 | last snapshot index: 1]
I0710 12:03:06.821707 raft/snapshot.go:95] compacted log at index 2
I0710 12:03:06.821730 raft/persistence.go:54] persisted the latest applied index: 2
I0710 12:03:06.821799 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 3
I0710 12:03:06.821806 raft/snapshot.go:80] start snapshot [applied index: 3 | last snapshot index: 2]
I0710 12:03:06.884864 raft/snapshot.go:95] compacted log at index 3
I0710 12:03:06.884886 raft/persistence.go:54] persisted the latest applied index: 3
raft2017/07/10 12:03:07 INFO: 1 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 3 [logterm: 1, index: 3] at term 1
raft2017/07/10 12:03:07 INFO: 1 [term: 1] received a MsgVote message with higher term from 3 [term: 2]
raft2017/07/10 12:03:07 INFO: 1 became follower at term 2
raft2017/07/10 12:03:07 INFO: 1 [logterm: 1, index: 3, vote: 0] cast MsgVote for 3 [logterm: 1, index: 3] at term 2
raft2017/07/10 12:03:07 INFO: raft.node: 1 elected leader 3 at term 2
I0710 12:03:07.810988 logger/log_raft_checkpoint.go:18] RAFT-CHECKPOINT BECAME-VERIFIER []
I0710 12:03:07.835044 raft/persistence.go:54] persisted the latest applied index: 4
I0710 12:03:08.064457 cmd/geth/accountcmd.go:189] Unlocked account 4199091603d4724c0f549d54730e85f36df71d8b

geth2.out

I0710 12:03:05.870141 ethdb/database.go:81] Allotted 128MB cache and 1024 file handles to /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth2/geth/chaindata
I0710 12:03:05.882014 ethdb/database.go:174] closed db:/Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth2/geth/chaindata
I0710 12:03:05.882797 node/node.go:179] instance: Geth/v1.5.0-unstable-9918e6f9/darwin/go1.7.3
I0710 12:03:05.882823 ethdb/database.go:81] Allotted 128MB cache and 1024 file handles to /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth2/geth/chaindata
I0710 12:03:05.938080 eth/backend.go:177] Protocol Versions: [63 62], Network Id: 1418
I0710 12:03:05.939701 core/blockchain.go:225] Last header: #0 [79b3613e…] TD=0
I0710 12:03:05.939723 core/blockchain.go:226] Last block: #0 [79b3613e…] TD=0
I0710 12:03:05.939734 core/blockchain.go:227] Fast block: #0 [79b3613e…] TD=0
I0710 12:03:05.962877 p2p/server.go:328] Starting Server
I0710 12:03:05.963011 raft/handler.go:132] starting raft protocol handler
I0710 12:03:05.964673 p2p/server.go:582] Listening on [::]:30402
I0710 12:03:05.963164 raft/persistence.go:48] loaded the latest applied index: 0
I0710 12:03:05.966797 raft/wal.go:43] replaying WAL
I0710 12:03:06.008019 p2p/nat/nat.go:111] mapped network port tcp:30402 -> 30402 (ethereum p2p) using NAT-PMP(192.168.1.1)
I0710 12:03:06.409856 raft/wal.go:26] loading WAL
I0710 12:03:06.413562 raft/handler.go:444] local raft ID is 2
I0710 12:03:06.414749 raft/handler.go:456] starting a new raft log with an initial cluster size of 3.
2017-07-10 12:03:06.414875 I | rafthttp: starting peer 1...
2017-07-10 12:03:06.414930 I | rafthttp: started HTTP pipelining with peer 1
2017-07-10 12:03:06.420634 I | rafthttp: started peer 1
2017-07-10 12:03:06.420673 I | rafthttp: added peer 1
2017-07-10 12:03:06.422943 I | rafthttp: starting peer 3...
2017-07-10 12:03:06.422978 I | rafthttp: started HTTP pipelining with peer 3
2017-07-10 12:03:06.438850 I | rafthttp: started peer 3
2017-07-10 12:03:06.438883 I | rafthttp: added peer 3
raft2017/07/10 12:03:06 INFO: 2 became follower at term 0
raft2017/07/10 12:03:06 INFO: newRaft 2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
raft2017/07/10 12:03:06 INFO: 2 became follower at term 1
2017-07-10 12:03:06.447582 I | rafthttp: started streaming with peer 1 (writer)
2017-07-10 12:03:06.447614 I | rafthttp: started streaming with peer 1 (writer)
2017-07-10 12:03:06.448123 I | rafthttp: started streaming with peer 1 (stream MsgApp v2 reader)
2017-07-10 12:03:06.450568 I | rafthttp: started streaming with peer 1 (stream Message reader)
2017-07-10 12:03:06.451309 I | rafthttp: started streaming with peer 3 (writer)
2017-07-10 12:03:06.451785 I | rafthttp: started streaming with peer 3 (writer)
2017-07-10 12:03:06.451866 I | rafthttp: started streaming with peer 3 (stream MsgApp v2 reader)
2017-07-10 12:03:06.452576 I | rafthttp: started streaming with peer 3 (stream Message reader)
I0710 12:03:06.469319 node/node.go:344] IPC endpoint opened: /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth2/geth.ipc
2017-07-10 12:03:06.469444 I | rafthttp: peer 3 became active
2017-07-10 12:03:06.469461 I | rafthttp: established a TCP streaming connection with peer 3 (stream MsgApp v2 reader)
2017-07-10 12:03:06.469651 I | rafthttp: established a TCP streaming connection with peer 3 (stream Message reader)
2017-07-10 12:03:06.470519 I | rafthttp: established a TCP streaming connection with peer 3 (stream Message writer)
2017-07-10 12:03:06.471053 I | rafthttp: established a TCP streaming connection with peer 3 (stream MsgApp v2 writer)
2017-07-10 12:03:06.473744 I | rafthttp: peer 1 became active
2017-07-10 12:03:06.473762 I | rafthttp: established a TCP streaming connection with peer 1 (stream MsgApp v2 reader)
2017-07-10 12:03:06.475769 I | rafthttp: established a TCP streaming connection with peer 1 (stream Message reader)
I0710 12:03:06.480288 node/node.go:414] HTTP endpoint opened: http://localhost:40402
2017-07-10 12:03:06.497883 I | rafthttp: established a TCP streaming connection with peer 1 (stream MsgApp v2 writer)
2017-07-10 12:03:06.500864 I | rafthttp: established a TCP streaming connection with peer 1 (stream Message writer)
I0710 12:03:06.741563 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 1
I0710 12:03:06.741582 raft/snapshot.go:80] start snapshot [applied index: 1 | last snapshot index: 0]
I0710 12:03:06.812463 raft/snapshot.go:95] compacted log at index 1
I0710 12:03:06.812484 raft/persistence.go:54] persisted the latest applied index: 1
I0710 12:03:06.813378 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 2
I0710 12:03:06.813393 raft/snapshot.go:80] start snapshot [applied index: 2 | last snapshot index: 1]
I0710 12:03:06.872756 raft/snapshot.go:95] compacted log at index 2
I0710 12:03:06.872774 raft/persistence.go:54] persisted the latest applied index: 2
I0710 12:03:06.872838 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 3
I0710 12:03:06.872845 raft/snapshot.go:80] start snapshot [applied index: 3 | last snapshot index: 2]
I0710 12:03:06.908102 raft/snapshot.go:95] compacted log at index 3
I0710 12:03:06.908127 raft/persistence.go:54] persisted the latest applied index: 3
raft2017/07/10 12:03:07 INFO: 2 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 3 [logterm: 1, index: 3] at term 1
raft2017/07/10 12:03:07 INFO: 2 [term: 1] received a MsgVote message with higher term from 3 [term: 2]
raft2017/07/10 12:03:07 INFO: 2 became follower at term 2
raft2017/07/10 12:03:07 INFO: 2 [logterm: 1, index: 3, vote: 0] cast MsgVote for 3 [logterm: 1, index: 3] at term 2
raft2017/07/10 12:03:07 INFO: raft.node: 2 elected leader 3 at term 2
I0710 12:03:07.810961 logger/log_raft_checkpoint.go:18] RAFT-CHECKPOINT BECAME-VERIFIER []
I0710 12:03:07.823700 raft/persistence.go:54] persisted the latest applied index: 4
I0710 12:03:07.996275 cmd/geth/accountcmd.go:189] Unlocked account 9f6ff72b5aca247901fb1f1da652425d6ad1d86e

geth3.out

I0710 12:03:05.878729 ethdb/database.go:81] Allotted 128MB cache and 1024 file handles to /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth3/geth/chaindata
I0710 12:03:05.894716 ethdb/database.go:174] closed db:/Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth3/geth/chaindata
I0710 12:03:05.896096 node/node.go:179] instance: Geth/v1.5.0-unstable-9918e6f9/darwin/go1.7.3
I0710 12:03:05.896173 ethdb/database.go:81] Allotted 128MB cache and 1024 file handles to /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth3/geth/chaindata
I0710 12:03:05.932116 eth/backend.go:177] Protocol Versions: [63 62], Network Id: 1418
I0710 12:03:05.932914 core/blockchain.go:225] Last header: #0 [79b3613e…] TD=0
I0710 12:03:05.932928 core/blockchain.go:226] Last block: #0 [79b3613e…] TD=0
I0710 12:03:05.932936 core/blockchain.go:227] Fast block: #0 [79b3613e…] TD=0
I0710 12:03:05.938582 p2p/server.go:328] Starting Server
I0710 12:03:05.938769 raft/handler.go:132] starting raft protocol handler
I0710 12:03:05.938867 raft/persistence.go:48] loaded the latest applied index: 0
I0710 12:03:05.938900 raft/wal.go:43] replaying WAL
I0710 12:03:05.939483 p2p/server.go:582] Listening on [::]:30403
I0710 12:03:05.977773 p2p/nat/nat.go:111] mapped network port tcp:30403 -> 30403 (ethereum p2p) using NAT-PMP(192.168.1.1)
I0710 12:03:06.345838 raft/wal.go:26] loading WAL
I0710 12:03:06.358681 raft/handler.go:444] local raft ID is 3
I0710 12:03:06.358708 raft/handler.go:456] starting a new raft log with an initial cluster size of 3.
2017-07-10 12:03:06.358840 I | rafthttp: starting peer 1...
2017-07-10 12:03:06.358900 I | rafthttp: started HTTP pipelining with peer 1
2017-07-10 12:03:06.359423 I | rafthttp: started streaming with peer 1 (writer)
2017-07-10 12:03:06.359715 I | rafthttp: started streaming with peer 1 (writer)
2017-07-10 12:03:06.360166 I | rafthttp: started peer 1
2017-07-10 12:03:06.360190 I | rafthttp: added peer 1
2017-07-10 12:03:06.360231 I | rafthttp: starting peer 2...
2017-07-10 12:03:06.360242 I | rafthttp: started streaming with peer 1 (stream Message reader)
2017-07-10 12:03:06.360292 I | rafthttp: started streaming with peer 1 (stream MsgApp v2 reader)
2017-07-10 12:03:06.360326 I | rafthttp: started HTTP pipelining with peer 2
2017-07-10 12:03:06.360711 I | rafthttp: started streaming with peer 2 (writer)
2017-07-10 12:03:06.360961 I | rafthttp: started streaming with peer 2 (writer)
2017-07-10 12:03:06.361517 I | rafthttp: started peer 2
2017-07-10 12:03:06.361545 I | rafthttp: added peer 2
2017-07-10 12:03:06.361566 I | rafthttp: started streaming with peer 2 (stream Message reader)
raft2017/07/10 12:03:06 INFO: 3 became follower at term 0
raft2017/07/10 12:03:06 INFO: newRaft 3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
raft2017/07/10 12:03:06 INFO: 3 became follower at term 1
2017-07-10 12:03:06.361625 I | rafthttp: started streaming with peer 2 (stream MsgApp v2 reader)
I0710 12:03:06.367244 node/node.go:344] IPC endpoint opened: /Users/Edwin/Workspace/go/src/github.com/jpmorganchase/quorum-tools/gdata/geth3/geth.ipc
I0710 12:03:06.370640 node/node.go:414] HTTP endpoint opened: http://localhost:40403
2017-07-10 12:03:06.403391 I | rafthttp: peer 1 became active
2017-07-10 12:03:06.403415 I | rafthttp: established a TCP streaming connection with peer 1 (stream Message writer)
2017-07-10 12:03:06.438053 I | rafthttp: established a TCP streaming connection with peer 1 (stream MsgApp v2 writer)
2017-07-10 12:03:06.469485 I | rafthttp: peer 2 became active
2017-07-10 12:03:06.469502 I | rafthttp: established a TCP streaming connection with peer 2 (stream MsgApp v2 writer)
2017-07-10 12:03:06.469595 I | rafthttp: established a TCP streaming connection with peer 2 (stream Message writer)
2017-07-10 12:03:06.470561 I | rafthttp: established a TCP streaming connection with peer 2 (stream Message reader)
2017-07-10 12:03:06.471210 I | rafthttp: established a TCP streaming connection with peer 2 (stream MsgApp v2 reader)
2017-07-10 12:03:06.472045 I | rafthttp: established a TCP streaming connection with peer 1 (stream MsgApp v2 reader)
2017-07-10 12:03:06.472241 I | rafthttp: established a TCP streaming connection with peer 1 (stream Message reader)
I0710 12:03:06.606651 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 1
I0710 12:03:06.606690 raft/snapshot.go:80] start snapshot [applied index: 1 | last snapshot index: 0]
I0710 12:03:06.704467 raft/snapshot.go:95] compacted log at index 1
I0710 12:03:06.704493 raft/persistence.go:54] persisted the latest applied index: 1
I0710 12:03:06.705938 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 2
I0710 12:03:06.705962 raft/snapshot.go:80] start snapshot [applied index: 2 | last snapshot index: 1]
I0710 12:03:06.802260 raft/snapshot.go:95] compacted log at index 2
I0710 12:03:06.802284 raft/persistence.go:54] persisted the latest applied index: 2
I0710 12:03:06.802406 raft/handler.go:735] ignoring expected ConfChangeAddNode for initial peer 3
I0710 12:03:06.802415 raft/snapshot.go:80] start snapshot [applied index: 3 | last snapshot index: 2]
I0710 12:03:06.872756 raft/snapshot.go:95] compacted log at index 3
I0710 12:03:06.872774 raft/persistence.go:54] persisted the latest applied index: 3
raft2017/07/10 12:03:07 INFO: 3 is starting a new election at term 1
raft2017/07/10 12:03:07 INFO: 3 became pre-candidate at term 1
raft2017/07/10 12:03:07 INFO: 3 received MsgPreVoteResp from 3 at term 1
raft2017/07/10 12:03:07 INFO: 3 [logterm: 1, index: 3] sent MsgPreVote request to 2 at term 1
raft2017/07/10 12:03:07 INFO: 3 [logterm: 1, index: 3] sent MsgPreVote request to 1 at term 1
raft2017/07/10 12:03:07 INFO: 3 received MsgPreVoteResp from 2 at term 1
raft2017/07/10 12:03:07 INFO: 3 [quorum:2] has received 2 MsgPreVoteResp votes and 0 vote rejections
raft2017/07/10 12:03:07 INFO: 3 became candidate at term 2
raft2017/07/10 12:03:07 INFO: 3 received MsgVoteResp from 3 at term 2
raft2017/07/10 12:03:07 INFO: 3 [logterm: 1, index: 3] sent MsgVote request to 1 at term 2
raft2017/07/10 12:03:07 INFO: 3 [logterm: 1, index: 3] sent MsgVote request to 2 at term 2
raft2017/07/10 12:03:07 INFO: 3 [term: 2] ignored a MsgPreVoteResp message with lower term from 1 [term: 1]
raft2017/07/10 12:03:07 INFO: 3 received MsgVoteResp from 1 at term 2
raft2017/07/10 12:03:07 INFO: 3 [quorum:2] has received 2 MsgVoteResp votes and 0 vote rejections
raft2017/07/10 12:03:07 INFO: 3 became leader at term 2
raft2017/07/10 12:03:07 INFO: raft.node: 3 elected leader 3 at term 2
I0710 12:03:07.789049 logger/log_raft_checkpoint.go:18] RAFT-CHECKPOINT BECAME-MINTER []
I0710 12:03:07.789230 raft/minter.go:286] Not minting a new block since there are no pending transactions
I0710 12:03:07.823519 raft/persistence.go:54] persisted the latest applied index: 4
I0710 12:03:07.991394 cmd/geth/accountcmd.go:189] Unlocked account 0c42833f30ce3bfcf878ca549f48b19a80a9c9ca
bailantaotao commented 7 years ago

Do you have any update on this issue?

Chandubabuankam commented 6 years ago

Me Also facing same issue. Can any one give solution???