commit 61705a14e01cadd0c98ca5241ca22315700bec84 from: Sergey Bronnikov via: Sergey Bronnikov date: Thu Jan 18 10:14:48 2024 UTC curl-diff commit - 42fb0ce94bad0b6c49f3626c32f55e53d7abfb66 commit + 61705a14e01cadd0c98ca5241ca22315700bec84 blob - /dev/null blob + 20a02f807621238f034f312dbbe91bbc4fbd96a1 (mode 644) --- /dev/null +++ curl-question/curl-diff.log @@ -0,0 +1,1041 @@ +1c1 +< 2024-01-18 12:05:48.508 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 startup +--- +> 2024-01-18 12:19:58.865 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 startup +3,267c3,267 +< Started on Thu Jan 18 12:05:48 2024 +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.510981+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_ADVERTISE_CLIENT_URLS","variable-value":"https://localhost:2379"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.511056+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_CERT_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.511067+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/tmp/uqKJxk/test1"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51126+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_ADVERTISE_PEER_URLS","variable-value":"http://localhost:2380"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.511277+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER","variable-value":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.511284+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER_STATE","variable-value":"new"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51129+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_KEY_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.511301+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_CLIENT_URLS","variable-value":"https://localhost:2379"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51131+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_PEER_URLS","variable-value":"http://localhost:2380"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51132+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"test1"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.511342+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_TRUSTED_CA_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:48.5114+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.511415+0300","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/tmp/etcd-download-test/etcd"]} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:48.511444+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51145+0300","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51162+0300","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://localhost:2379"]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.511667+0300","caller":"embed/etcd.go:309","msg":"starting an etcd server","etcd-version":"3.5.8","git-sha":"217d183e5","go-version":"go1.19.8","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"test1","data-dir":"/tmp/uqKJxk/test1","wal-dir":"","wal-dir-dedicated":"","member-dir":"/tmp/uqKJxk/test1/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["https://localhost:2379"],"listen-client-urls":["https://localhost:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51258+0300","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/tmp/uqKJxk/test1/member/snap/db","took":"740.406µs"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512519+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_ADVERTISE_CLIENT_URLS","variable-value":"https://localhost:2381"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512703+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_CERT_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512717+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/tmp/uqKJxk/test2"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512741+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_ADVERTISE_PEER_URLS","variable-value":"http://localhost:2382"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512747+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER","variable-value":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512753+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER_STATE","variable-value":"new"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512759+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_KEY_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512767+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_CLIENT_URLS","variable-value":"https://localhost:2381"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512776+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_PEER_URLS","variable-value":"http://localhost:2382"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512785+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"test2"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512803+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_TRUSTED_CA_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:48.51286+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512875+0300","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/tmp/etcd-download-test/etcd"]} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:48.512893+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.512899+0300","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2382"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.513048+0300","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://localhost:2381"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.513106+0300","caller":"embed/etcd.go:309","msg":"starting an etcd server","etcd-version":"3.5.8","git-sha":"217d183e5","go-version":"go1.19.8","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"test2","data-dir":"/tmp/uqKJxk/test2","wal-dir":"","wal-dir-dedicated":"","member-dir":"/tmp/uqKJxk/test2/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2382"],"listen-peer-urls":["http://localhost:2382"],"advertise-client-urls":["https://localhost:2381"],"listen-client-urls":["https://localhost:2381"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.513865+0300","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/tmp/uqKJxk/test2/member/snap/db","took":"614.337µs"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51474+0300","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"de368b0e4577b2d6"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.514774+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.514795+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.514801+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.514807+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51483+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880)"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51484+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437)"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.514851+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.514642+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_ADVERTISE_CLIENT_URLS","variable-value":"https://localhost:2383"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.514925+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_CERT_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.51494+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/tmp/uqKJxk/test3"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.514971+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_ADVERTISE_PEER_URLS","variable-value":"http://localhost:2384"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.514977+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER","variable-value":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.514984+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER_STATE","variable-value":"new"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.514991+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_KEY_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.514998+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_CLIENT_URLS","variable-value":"https://localhost:2383"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.515006+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_PEER_URLS","variable-value":"http://localhost:2384"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.515015+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"test3"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.515034+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_TRUSTED_CA_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:48.515209+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.515227+0300","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/tmp/etcd-download-test/etcd"]} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:48.515247+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.515254+0300","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2384"]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.515384+0300","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://localhost:2383"]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.515441+0300","caller":"embed/etcd.go:309","msg":"starting an etcd server","etcd-version":"3.5.8","git-sha":"217d183e5","go-version":"go1.19.8","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"test3","data-dir":"/tmp/uqKJxk/test3","wal-dir":"","wal-dir-dedicated":"","member-dir":"/tmp/uqKJxk/test3/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2384"],"listen-peer-urls":["http://localhost:2384"],"advertise-client-urls":["https://localhost:2383"],"listen-client-urls":["https://localhost:2383"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:48.51668+0300","caller":"auth/store.go:1238","msg":"simple token is not cryptographically signed"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.516817+0300","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/tmp/uqKJxk/test3/member/snap/db","took":"1.248859ms"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.517396+0300","caller":"mvcc/kvstore.go:393","msg":"kvstore restored","current-rev":1} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.51791+0300","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.518402+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.518414+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.518747+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519341+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519368+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519395+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8","remote-peer-urls":["http://localhost:2382"]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519407+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519418+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519501+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519675+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519757+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.519768+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520072+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520074+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520087+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f","remote-peer-urls":["http://localhost:2384"]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520097+0300","caller":"etcdserver/server.go:854","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.8","cluster-version":"to_be_decided"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520164+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520179+0300","caller":"etcdserver/server.go:754","msg":"starting initial election tick advance","election-ticks":10} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520219+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test1/member/snap","suffix":"snap.db","max":5,"interval":"30s"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520237+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test1/member/snap","suffix":"snap","max":5,"interval":"30s"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520244+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test1/member/wal","suffix":"wal","max":5,"interval":"30s"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520568+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520616+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"8e9e05c52164694d","added-peer-id":"7e3bd17c66e004e8","added-peer-peer-urls":["http://localhost:2382"]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520641+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520665+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520692+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.520704+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"8e9e05c52164694d","added-peer-id":"fa252746f913ab7f","added-peer-peer-urls":["http://localhost:2384"]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.521091+0300","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt, key = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key, client-cert=, client-key=, trusted-ca = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt, client-cert-auth = false, crl-file = ","cipher-suites":[]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.521126+0300","caller":"embed/etcd.go:278","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["https://localhost:2379"],"listen-client-urls":["https://localhost:2379"],"listen-metrics-urls":[]} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.521138+0300","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"127.0.0.1:2380"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.521147+0300","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"127.0.0.1:2380"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.523256+0300","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.52329+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=()"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.523304+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became follower at term 0"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.523309+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fa252746f913ab7f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.523312+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became follower at term 1"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.523329+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880)"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.523337+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437)"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.523343+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.523658+0300","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7e3bd17c66e004e8","cluster-id":"de368b0e4577b2d6"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.523685+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=()"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.523697+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 became follower at term 0"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.523701+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7e3bd17c66e004e8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.523704+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 became follower at term 1"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.523718+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880)"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.523724+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437)"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.523731+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:48.525322+0300","caller":"auth/store.go:1238","msg":"simple token is not cryptographically signed"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:48.525568+0300","caller":"auth/store.go:1238","msg":"simple token is not cryptographically signed"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.526287+0300","caller":"mvcc/kvstore.go:393","msg":"kvstore restored","current-rev":1} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.526363+0300","caller":"mvcc/kvstore.go:393","msg":"kvstore restored","current-rev":1} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.526841+0300","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.527037+0300","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.527523+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.527543+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.52782+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.527839+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.52789+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.528198+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.528296+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.528645+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.528674+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8","remote-peer-urls":["http://localhost:2382"]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.528686+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.52868+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.528699+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.528712+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.52889+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.52893+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.528947+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.528957+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d","remote-peer-urls":["http://localhost:2380"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.528948+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.528966+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.52898+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.529069+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.529642+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"8e9e05c52164694d","to":"7e3bd17c66e004e8","stream-type":"stream MsgApp v2"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.529659+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.529669+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.529925+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"8e9e05c52164694d","to":"7e3bd17c66e004e8","stream-type":"stream Message"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.529934+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.530062+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"8e9e05c52164694d","to":"fa252746f913ab7f","stream-type":"stream MsgApp v2"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.53007+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.530077+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.530131+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"8e9e05c52164694d","to":"fa252746f913ab7f","stream-type":"stream Message"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.530139+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.529025+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.529714+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.529717+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.529742+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d","remote-peer-urls":["http://localhost:2380"]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.529761+0300","caller":"etcdserver/server.go:854","msg":"starting etcd server","local-member-id":"fa252746f913ab7f","local-server-version":"3.5.8","cluster-version":"to_be_decided"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.529876+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530037+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test3/member/snap","suffix":"snap.db","max":5,"interval":"30s"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530058+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test3/member/snap","suffix":"snap","max":5,"interval":"30s"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530067+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test3/member/wal","suffix":"wal","max":5,"interval":"30s"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530084+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530079+0300","caller":"etcdserver/server.go:754","msg":"starting initial election tick advance","election-ticks":10} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530097+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530145+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530502+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530569+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"fa252746f913ab7f","added-peer-id":"7e3bd17c66e004e8","added-peer-peer-urls":["http://localhost:2382"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.529448+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.529645+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.529666+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.530263+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.53039+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.530499+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.53052+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f","remote-peer-urls":["http://localhost:2384"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.530534+0300","caller":"etcdserver/server.go:854","msg":"starting etcd server","local-member-id":"7e3bd17c66e004e8","local-server-version":"3.5.8","cluster-version":"to_be_decided"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.530732+0300","caller":"etcdserver/server.go:754","msg":"starting initial election tick advance","election-ticks":10} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530632+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530686+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"fa252746f913ab7f","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530723+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.530744+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"fa252746f913ab7f","added-peer-id":"fa252746f913ab7f","added-peer-peer-urls":["http://localhost:2384"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.530775+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.53078+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test2/member/snap","suffix":"snap.db","max":5,"interval":"30s"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.530789+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.530804+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test2/member/snap","suffix":"snap","max":5,"interval":"30s"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.530811+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/uqKJxk/test2/member/wal","suffix":"wal","max":5,"interval":"30s"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531082+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531124+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"7e3bd17c66e004e8","added-peer-id":"7e3bd17c66e004e8","added-peer-peer-urls":["http://localhost:2382"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531148+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531173+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"7e3bd17c66e004e8","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531191+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531203+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"7e3bd17c66e004e8","added-peer-id":"fa252746f913ab7f","added-peer-peer-urls":["http://localhost:2384"]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531369+0300","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt, key = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key, client-cert=, client-key=, trusted-ca = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt, client-cert-auth = false, crl-file = ","cipher-suites":[]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531411+0300","caller":"embed/etcd.go:278","msg":"now serving peer/client/metrics","local-member-id":"fa252746f913ab7f","initial-advertise-peer-urls":["http://localhost:2384"],"listen-peer-urls":["http://localhost:2384"],"advertise-client-urls":["https://localhost:2383"],"listen-client-urls":["https://localhost:2383"],"listen-metrics-urls":[]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531439+0300","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"127.0.0.1:2384"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531447+0300","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"127.0.0.1:2384"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531569+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531579+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531609+0300","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt, key = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key, client-cert=, client-key=, trusted-ca = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt, client-cert-auth = false, crl-file = ","cipher-suites":[]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531652+0300","caller":"embed/etcd.go:278","msg":"now serving peer/client/metrics","local-member-id":"7e3bd17c66e004e8","initial-advertise-peer-urls":["http://localhost:2382"],"listen-peer-urls":["http://localhost:2382"],"advertise-client-urls":["https://localhost:2381"],"listen-client-urls":["https://localhost:2381"],"listen-metrics-urls":[]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531668+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531677+0300","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"127.0.0.1:2382"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531687+0300","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"127.0.0.1:2382"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531582+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"fa252746f913ab7f","to":"7e3bd17c66e004e8","stream-type":"stream MsgApp v2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531591+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531588+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"fa252746f913ab7f","to":"8e9e05c52164694d","stream-type":"stream Message"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531599+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531603+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531647+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"fa252746f913ab7f","to":"8e9e05c52164694d","stream-type":"stream MsgApp v2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531656+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531663+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"fa252746f913ab7f","to":"7e3bd17c66e004e8","stream-type":"stream Message"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531673+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.53187+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.531871+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.531624+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.531644+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.531825+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.531854+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531803+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"7e3bd17c66e004e8","to":"8e9e05c52164694d","stream-type":"stream Message"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531812+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531829+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"7e3bd17c66e004e8","to":"fa252746f913ab7f","stream-type":"stream Message"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531935+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"7e3bd17c66e004e8","to":"8e9e05c52164694d","stream-type":"stream MsgApp v2"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.53195+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531839+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531976+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"7e3bd17c66e004e8","to":"fa252746f913ab7f","stream-type":"stream MsgApp v2"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.531985+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:48.571052+0300","caller":"etcdserver/server.go:777","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:48.58041+0300","caller":"etcdserver/server.go:777","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"f2024-01-18 12:05:48.608 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 startup +< a252746f913ab7f","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:48.580951+0300","caller":"etcdserver/server.go:777","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"7e3bd17c66e004e8","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024095+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f is starting a new election at term 1"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024139+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became pre-candidate at term 1"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024178+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f received MsgPreVoteResp from fa252746f913ab7f at term 1"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024199+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [logterm: 1, index: 3] sent MsgPreVote request to 7e3bd17c66e004e8 at term 1"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024221+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [logterm: 1, index: 3] sent MsgPreVote request to 8e9e05c52164694d at term 1"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.024491+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for fa252746f913ab7f [logterm: 1, index: 3] at term 1"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.024516+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [logterm: 1, index: 3, vote: 0] cast MsgPreVote for fa252746f913ab7f [logterm: 1, index: 3] at term 1"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024686+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f received MsgPreVoteResp from 8e9e05c52164694d at term 1"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.02471+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f has received 2 MsgPreVoteResp votes and 0 vote rejections"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024724+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became candidate at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024733+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f received MsgVoteResp from fa252746f913ab7f at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024752+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [logterm: 1, index: 3] sent MsgVote request to 7e3bd17c66e004e8 at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.024762+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [logterm: 1, index: 3] sent MsgVote request to 8e9e05c52164694d at term 2"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.025243+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [term: 1] received a MsgVote message with higher term from fa252746f913ab7f [term: 2]"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.025263+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 2"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.025275+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [logterm: 1, index: 3, vote: 0] cast MsgVote for fa252746f913ab7f [logterm: 1, index: 3] at term 2"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.025259+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 [term: 1] received a MsgVote message with higher term from fa252746f913ab7f [term: 2]"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.025302+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 became follower at term 2"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.025325+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 [logterm: 1, index: 3, vote: 0] cast MsgVote for fa252746f913ab7f [logterm: 1, index: 3] at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.025804+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f received MsgVoteResp from 8e9e05c52164694d at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.025838+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f has received 2 MsgVoteResp votes and 0 vote rejections"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.025862+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became leader at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.025891+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fa252746f913ab7f elected leader fa252746f913ab7f at term 2"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.026112+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader fa252746f913ab7f at term 2"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.026112+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e3bd17c66e004e8 elected leader fa252746f913ab7f at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.031513+0300","caller":"etcdserver/server.go:2571","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.031917+0300","caller":"etcdserver/server.go:2062","msg":"published local member to cluster through raft","local-member-id":"fa252746f913ab7f","local-member-attributes":"{Name:test3 ClientURLs:[https://localhost:2383]}","request-path":"/0/members/fa252746f913ab7f/attributes","cluster-id":"de368b0e4577b2d6","publish-timeout":"7s"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.031924+0300","caller":"embed/serve.go:103","msg":"ready to serve client requests"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.03199+0300","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.031999+0300","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.032213+0300","caller":"embed/serve.go:103","msg":"ready to serve client requests"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.032214+0300","caller":"etcdserver/server.go:2062","msg":"published local member to cluster through raft","local-member-id":"7e3bd17c66e004e8","local-member-attributes":"{Name:test2 ClientURLs:[https://localhost:2381]}","request-path":"/0/members/7e3bd17c66e004e8/attributes","cluster-id":"de368b0e4577b2d6","publish-timeout":"7s"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.032283+0300","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.032289+0300","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.03254+0300","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2383"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.032561+0300","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de368b0e4577b2d6","local-member-i2024-01-18 12:05:49.037 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 startup +< 2024-01-18 12:05:49.044 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 startup +< 2024-01-18 12:05:49.051 [66324] main/103/luatest/etcd-client.client.pool V> etcd transport | stream: /watch +--- +> Started on Thu Jan 18 12:19:58 2024 +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868333+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_ADVERTISE_CLIENT_URLS","variable-value":"https://localhost:2379"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868489+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_CERT_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868503+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/tmp/W2ZHhX/test1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868529+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_ADVERTISE_PEER_URLS","variable-value":"http://localhost:2380"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868535+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER","variable-value":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868547+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER_STATE","variable-value":"new"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868554+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_KEY_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868572+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_CLIENT_URLS","variable-value":"https://localhost:2379"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868584+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_PEER_URLS","variable-value":"http://localhost:2380"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868604+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"test1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868771+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_TRUSTED_CA_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:19:58.86883+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868862+0300","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/tmp/etcd-download-test/etcd"]} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:19:58.868893+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.868901+0300","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.86911+0300","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://localhost:2379"]} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.869172+0300","caller":"embed/etcd.go:309","msg":"starting an etcd server","etcd-version":"3.5.8","git-sha":"217d183e5","go-version":"go1.19.8","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"test1","data-dir":"/tmp/W2ZHhX/test1","wal-dir":"","wal-dir-dedicated":"","member-dir":"/tmp/W2ZHhX/test1/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["https://localhost:2379"],"listen-client-urls":["https://localhost:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.869945+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_ADVERTISE_CLIENT_URLS","variable-value":"https://localhost:2381"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870019+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_CERT_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870056+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/tmp/W2ZHhX/test2"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870238+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_ADVERTISE_PEER_URLS","variable-value":"http://localhost:2382"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.87025+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER","variable-value":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870257+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER_STATE","variable-value":"new"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870264+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_KEY_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870273+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_CLIENT_URLS","variable-value":"https://localhost:2381"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870283+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_PEER_URLS","variable-value":"http://localhost:2382"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870297+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"test2"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870319+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_TRUSTED_CA_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:19:58.870357+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870377+0300","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/tmp/etcd-download-test/etcd"]} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:19:58.8704+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870407+0300","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2382"]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870644+0300","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://localhost:2381"]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.870701+0300","caller":"embed/etcd.go:309","msg":"starting an etcd server","etcd-version":"3.5.8","git-sha":"217d183e5","go-version":"go1.19.8","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"test2","data-dir":"/tmp/W2ZHhX/test2","wal-dir":"","wal-dir-dedicated":"","member-dir":"/tmp/W2ZHhX/test2/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2382"],"listen-peer-urls":["http://localhost:2382"],"advertise-client-urls":["https://localhost:2381"],"listen-client-urls":["https://localhost:2381"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871559+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_ADVERTISE_CLIENT_URLS","variable-value":"https://localhost:2383"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871652+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_CERT_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871702+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/tmp/W2ZHhX/test3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871808+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_ADVERTISE_PEER_URLS","variable-value":"http://localhost:2384"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871813+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER","variable-value":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871817+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_INITIAL_CLUSTER_STATE","variable-value":"new"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871821+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_KEY_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871826+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_CLIENT_URLS","variable-value":"https://localhost:2383"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871832+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_LISTEN_PEER_URLS","variable-value":"http://localhost:2384"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871839+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"test3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871855+0300","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_TRUSTED_CA_FILE","variable-value":"/home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:19:58.871899+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871908+0300","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/tmp/etcd-download-test/etcd"]} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:19:58.871924+0300","caller":"embed/config.go:673","msg":"Running http and grpc server on single port. This is not recommended for production."} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.871928+0300","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2384"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.872096+0300","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://localhost:2383"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.872138+0300","caller":"embed/etcd.go:309","msg":"starting an etcd server","etcd-version":"3.5.8","git-sha":"217d183e5","go-version":"go1.19.8","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"test3","data-dir":"/tmp/W2ZHhX/test3","wal-dir":"","wal-dir-dedicated":"","member-dir":"/tmp/W2ZHhX/test3/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://localhost:2384"],"listen-peer-urls":["http://localhost:2384"],"advertise-client-urls":["https://localhost:2383"],"listen-client-urls":["https://localhost:2383"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"test1=http://localhost:2380,test2=http://localhost:2382,test3=http://localhost:2384","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:19:58.87999+0300","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/tmp/W2ZHhX/test3/member/snap/db","took":"7.747742ms"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:19:58.879988+0300","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/tmp/W2ZHhX/test2/member/snap/db","took":"9.133163ms"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:19:58.88039+0300","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/tmp/W2ZH2024-01-18 12:19:58.966 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 startup +> hX/test1/member/snap/db","took":"11.051615ms"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.885546+0300","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.885643+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=()"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.885686+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became follower at term 0"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.885701+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fa252746f913ab7f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.885713+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became follower at term 1"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.885772+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880)"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.885796+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437)"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.885819+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.885559+0300","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"de368b0e4577b2d6"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.885647+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.885688+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.885702+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.885715+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.885766+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.885792+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.885814+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.885924+0300","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7e3bd17c66e004e8","cluster-id":"de368b0e4577b2d6"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.886004+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=()"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.886042+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 became follower at term 0"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.886057+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7e3bd17c66e004e8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.88607+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 became follower at term 1"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.886116+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880)"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.88614+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437)"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.886164+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:00.887309+0300","caller":"auth/store.go:1238","msg":"simple token is not cryptographically signed"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:00.887388+0300","caller":"auth/store.go:1238","msg":"simple token is not cryptographically signed"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:00.887467+0300","caller":"auth/store.go:1238","msg":"simple token is not cryptographically signed"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.889008+0300","caller":"mvcc/kvstore.go:393","msg":"kvstore restored","current-rev":1} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.889203+0300","caller":"mvcc/kvstore.go:393","msg":"kvstore restored","current-rev":1} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.889307+0300","caller":"mvcc/kvstore.go:393","msg":"kvstore restored","current-rev":1} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.89012+0300","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.890305+0300","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.890486+0300","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.891309+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.891724+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.891481+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.891561+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.892108+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.892515+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.892381+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.893905+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.893903+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.89406+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.895337+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.894621+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.894715+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8","remote-peer-urls":["http://localhost:2382"]} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.894754+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.894811+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.895283+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.895262+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.895476+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.896025+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.896653+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.896724+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f","remote-peer-urls":["http://localhost:2384"]} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.89679+0300","caller":"etcdserver/server.go:854","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.8","cluster-version":"to_be_decided"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.89669+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.896023+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.896079+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.896118+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d","remote-peer-urls":["http://localhost:2380"]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.89615+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.896179+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.896848+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.89769+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.895977+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.896663+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.896708+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8","remote-peer-urls":["http://localhost:2382"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.896742+0300","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.896787+0300","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.899833+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.898499+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.899202+0300","caller":"etcdserver/server.go:754","msg":"starting initial election tick advance","election-ticks":10} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.900029+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test1/member/snap","suffix":"snap.db","max":5,"interval":"30s"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.900081+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test1/member/snap","suffix":"snap","max":5,"interval":"30s"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.900094+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test1/member/wal","suffix":"wal","max":5,"interval":"30s"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.898831+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.89934+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.900307+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.900441+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.90059+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"8e9e05c52164694d","added-peer-id":"7e3bd17c66e004e8","added-peer-peer-urls":["http://localhost:2382"]} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.900682+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.900745+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.900806+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.900849+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"8e9e05c52164694d","added-peer-id":"fa252746f913ab7f","added-peer-peer-urls":["http://localhost:2384"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.90107+0300","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901635+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901651+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901681+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d","remote-peer-urls":["http://localhost:2380"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901735+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901764+0300","caller":"etcdserver/server.go:854","msg":"starting etcd server","local-member-id":"fa252746f913ab7f","local-server-version":"3.5.8","cluster-version":"to_be_decided"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901823+0300","caller":"etcdserver/server.go:754","msg":"starting initial election tick advance","election-ticks":10} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.901914+0300","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt, key = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key, client-cert=, client-key=, trusted-ca = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt, client-cert-auth = false, crl-file = ","cipher-suites":[]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901907+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test3/member/snap","suffix":"snap.db","max":5,"interval":"30s"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901944+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test3/member/snap","suffix":"snap","max":5,"interval":"30s"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.901959+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test3/member/wal","suffix":"wal","max":5,"interval":"30s"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902024+0300","caller":"embed/etcd.go:278","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["https://localhost:2379"],"listen-client-urls":["https://localhost:2379"],"listen-metrics-urls":[]} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902151+0300","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"127.0.0.1:2380"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902171+0300","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"127.0.0.1:2380"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.902163+0300","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.902201+0300","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f","remote-peer-urls":["http://localhost:2384"]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.902241+0300","caller":"etcdserver/server.go:854","msg":"starting etcd server","local-member-id":"7e3bd17c66e004e8","local-server-version":"3.5.8","cluster-version":"to_be_decided"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.902522+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.902779+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.902793+0300","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.902812+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.902967+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.903065+0300","caller":"etcdserver/server.go:754","msg":"starting initial election tick advance","election-ticks":10} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.903183+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test2/member/snap","suffix":"snap.db","max":5,"interval":"30s"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.903207+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test2/member/snap","suffix":"snap","max":5,"interval":"30s"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.903219+0300","caller":"fileutil/purge.go:44","msg":"started to purge file","dir":"/tmp/W2ZHhX/test2/member/wal","suffix":"wal","max":5,"interval":"30s"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.90268+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.902726+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.90305+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.903187+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.903205+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"fa252746f913ab7f","added-peer-id":"7e3bd17c66e004e8","added-peer-peer-urls":["http://localhost:2382"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.903282+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.903343+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"fa252746f913ab7f","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.903401+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.90344+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"fa252746f913ab7f","added-peer-id":"fa252746f913ab7f","added-peer-peer-urls":["http://localhost:2384"]} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902517+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"8e9e05c52164694d","to":"fa252746f913ab7f","stream-type":"stream Message"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902539+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902563+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902719+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"8e9e05c52164694d","to":"7e3bd17c66e004e8","stream-type":"stream Message"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902737+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902751+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902796+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"8e9e05c52164694d","to":"7e3bd17c66e004e8","stream-type":"stream MsgApp v2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.90282+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902944+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"8e9e05c52164694d","to":"fa252746f913ab7f","stream-type":"stream MsgApp v2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.902963+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.903738+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.90385+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"7e3bd17c66e004e8","added-peer-id":"7e3bd17c66e004e8","added-peer-peer-urls":["http://localhost:2382"]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.903913+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.903978+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"7e3bd17c66e004e8","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.904035+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 switched to configuration voters=(9096094204636955880 10276657743932975437 18024856269400288127)"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.904075+0300","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de368b0e4577b2d6","local-member-id":"7e3bd17c66e004e8","added-peer-id":"fa252746f913ab7f","added-peer-peer-urls":["http://localhost:2384"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.904585+0300","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt, key = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key, client-cert=, client-key=, trusted-ca = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt, client-cert-auth = false, crl-file = ","cipher-suites":[]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.904642+0300","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"127.0.0.1:2384"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.904645+0300","caller":"embed/etcd.go:278","msg":"now serving peer/client/metrics","local-member-id":"fa252746f913ab7f","initial-advertise-peer-urls":["http://localhost:2384"],"listen-peer-urls":["http://localhost:2384"],"advertise-client-urls":["https://localhost:2383"],"listen-client-urls":["https://localhost:2383"],"listen-metrics-urls":[]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.904657+0300","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"127.0.0.1:2384"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.904882+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"fa252746f913ab7f","to":"8e9e05c52164694d","stream-type":"stream Message"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.904904+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.904983+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"fa252746f913ab7f","to":"7e3bd17c66e004e8","stream-type":"stream MsgApp v2"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.905001+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.905012+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"fa252746f913ab7f","to":"7e3bd17c66e004e8","stream-type":"stream Message"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.905015+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.905031+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.905064+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"fa252746f913ab7f","to":"8e9e05c52164694d","stream-type":"stream MsgApp v2"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.905082+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.905357+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.905387+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.904993+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.905035+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.905403+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.90541+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.904848+0300","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.crt, key = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/localhost.key, client-cert=, client-key=, trusted-ca = /home/sergeyb/sources/MRG/tarantool-ee/src/lua/etcd-client/test/data/ca.crt, client-cert-auth = false, crl-file = ","cipher-suites":[]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.904928+0300","caller":"embed/etcd.go:278","msg":"now serving peer/client/metrics","local-member-id":"7e3bd17c66e004e8","initial-advertise-peer-urls":["http://localhost:2382"],"listen-peer-urls":["http://localhost:2382"],"advertise-client-urls":["https://localhost:2381"],"listen-client-urls":["https://localhost:2381"],"listen-metrics-urls":[]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.904938+0300","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"127.0.0.1:2382"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.904975+0300","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"127.0.0.1:2382"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905021+0300","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.90504+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905071+0300","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905306+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"7e3bd17c66e004e8","to":"fa252746f913ab7f","stream-type":"stream Message"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905654+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"7e3bd17c66e004e8","to":"fa252746f913ab7f","stream-type":"stream MsgApp v2"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905332+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"7e3bd17c66e004e8","to":"8e9e05c52164694d","stream-type":"stream Message"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905695+0300","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"7e3bd17c66e004e8","to":"8e9e05c52164694d","stream-type":"stream MsgApp v2"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905731+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905333+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905679+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.905692+0300","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:00.949702+0300","caller":"etcdserver/server.go:777","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:00.952117+0300","caller":"etcdserver/server.go:777","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"fa252746f913ab7f","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:00.953248+0300","caller":"etcdserver/server.go:777","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"7e3bd17c66e004e8","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.386724+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.38678+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.386832+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.386858+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [logterm: 1, index: 3] sent MsgPreVote request to 7e3bd17c66e004e8 at term 1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.386874+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [logterm: 1, index: 3] sent MsgPreVote request to fa252746f913ab7f at term 1"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.387185+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 8e9e05c52164694d [logterm: 1, index: 3] at term 1"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.387235+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 8e9e05c52164694d [logterm: 1, index: 3] at term 1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.38743+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 7e3bd17c66e004e8 at term 1"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.38748+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d has received 2 MsgPreVoteResp votes and 0 vote rejections"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.387509+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.387528+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.38756+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [logterm: 1, index: 3] sent MsgVote request to 7e3bd17c66e004e8 at term 2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.387582+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [logterm: 1, index: 3] sent MsgVote request to fa252746f913ab7f at term 2"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.398258+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 [term: 1] received a MsgVote message with higher term from 8e9e05c52164694d [term: 2]"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.398292+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 became follower at term 2"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.398311+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 [logterm: 1, index: 3, vote: 0] cast MsgVote for 8e9e05c52164694d [logterm: 1, index: 3] at term 2"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.398358+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [term: 1] received a MsgVote message with higher term from 8e9e05c52164694d [term: 2]"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.398396+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became follower at term 2"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.398411+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [logterm: 1, index: 3, vote: 0] cast MsgVote for 8e9e05c52164694d [logterm: 1, index: 3] at term 2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.398837+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 7e3bd17c66e004e8 at term 2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.398883+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d has received 2 MsgVoteResp votes and 0 vote rejections"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.398903+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.398928+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.399201+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fa252746f913ab7f elected leader 8e9e05c52164694d at term 2"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.399201+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e3bd17c66e004e8 elected leader 8e9e05c52164694d at term 2"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.401072+0300","caller":"embed/serve.go:103","msg":"ready to serve client requests"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.401077+0300","caller":"etcdserver/server.go:2062","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:test1 ClientURLs:[https://localhost:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"de368b0e4577b2d6","publish-timeout":"7s"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.401624+0300","caller":"embed/serve.go:103","msg":"ready to serve client requests"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.401622+0300","caller":"etcdserver/server.go:2062","msg":"published local member to cluster through raft","local-member-id":"7e3bd17c66e004e8","local-member-attributes":"{Name:test2 ClientURLs:[https://localhost:2381]}","request-path":"/0/members/7e3bd17c66e004e8/attributes","cluster-id":"de368b0e4577b2d6","publish-timeout":"7s"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.401794+0300","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.401815+0300","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.401334+0300","caller":"embed/serve.go:103","msg":"ready to serve client requests"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.40135+0300","caller":"etcdserver/server.go:2062","msg":"published local member to cluster through raft","local-member-id":"fa252746f913ab7f","local-member-attributes":"{Name:test3 ClientURLs:[https://localhost:2383]}","request-path":"/0/members/fa252746f913ab7f/attributes","cluster-id":"de368b0e4577b2d6","publish-timeout":"7s"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.401571+0300","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.401587+0300","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} +> etcd #1 | {"level":"info","ts":2024-01-18 12:20:01.411 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 startup +> 2024-01-18 12:20:01.418 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 startup +> 2024-01-18 12:20:01.425 [74243] main/103/luatest/etcd-client.client.pool V> etcd transport | stream: /watch +270c270 +< * STATE: INIT => CONNECT handle 0x55fcad874898; line 1942 +--- +> * STATE: INIT => CONNECT handle 0x556c462c0ca8; line 1942 +272c272 +< * STATE: CONNECT => CONNECTING handle 0x55fcad874898; line 1995 +--- +> * STATE: CONNECT => CONNECTING handle 0x556c462c0ca8; line 1995 +288c288 +< * STATE: CONNECTING => PROTOCONNECT handle 0x55fcad874898; line 2103 +--- +> * STATE: CONNECTING => PROTOCONNECT handle 0x556c462c0ca8; line 2103 +290c290 +< * STATE: PROTOCONNECT => DO handle 0x55fcad874898; line 2135 +--- +> * STATE: PROTOCONNECT => DO handle 0x556c462c0ca8; line 2135 +303,304c303,304 +< * STATE: DO => DID handle 0x55fcad874898; line 2231 +< * STATE: DID => PERFORMING handle 0x55fcad874898; line 2349 +--- +> * STATE: DO => DID handle 0x556c462c0ca8; line 2231 +> * STATE: DID => PERFORMING handle 0x556c462c0ca8; line 2349 +315c315 +< < date: Thu, 18 Jan 2024 09:05:49 GMT +--- +> < date: Thu, 18 Jan 2024 09:20:01 GMT +317c317 +< * STATE: PERFORMING => DONE handle 0x55fcad874898; line 2548 +--- +> * STATE: PERFORMING => DONE handle 0x556c462c0ca8; line 2548 +321,322c321,322 +< * STATE: INIT => CONNECT handle 0x55fcad874898; line 1942 +< * Found bundle for host: 0x55fcad865b98 [can multiplex] +--- +> * STATE: INIT => CONNECT handle 0x556c462c0ca8; line 1942 +> * Found bundle for host: 0x556c46290998 [can multiplex] +324,326c324,326 +< * STATE: CONNECT => CONNECTING handle 0x55fcad874898; line 1995 +< * STATE: CONNECTING => PROTOCONNECT handle 0x55fcad874898; line 2103 +< * STATE: PROTOCONNECT => DO handle 0x55fcad874898; line 2122 +--- +> * STATE: CONNECT => CONNECTING handle 0x556c462c0ca8; line 1995 +> * STATE: CONNECTING => PROTOCONNECT handle 0x556c462c0ca8; line 2103 +> * STATE: PROTOCONNECT => DO handle 0x556c462c0ca8; line 2122 +339,341c339,341 +< * STATE: DO => DID handle 0x55fcad874898; line 2231 +< * STATE: DID => PERFORMING handle 0x55fcad874898; line 2349 +< 2024-01-18 12:05:49.060 [66324] main/103/luatest/etcd-client.client.pool V> etcd transport | stream: /watch ok +--- +> * STATE: DO => DID handle 0x556c462c0ca8; line 2231 +> * STATE: DID => PERFORMING handle 0x556c462c0ca8; line 2349 +> 2024-01-18 12:20:01.432 [74243] main/103/luatest/etcd-client.client.pool V> etcd transport | stream: /watch ok +343a344 +> * pause: no change, early return +357c358 +< < date: Thu, 18 Jan 2024 09:05:49 GMT +--- +> < date: Thu, 18 Jan 2024 09:20:01 GMT +361,372c362,367 +< 2024-01-18 12:05:49.062 [66324] main/103/luatest/etcd-client.client.pool V> etcd transport | req: /kv/put {"key":"Zm9v","value":"YmFy"} +< * readwrite, dselect_bits, early return on PAUSED +< * readwrite, dselect_bits, early return on PAUSED +< * readwrite, dselect_bits, early return on PAUSED +< +< +< +< * readwrite, dselect_bits, early return on PAUSED +< * readwrite, dselect_bits, early return on PAUSED +< * readwrite, dselect_bits, early return on PAUSED +< * STATE: INIT => CONNECT handle 0x55fcad8fed38; line 1942 +< * Found bundle for host: 0x55fcad865b98 [can multiplex] +--- +> * pause: no change, early return +> * Set HTTP/2 window size to 10485760 for stream 3 +> * HTTP/2 window size is now 10485463 for stream 3 +> 2024-01-18 12:20:01.434 [74243] main/103/luatest/etcd-client.client.pool V> etcd transport | req: /kv/put {"key":"Zm9v","value":"YmFy"} +> * STATE: INIT => CONNECT handle 0x556c462d5368; line 1942 +> * Found bundle for host: 0x556c46290998 [can multiplex] +375,376c370,371 +< * STATE: CONNECT => PROTOCONNECT handle 0x55fcad8fed38; line 1993 +< * STATE: PROTOCONNECT => DO handle 0x55fcad8fed38; line 2122 +--- +> * STATE: CONNECT => PROTOCONNECT handle 0x556c462d5368; line 1993 +> * STATE: PROTOCONNECT => DO handle 0x556c462d5368; line 2122 +393,396c388,391 +< * STATE: DO => DID handle 0x55fcad8fed38; line 2231 +< * STATE: DID => PERFORMING handle 0x55fcad8fed38; line 2349 +< * readwrite, dselect_bits, early return on PAUSED +< * readwrite, dselect_bits, early return on PAUSED +--- +> * STATE: DO => DID handle 0x556c462d5368; line 2231 +> * STATE: DID => PERFORMING handle 0x556c462d5368; line 2349 +> * Set HTTP/2 window size to 10485760 for stream 3 +> * HTTP/2 window size is now 10485234 for stream 3 +411c406 +< < date: Thu, 18 Jan 2024 09:05:49 GMT +--- +> < date: Thu, 18 Jan 2024 09:20:01 GMT +413c408 +< * STATE: PERFORMING => DONE handle 0x55fcad8fed38; line 2548 +--- +> * STATE: PERFORMING => DONE handle 0x556c462d5368; line 2548 +417,442c412,444 +< 2024-01-18 12:05:49.063 [66324] main/103/luatest/etcd-client.client.pool V> etcd transport | response: /kv/put {"header":{"raft_term":"2","revision":"2","member_id":"10276657743932975437","cluster_id":"16012138418573652694"}} +< 2024-01-18 12:05:54.066 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< * readwrite, dselect_bits, early return on PAUSED +< 2024-01-18 12:05:54.163 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:54.263 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:54.363 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:54.463 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:54.563 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:54.663 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:54.763 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:54.863 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:54.963 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.063 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< d":"fa252746f913ab7f","cluster-version":"3.5"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.032603+0300","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:49.032615+0300","caller":"etcdserver/server.go:2595","msg":"cluster version is updated","cluster-version":"3.5"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.0326+0300","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de368b0e4577b2d6","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.032651+0300","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.03266+0300","caller":"embed/serve.go:103","msg":"ready to serve client requests"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.032663+0300","caller":"etcdserver/server.go:2062","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:test1 ClientURLs:[https://localhost:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"de368b0e4577b2d6","publish-timeout":"7s"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.032664+0300","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de368b0e4577b2d6","local-member-id":"7e3bd17c66e004e8","cluster-version":"3.5"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.032716+0300","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.032716+0300","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.03272+0300","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:49.032803+0300","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2381"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:49.033327+0300","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} +--- +> * Set HTTP/2 window size to 10485760 for stream 3 +> * HTTP/2 window size is now 10484990 for stream 3 +> 2024-01-18 12:20:01.437 [74243] main/103/luatest/etcd-client.client.pool V> etcd transport | response: /kv/put {"header":{"raft_term":"2","revision":"2","member_id":"10276657743932975437","cluster_id":"16012138418573652694"}} +> * pause: no change, early return +> * pause: no change, early return +> * multi_done[PERFORMING]: status: 0 prem: 1 done: 0 +> * Connection #0 to host localhost left intact +> * Expire cleared +> 2024-01-18 12:20:01.438 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:01.438 [74243] main/114/etcd-client read stream/etcd-client.subscribe.once V> etcd subscriber | stream read error: closed +> 2024-01-18 12:20:01.537 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:01.638 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:01.739 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:01.840 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:01.941 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:02.042 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:02.143 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:02.244 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:02.345 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:02.446 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> "2024-01-18T12:20:01.401336+0300","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.40138+0300","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.402012+0300","caller":"etcdserver/server.go:2571","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.403091+0300","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de368b0e4577b2d6","local-member-id":"fa252746f913ab7f","cluster-version":"3.5"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.403268+0300","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.402916+0300","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de368b0e4577b2d6","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.403064+0300","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.403101+0300","caller":"etcdserver/server.go:2595","msg":"cluster version is updated","cluster-version":"3.5"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.403569+0300","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.403043+0300","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de368b0e4577b2d6","local-member-id":"7e3bd17c66e004e8","cluster-version":"3.5"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.403191+0300","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:01.403712+0300","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2383"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:01.403922+0300","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2381"} +444,610c446,611 +< integration.general.tls:true.test_watchwait ... (5.013s) fail +< ...ee/src/lua/etcd-client/test/integration/general_test.lua:1193: expected: a value evaluating to true, actual: nil +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:54.065548+0300","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:54.065602+0300","caller":"embed/etcd.go:376","msg":"closing etcd server","name":"test1","data-dir":"/tmp/uqKJxk/test1","advertise-peer-urls":["http://localhost:2380"],"advertise-client-urls":["https://localhost:2379"]} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:54.065722+0300","caller":"embed/serve.go:212","msg":"stopping secure grpc server due to error","error":"accept tcp 127.0.0.1:2379: use of closed network connection"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:54.065757+0300","caller":"embed/serve.go:214","msg":"stopped secure grpc server due to error","error":"accept tcp 127.0.0.1:2379: use of closed network connection"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.148798+0300","caller":"etcdserver/server.go:1456","msg":"skipped leadership transfer; local server is not leader","local-member-id":"8e9e05c52164694d","current-leader-member-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.148898+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"7e3bd17c66e004e8"} +< "ts":"2024-01-18T12:05:55.148995+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149006+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149066+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149074+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149089+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149127+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8","error":"context canceled"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149144+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"7e3bd17c66e004e8","error":"failed to read 7e3bd17c66e004e8 on stream MsgApp v2 (context canceled)"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149162+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149197+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8","error":"context canceled"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149207+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149215+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149221+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149317+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149334+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.14943+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.14945+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"fa252746f913ab7f"} +< g with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149495+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f","error":"context canceled"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149508+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"fa252746f913ab7f","error":"failed to read fa252746f913ab7f on stream MsgApp v2 (context canceled)"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.14952+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149548+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f","error":"context canceled"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149557+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.149567+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"fa252746f913ab7f"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.14967+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"8e9e05c52164694d","remote-peer-id-stream-handler":"8e9e05c52164694d","remote-peer-id-from":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.149688+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"8e9e05c52164694d","remote-peer-id-stream-handler":"8e9e05c52164694d","remote-peer-id-from":"7e3bd17c66e004e8","cluster-id":"de368b0e4577b2d6"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.14967+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"8e9e05c52164694d","remote-peer-id-stream-handler":"8e9e05c52164694d","remote-peer-id-from":"7e3bd17c66e004e8","cluster-id":"de368b0e4577b2d6"} +< etcd #1 | {"level":"warn","ts":"2024-01-18T12:05:55.1497+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"8e9e05c52164694d","remote-peer-id-stream-handler":"8e9e05c52164694d","remote-peer-id-from":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:55.149112+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d","error":"EOF"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:55.149174+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d","error":"EOF"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:55.149774+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"8e9e05c52164694d","error":"failed to dial 8e9e05c52164694d on stream MsgApp v2 (peer 8e9e05c52164694d failed to find local node 7e3bd17c66e004e8)"} +< 2024-01-18 12:05:55.163 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.263 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.363 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.463 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.563 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.663 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.763 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.863 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:55.963 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:56.063 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:56.163 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +< 2024-01-18 12:05:56.164 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:56.263 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:56.363 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:56.463 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:56.563 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:56.663 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:56.763 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:56.863 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:56.963 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.063 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.163 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< m MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d","error":"EOF"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:55.149514+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d","error":"EOF"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:55.149766+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"8e9e05c52164694d","error":"failed to dial 8e9e05c52164694d on stream MsgApp v2 (peer 8e9e05c52164694d failed to find local node fa252746f913ab7f)"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:55.150656+0300","caller":"embed/etcd.go:579","msg":"stopping serving peer traffic","address":"127.0.0.1:2380"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:55.424239+0300","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:56.151012+0300","caller":"embed/etcd.go:584","msg":"stopped serving peer traffic","address":"127.0.0.1:2380"} +< etcd #1 | {"level":"info","ts":"2024-01-18T12:05:56.151038+0300","caller":"embed/etcd.go:378","msg":"closed etcd server","name":"test1","data-dir":"/tmp/uqKJxk/test1","advertise-peer-urls":["http://localhost:2380"],"advertise-client-urls":["https://localhost:2379"]} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:56.16397+0300","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:56.163995+0300","caller":"embed/etcd.go:376","msg":"closing etcd server","name":"test2","data-dir":"/tmp/uqKJxk/test2","advertise-peer-urls":["http://localhost:2382"],"advertise-client-urls":["https://localhost:2381"]} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:56.16405+0300","caller":"embed/serve.go:212","msg":"stopping secure grpc server due to error","error":"accept tcp 127.0.0.1:2381: use of closed network connection"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:56.16406+0300","caller":"embed/serve.go:214","msg":"stopped secure grpc server due to error","error":"accept tcp 127.0.0.1:2381: use of closed network connection"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:57.032958+0300","caller":"etcdserver/cluster_util.go:288","msg":"failed to reach the peer URL","address":"http://localhost:2380/version","remote-member-id":"8e9e05c52164694d","error":"Get \"http://localhost:2380/version\": dial tcp 127.0.0.1:2380: connect: connection refused"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:57.032995+0300","caller":"etcdserver/cluster_util.go:155","msg":"failed to get version","remote-member-id":"8e9e05c52164694d","error":"Get \"http://localhost:2380/version\": dial tcp 127.0.0.1:2380: connect: connection refused"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.228872+0300","caller":"etcdserver/server.go:1456","msg":"skipped leadership transfer; local server is not leader","local-member-id":"7e3bd17c66e004e8","current-leader-member-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.228946+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229061+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"8e9e05c52164694d"} +< 2164694d"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229192+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229203+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229222+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229234+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229245+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229254+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"8e9e05c52164694d"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229258+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229363+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229371+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229432+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229439+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229461+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229499+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f","error":"context canceled"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229514+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"fa252746f913ab7f","error":"failed to read fa252746f913ab7f on stream MsgApp v2 (context canceled)"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229532+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229562+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f","error":"context canceled"} +< 2024-01-18 12:05:57.263 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.363 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.463 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.563 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.663 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.763 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.863 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:57.963 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:58.063 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:58.163 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:58.263 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +< 2024-01-18 12:05:58.264 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:58.363 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:58.463 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:58.563 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:58.663 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:58.763 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:58.863 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:58.963 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 00","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.229581+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"fa252746f913ab7f"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229657+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"7e3bd17c66e004e8","remote-peer-id-stream-handler":"7e3bd17c66e004e8","remote-peer-id-from":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +< etcd #2 | {"level":"warn","ts":"2024-01-18T12:05:57.229691+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"7e3bd17c66e004e8","remote-peer-id-stream-handler":"7e3bd17c66e004e8","remote-peer-id-from":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:57.229384+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8","error":"EOF"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:57.229484+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8","error":"EOF"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:57.229726+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"7e3bd17c66e004e8","error":"failed to dial 7e3bd17c66e004e8 on stream MsgApp v2 (peer 7e3bd17c66e004e8 failed to find local node fa252746f913ab7f)"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:57.230573+0300","caller":"embed/etcd.go:579","msg":"stopping serving peer traffic","address":"127.0.0.1:2382"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:57.624211+0300","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:58.231115+0300","caller":"embed/etcd.go:584","msg":"stopped serving peer traffic","address":"127.0.0.1:2382"} +< etcd #2 | {"level":"info","ts":"2024-01-18T12:05:58.231153+0300","caller":"embed/etcd.go:378","msg":"closed etcd server","name":"test2","data-dir":"/tmp/uqKJxk/test2","advertise-peer-urls":["http://localhost:2382"],"advertise-client-urls":["https://localhost:2381"]} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:58.264104+0300","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:58.264133+0300","caller":"embed/etcd.go:376","msg":"closing etcd server","name":"test3","data-dir":"/tmp/uqKJxk/test3","advertise-peer-urls":["http://localhost:2384"],"advertise-client-urls":["https://localhost:2383"]} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:58.264195+0300","caller":"embed/serve.go:212","msg":"stopping secure grpc server due to error","error":"accept tcp 127.0.0.1:2383: use of closed network connection"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:58.264207+0300","caller":"embed/serve.go:214","msg":"stopped secure grpc server due to error","error":"accept tcp 127.0.0.1:2383: use of closed network connection"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:59.024208+0300","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"fa252746f913ab7f stepped down to follower since quorum is not active"} +< 2024-01-18 12:05:59.063 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:59.163 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< 2024-01-18 12:05:59.263 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< fa252746f913ab7f became follower at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.024255+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fa252746f913ab7f lost leader fa252746f913ab7f at term 2"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.349802+0300","caller":"etcdserver/server.go:1456","msg":"skipped leadership transfer; local server is not leader","local-member-id":"fa252746f913ab7f","current-leader-member-id":"0"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.349895+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:59.349971+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.349981+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.349992+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350009+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350015+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350024+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350032+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"8e9e05c52164694d"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350036+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"warn","ts":"2024-01-18T12:05:59.350096+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350104+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350113+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350152+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350167+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.350178+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +< 2024-01-18 12:05:59.363 [66324] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +< info","ts":"2024-01-18T12:05:59.350184+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"7e3bd17c66e004e8"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.361204+0300","caller":"embed/etcd.go:579","msg":"stopping serving peer traffic","address":"127.0.0.1:2384"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.361276+0300","caller":"embed/etcd.go:584","msg":"stopped serving peer traffic","address":"127.0.0.1:2384"} +< etcd #3 | {"level":"info","ts":"2024-01-18T12:05:59.361285+0300","caller":"embed/etcd.go:378","msg":"closed etcd server","name":"test3","data-dir":"/tmp/uqKJxk/test3","advertise-peer-urls":["http://localhost:2384"],"advertise-client-urls":["https://localhost:2383"]} +< ========================================================= +<  +< Failed tests: +< ------------- +<  +< 1) integration.general.tls:true.test_watchwait +< ...ee/src/lua/etcd-client/test/integration/general_test.lua:1193: expected: a value evaluating to true, actual: nil +< stack traceback: +< ...ee/src/lua/etcd-client/test/integration/general_test.lua:1193: in function 'integration.general.tls:true.test_watchwait' +< ... +< [C]: in function 'xpcall' +< Ran 1 tests in 10.866 seconds, 0 succeeded, 1 failed +< +--- +> integration.general.tls:true.test_watchwait ... (0.012s) Ok +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.437575+0300","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:01.437598+0300","caller":"embed/etcd.go:376","msg":"closing etcd server","name":"test1","data-dir":"/tmp/W2ZHhX/test1","advertise-peer-urls":["http://localhost:2380"],"advertise-client-urls":["https://localhost:2379"]} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:01.437638+0300","caller":"embed/serve.go:212","msg":"stopping secure grpc server due to error","error":"accept tcp 127.0.0.1:2379: use of closed network connection"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:01.437646+0300","caller":"embed/serve.go:214","msg":"stopped secure grpc server due to error","error":"accept tcp 127.0.0.1:2379: use of closed network connection"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.500565+0300","caller":"etcdserver/server.go:1425","msg":"leadership transfer starting","local-member-id":"8e9e05c52164694d","current-leader-member-id":"8e9e05c52164694d","transferee-member-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.500619+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [term 2] starts to transfer leadership to fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.500636+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d sends MsgTimeoutNow to fa252746f913ab7f immediately as fa252746f913ab7f already has up-to-date log"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.500759+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [term 2] received MsgTimeoutNow from 8e9e05c52164694d and starts an election to get leadership."} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.500785+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f is starting a new election at term 2"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.500799+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became candidate at term 3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.500816+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f received MsgVoteResp from fa252746f913ab7f at term 3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.500836+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [logterm: 2, index: 9] sent MsgVote request to 7e3bd17c66e004e8 at term 3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.500848+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f [logterm: 2, index: 9] sent MsgVote request to 8e9e05c52164694d at term 3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.50086+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fa252746f913ab7f lost leader 8e9e05c52164694d at term 3"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:02.511707+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 [term: 2] received a MsgVote message with higher term from fa252746f913ab7f [term: 3]"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:02.511755+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 became follower at term 3"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:02.511775+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e3bd17c66e004e8 [logterm: 2, index: 9, vote: 0] cast MsgVote for fa252746f913ab7f [logterm: 2, index: 9] at term 3"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:02.511791+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e3bd17c66e004e8 lost leader 8e9e05c52164694d at term 3"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.51177+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [term: 2] received a MsgVote message with higher term from fa252746f913ab7f [term: 3]"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.511818+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 3"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.511834+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d [logterm: 2, index: 9, vote: 0] cast MsgVote for fa252746f913ab7f [logterm: 2, index: 9] at term 3"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.511847+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d lost leader 8e9e05c52164694d at term 3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.512373+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f received MsgVoteResp from 7e3bd17c66e004e8 at term 3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.512412+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f has received 2 MsgVoteResp votes and 0 vote rejections"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:02.512435+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became leader at term 3"} +> etcd #3 | {"level":"info","ts":"22024-01-18 12:20:02.547 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 024-01-18T12:20:02.512464+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fa252746f913ab7f elected leader fa252746f913ab7f at term 3"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.512609+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader fa252746f913ab7f at term 3"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:02.512589+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e3bd17c66e004e8 elected leader fa252746f913ab7f at term 3"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.601065+0300","caller":"etcdserver/server.go:1442","msg":"leadership transfer finished","local-member-id":"8e9e05c52164694d","old-leader-member-id":"8e9e05c52164694d","new-leader-member-id":"fa252746f913ab7f","took":"100.497957ms"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.601183+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.601501+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.601538+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.601725+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.601762+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.601817+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.60192+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8","error":"context canceled"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.601962+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"7e3bd17c66e004e8","error":"failed to read 7e3bd17c66e004e8 on stream MsgApp v2 (context canceled)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602007+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.602097+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8","error":"context canceled"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602128+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602154+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602164+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.602332+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602357+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.602601+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602635+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602694+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.602808+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f","error":"context canceled"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.602853+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"fa252746f913ab7f","error":"failed to read fa252746f913ab7f on stream MsgApp v2 (context canceled)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602888+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.602967+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f","error":"context canceled"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.602997+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"8e9e05c52164694d","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.603027+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"fa252746f913ab7f"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.603071+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"8e9e05c52164694d","remote-peer-id-stream-handler":"8e9e05c52164694d","remote-peer-id-from":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.603074+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"8e9e05c52164694d","remote-peer-id-stream-handler":"8e9e05c52164694d","remote-peer-id-from":"7e3bd17c66e004e8","cluster-id":"de368b0e4577b2d6"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.603076+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"8e9e05c52164694d","remote-peer-id-stream-handler":"8e9e05c52164694d","remote-peer-id-from":"7e3bd17c66e004e8","cluster-id":"de368b0e4577b2d6"} +> etcd #1 | {"level":"warn","ts":"2024-01-18T12:20:02.603141+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"8e9e05c52164694d","remote-peer-id-stream-handler":"8e9e05c52164694d","remote-peer-id-from":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +> etcd #2024-01-18 12:20:02.647 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#1 teardown +> 2024-01-18 12:20:02.649 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:02.748 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:02.849 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:02.950 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.051 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.152 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.253 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.354 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.455 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.555 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.656 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2 | {"level":"warn","ts":"2024-01-18T12:20:02.601568+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d","error":"EOF"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:02.601717+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d","error":"EOF"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:02.603378+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"8e9e05c52164694d","error":"failed to dial 8e9e05c52164694d on stream Message (peer 8e9e05c52164694d failed to find local node 7e3bd17c66e004e8)"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:02.602347+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d","error":"EOF"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:02.60255+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d","error":"EOF"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:02.603363+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"8e9e05c52164694d","error":"failed to dial 8e9e05c52164694d on stream MsgApp v2 (peer 8e9e05c52164694d failed to find local node fa252746f913ab7f)"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.604181+0300","caller":"embed/etcd.go:579","msg":"stopping serving peer traffic","address":"127.0.0.1:2380"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.604227+0300","caller":"embed/etcd.go:584","msg":"stopped serving peer traffic","address":"127.0.0.1:2380"} +> etcd #1 | {"level":"info","ts":"2024-01-18T12:20:02.604233+0300","caller":"embed/etcd.go:378","msg":"closed etcd server","name":"test1","data-dir":"/tmp/W2ZHhX/test1","advertise-peer-urls":["http://localhost:2380"],"advertise-client-urls":["https://localhost:2379"]} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:02.648925+0300","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:02.648984+0300","caller":"embed/etcd.go:376","msg":"closing etcd server","name":"test2","data-dir":"/tmp/W2ZHhX/test2","advertise-peer-urls":["http://localhost:2382"],"advertise-client-urls":["https://localhost:2381"]} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:02.649103+0300","caller":"embed/serve.go:212","msg":"stopping secure grpc server due to error","error":"accept tcp 127.0.0.1:2381: use of closed network connection"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:02.649134+0300","caller":"embed/serve.go:214","msg":"stopped secure grpc server due to error","error":"accept tcp 127.0.0.1:2381: use of closed network connection"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:02.986697+0300","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.700349+0300","caller":"etcdserver/server.go:1456","msg":"skipped leadership transfer; local server is not leader","local-member-id":"7e3bd17c66e004e8","current-leader-member-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.700515+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.700729+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.700759+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.700932+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.70096+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.701006+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.701066+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.701096+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.701117+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"8e9e05c52164694d"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.701128+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.701516+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.701561+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.701909+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.701955+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.701992+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.70207+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f","error":"context canceled"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.702109+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"fa252746f913ab7f","error":"failed to read fa252746f913ab7f on stream MsgApp v2 (context canceled)"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.702146+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stre2024-01-18 12:20:03.757 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.858 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:03.959 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.060 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.161 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.262 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.363 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.464 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.565 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.665 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.766 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#2 teardown +> 2024-01-18 12:20:04.768 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> am MsgApp v2","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.702232+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f","error":"context canceled"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.702254+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"7e3bd17c66e004e8","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.702275+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"fa252746f913ab7f"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.702328+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"7e3bd17c66e004e8","remote-peer-id-stream-handler":"7e3bd17c66e004e8","remote-peer-id-from":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +> etcd #2 | {"level":"warn","ts":"2024-01-18T12:20:03.702425+0300","caller":"rafthttp/http.go:413","msg":"failed to find remote peer in cluster","local-member-id":"7e3bd17c66e004e8","remote-peer-id-stream-handler":"7e3bd17c66e004e8","remote-peer-id-from":"fa252746f913ab7f","cluster-id":"de368b0e4577b2d6"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:03.701397+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8","error":"EOF"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:03.701814+0300","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8","error":"EOF"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:03.702554+0300","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"7e3bd17c66e004e8","error":"failed to dial 7e3bd17c66e004e8 on stream MsgApp v2 (peer 7e3bd17c66e004e8 failed to find local node fa252746f913ab7f)"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:03.713498+0300","caller":"embed/etcd.go:579","msg":"stopping serving peer traffic","address":"127.0.0.1:2382"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:04.087657+0300","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:04.713637+0300","caller":"embed/etcd.go:584","msg":"stopped serving peer traffic","address":"127.0.0.1:2382"} +> etcd #2 | {"level":"info","ts":"2024-01-18T12:20:04.713703+0300","caller":"embed/etcd.go:378","msg":"closed etcd server","name":"test2","data-dir":"/tmp/W2ZHhX/test2","advertise-peer-urls":["http://localhost:2382"],"advertise-client-urls":["https://localhost:2381"]} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:04.767635+0300","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:04.767689+0300","caller":"embed/etcd.go:376","msg":"closing etcd server","name":"test3","data-dir":"/tmp/W2ZHhX/test3","advertise-peer-urls":["http://localhost:2384"],"advertise-client-urls":["https://localhost:2383"]} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:04.767802+0300","caller":"embed/serve.go:212","msg":"stopping secure grpc server due to error","error":"accept tcp 127.0.0.1:2383: use of closed network connection"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:04.767832+0300","caller":"embed/serve.go:2142024-01-18 12:20:04.867 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:04.969 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:05.069 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:05.170 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:05.271 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:05.372 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:05.473 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:05.574 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:05.675 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> 2024-01-18 12:20:05.775 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> ","msg":"stopped secure grpc server due to error","error":"accept tcp 127.0.0.1:2383: use of closed network connection"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:05.48634+0300","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"fa252746f913ab7f stepped down to follower since quorum is not active"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.486398+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fa252746f913ab7f became follower at term 3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.486419+0300","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fa252746f913ab7f lost leader fa252746f913ab7f at term 3"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847456+0300","caller":"etcdserver/server.go:1456","msg":"skipped leadership transfer; local server is not leader","local-member-id":"fa252746f913ab7f","current-leader-member-id":"0"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847567+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:05.847789+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847824+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847855+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847891+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847907+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847932+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847955+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"8e9e05c52164694d"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.847964+0300","caller":"rafthttp/peer.go:330","msg":"stopping remote peer","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"warn","ts":"2024-01-18T12:20:05.848119+0300","caller":"rafthttp/stream.go:286","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.848143+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.848177+0300","caller":"rafthttp/stream.go:294","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.848212+0300","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.848224+0300","caller":"rafthttp/stream.go:4422024-01-18 12:20:05.875 [74243] main/103/luatest/test.utils V> etcd_test | waiting for etcd#3 teardown +> ","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.848247+0300","caller":"rafthttp/stream.go:442","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"fa252746f913ab7f","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.848269+0300","caller":"rafthttp/peer.go:335","msg":"stopped remote peer","remote-peer-id":"7e3bd17c66e004e8"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.859507+0300","caller":"embed/etcd.go:579","msg":"stopping serving peer traffic","address":"127.0.0.1:2384"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.859612+0300","caller":"embed/etcd.go:584","msg":"stopped serving peer traffic","address":"127.0.0.1:2384"} +> etcd #3 | {"level":"info","ts":"2024-01-18T12:20:05.859777+0300","caller":"embed/etcd.go:378","msg":"closed etcd server","name":"test3","data-dir":"/tmp/W2ZHhX/test3","advertise-peer-urls":["http://localhost:2384"],"advertise-client-urls":["https://localhost:2383"]} +612,615c613 +< Failed tests: +<  +< integration.general.tls:true.test_watchwait +<  +--- +> Ran 1 tests in 7.025 seconds, 1 succeeded, 0 failed