Apr 20 18:32:28.767801 np0000168547 systemd[1]: Starting devstack@etcd.service - Devstack devstack@etcd.service...
Apr 20 18:32:28.789995 np0000168547 etcd[66187]: {"level":"warn","ts":"2026-04-20T18:32:28.789861Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
Apr 20 18:32:28.790596 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.789990Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/opt/stack/bin/etcd","--name","np0000168547","--data-dir","/opt/stack/data/etcd","--initial-cluster-state","new","--initial-cluster-token","etcd-cluster-01","--initial-cluster","np0000168547=http://199.204.45.169:2380","--initial-advertise-peer-urls","http://199.204.45.169:2380","--advertise-client-urls","http://199.204.45.169:2379","--listen-peer-urls","http://0.0.0.0:2380","--listen-client-urls","http://199.204.45.169:2379","--log-level=debug"]}
Apr 20 18:32:28.790596 np0000168547 etcd[66187]: {"level":"warn","ts":"2026-04-20T18:32:28.790131Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
Apr 20 18:32:28.790596 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.790173Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://0.0.0.0:2380"]}
Apr 20 18:32:28.791390 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.791246Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://199.204.45.169:2379"]}
Apr 20 18:32:28.791676 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.791565Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.21","git-sha":"a17edfd","go-version":"go1.23.7","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"np0000168547","data-dir":"/opt/stack/data/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/opt/stack/data/etcd/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://199.204.45.169:2380"],"listen-peer-urls":["http://0.0.0.0:2380"],"advertise-client-urls":["http://199.204.45.169:2379"],"listen-client-urls":["http://199.204.45.169:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"np0000168547=http://199.204.45.169:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster-01","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"}
Apr 20 18:32:28.791856 np0000168547 etcd[66187]: {"level":"warn","ts":"2026-04-20T18:32:28.791711Z","caller":"fileutil/fileutil.go:53","msg":"check file permission","error":"directory \"/opt/stack/data/etcd\" exist, but the permission is \"dtrwxrwxrwx\". The recommended permission is \"-rwx------\" to prevent possible unprivileged access to the data"}
Apr 20 18:32:28.792328 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.792269Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/opt/stack/data/etcd/member/snap/db","took":"271.038µs"}
Apr 20 18:32:28.826625 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.826519Z","caller":"etcdserver/raft.go:506","msg":"starting local member","local-member-id":"881ede96a07647f7","cluster-id":"487b49188127a125"}
Apr 20 18:32:28.826746 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.826629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 switched to configuration voters=()"}
Apr 20 18:32:28.826746 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.826671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 became follower at term 0"}
Apr 20 18:32:28.826746 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.826682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 881ede96a07647f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
Apr 20 18:32:28.826746 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.826692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 became follower at term 1"}
Apr 20 18:32:28.826746 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.826725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 switched to configuration voters=(9808521776978085879)"}
Apr 20 18:32:28.827022 np0000168547 etcd[66187]: {"level":"warn","ts":"2026-04-20T18:32:28.826951Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
Apr 20 18:32:28.829965 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.829889Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1}
Apr 20 18:32:28.830057 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.829975Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0}
Apr 20 18:32:28.830200 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.830094Z","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"}
Apr 20 18:32:28.830387 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.830218Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"881ede96a07647f7","local-server-version":"3.5.21","cluster-version":"to_be_decided"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.830370Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/opt/stack/data/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.830483Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Server #1] Server created"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.830487Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/opt/stack/data/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.830581Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/opt/stack/data/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.830573Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.830638Z","caller":"etcdserver/server.go:759","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"881ede96a07647f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:28.830710Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":1}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:28.830882Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":1,"term":1,"type":"EntryConfChange"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.831171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 switched to configuration voters=(9808521776978085879)"}
Apr 20 18:32:28.831644 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.831471Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"487b49188127a125","local-member-id":"881ede96a07647f7","added-peer-id":"881ede96a07647f7","added-peer-peer-urls":["http://199.204.45.169:2380"],"added-peer-is-learner":false}
Apr 20 18:32:28.832794 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.832713Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"881ede96a07647f7","initial-advertise-peer-urls":["http://199.204.45.169:2380"],"listen-peer-urls":["http://0.0.0.0:2380"],"advertise-client-urls":["http://199.204.45.169:2379"],"listen-client-urls":["http://199.204.45.169:2379"],"listen-metrics-urls":[]}
Apr 20 18:32:28.832794 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.832699Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Server #1 ListenSocket #2] ListenSocket created"}
Apr 20 18:32:28.833006 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.832736Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"[::]:2380"}
Apr 20 18:32:28.833006 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:28.832947Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"[::]:2380"}
Apr 20 18:32:29.827630 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.827457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 is starting a new election at term 1"}
Apr 20 18:32:29.827630 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.827553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 became pre-candidate at term 1"}
Apr 20 18:32:29.827630 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.827602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 received MsgPreVoteResp from 881ede96a07647f7 at term 1"}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.827656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 became candidate at term 2"}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.827744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 received MsgVoteResp from 881ede96a07647f7 at term 2"}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.827765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"881ede96a07647f7 became leader at term 2"}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.827796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 881ede96a07647f7 elected leader 881ede96a07647f7 at term 2"}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.827979Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":2}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828002Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":2,"term":2,"type":"EntryNormal"}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828020Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":1,"entry-index":2,"should-applyV3":true}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828063Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":3,"term":2,"type":"EntryNormal"}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828075Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":2,"entry-index":3,"should-applyV3":true}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828096Z","caller":"etcdserver/server.go:2310","msg":"applyEntryNormal","V2request":"ID:5185786858710604290 Method:\"PUT\" Path:\"/0/members/881ede96a07647f7/attributes\" Val:\"{\\\"name\\\":\\\"np0000168547\\\",\\\"clientURLs\\\":[\\\"http://199.204.45.169:2379\\\"]}\" "}
Apr 20 18:32:29.828673 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.828613Z","caller":"etcdserver/server.go:2697","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828807Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":1}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.828800Z","caller":"etcdserver/server.go:2144","msg":"published local member to cluster through raft","local-member-id":"881ede96a07647f7","local-member-attributes":"{Name:np0000168547 ClientURLs:[http://199.204.45.169:2379]}","request-path":"/0/members/881ede96a07647f7/attributes","cluster-id":"487b49188127a125","publish-timeout":"7s"}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828826Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":4,"term":2,"type":"EntryNormal"}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828843Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":3,"entry-index":4,"should-applyV3":true}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:32:29.828875Z","caller":"etcdserver/server.go:2310","msg":"applyEntryNormal","V2request":"ID:5185786858710604292 Method:\"PUT\" Path:\"/0/version\" Val:\"3.5.0\" "}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.828931Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"487b49188127a125","local-member-id":"881ede96a07647f7","cluster-version":"3.5"}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.828997Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829025Z","caller":"etcdserver/server.go:2721","msg":"cluster version is updated","cluster-version":"3.5"}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829041Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829107Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] Channel created"}
Apr 20 18:32:29.829200 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829150Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] original dial target is: \"199.204.45.169:2379\""}
Apr 20 18:32:29.829903 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829232Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] dial target \"199.204.45.169:2379\" parse failed: parse \"199.204.45.169:2379\": first path segment in URL cannot contain colon"}
Apr 20 18:32:29.829903 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829272Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] fallback to scheme \"passthrough\""}
Apr 20 18:32:29.829903 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829204Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
Apr 20 18:32:29.829903 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829305Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] parsed dial target is: {URL:{Scheme:passthrough Opaque: User: Host: Path:/199.204.45.169:2379 RawPath: OmitHost:false ForceQuery:false RawQuery: Fragment: RawFragment:}}"}
Apr 20 18:32:29.829903 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829437Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] Channel authority set to \"199.204.45.169:2379\""}
Apr 20 18:32:29.829903 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829434Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
Apr 20 18:32:29.829903 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829667Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] Resolver state updated: {\n  \"Addresses\": [\n    {\n      \"Addr\": \"199.204.45.169:2379\",\n      \"ServerName\": \"\",\n      \"Attributes\": null,\n      \"BalancerAttributes\": null,\n      \"Metadata\": null\n    }\n  ],\n  \"Endpoints\": [\n    {\n      \"Addresses\": [\n        {\n          \"Addr\": \"199.204.45.169:2379\",\n          \"ServerName\": \"\",\n          \"Attributes\": null,\n          \"BalancerAttributes\": null,\n          \"Metadata\": null\n        }\n      ],\n      \"Attributes\": null\n    }\n  ],\n  \"ServiceConfig\": null,\n  \"Attributes\": null\n} (resolver returned new addresses)"}
Apr 20 18:32:29.829903 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829705Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] Channel switches to new LB policy \"pick_first\""}
Apr 20 18:32:29.829656 np0000168547 systemd[1]: Started devstack@etcd.service - Devstack devstack@etcd.service.
Apr 20 18:32:29.830752 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829780Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [pick-first-lb 0xc0005a67b0] Received new config {\n  \"shuffleAddressList\": false\n}, resolver state {\n  \"Addresses\": [\n    {\n      \"Addr\": \"199.204.45.169:2379\",\n      \"ServerName\": \"\",\n      \"Attributes\": null,\n      \"BalancerAttributes\": null,\n      \"Metadata\": null\n    }\n  ],\n  \"Endpoints\": [\n    {\n      \"Addresses\": [\n        {\n          \"Addr\": \"199.204.45.169:2379\",\n          \"ServerName\": \"\",\n          \"Attributes\": null,\n          \"BalancerAttributes\": null,\n          \"Metadata\": null\n        }\n      ],\n      \"Attributes\": null\n    }\n  ],\n  \"ServiceConfig\": null,\n  \"Attributes\": null\n}"}
Apr 20 18:32:29.830752 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829808Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3 SubChannel #4] Subchannel created"}
Apr 20 18:32:29.830752 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.829824Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] Channel Connectivity change to CONNECTING"}
Apr 20 18:32:29.830752 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.830020Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Server #5] Server created"}
Apr 20 18:32:29.830752 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.830060Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
Apr 20 18:32:29.830752 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.830540Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"199.204.45.169:2379"}
Apr 20 18:32:29.830752 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.830598Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Server #5 ListenSocket #6] ListenSocket created"}
Apr 20 18:32:29.830752 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.830613Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3 SubChannel #4] Subchannel Connectivity change to CONNECTING"}
Apr 20 18:32:29.831196 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.830711Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3 SubChannel #4] Subchannel picks a new address \"199.204.45.169:2379\" to connect"}
Apr 20 18:32:29.831196 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.830898Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [pick-first-lb 0xc0005a67b0] Received SubConn state update: 0xc0005a6960, {ConnectivityState:CONNECTING ConnectionError:<nil>}"}
Apr 20 18:32:29.832006 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.831818Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3 SubChannel #4] Subchannel Connectivity change to READY"}
Apr 20 18:32:29.832006 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.831945Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [pick-first-lb 0xc0005a67b0] Received SubConn state update: 0xc0005a6960, {ConnectivityState:READY ConnectionError:<nil>}"}
Apr 20 18:32:29.832006 np0000168547 etcd[66187]: {"level":"info","ts":"2026-04-20T18:32:29.831977Z","caller":"zapgrpc/zapgrpc.go:174","msg":"[core] [Channel #3] Channel Connectivity change to READY"}
Apr 20 18:39:19.768980 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.768809Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":1}
Apr 20 18:39:19.768980 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.768876Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":5,"term":2,"type":"EntryNormal"}
Apr 20 18:39:19.768980 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.768895Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":4,"entry-index":5,"should-applyV3":true}
Apr 20 18:39:19.770122 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.768914Z","caller":"etcdserver/server.go:2314","msg":"applyEntryNormal","raftReq":"header:<ID:5185786858710604294 > lease_grant:<TTL:30 ID:5185786858710604293 > "}
Apr 20 18:39:19.770451 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.770372Z","caller":"v3rpc/interceptor.go:182","msg":"request stats","start time":"2026-04-20T18:39:19.768590Z","time spent":"1.775204ms","remote":"199.204.45.169:37086","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
Apr 20 18:39:19.775185 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.775058Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:19.727216Z","now":"2026-04-20T18:39:19.775055Z"}
Apr 20 18:39:19.777413 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.777362Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":1}
Apr 20 18:39:19.777413 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.777396Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":6,"term":2,"type":"EntryNormal"}
Apr 20 18:39:19.777413 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.777408Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":5,"entry-index":6,"should-applyV3":true}
Apr 20 18:39:19.777634 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.777422Z","caller":"etcdserver/server.go:2314","msg":"applyEntryNormal","raftReq":"header:<ID:5185786858710604296 > lease_grant:<TTL:30 ID:5185786858710604295 > "}
Apr 20 18:39:19.777837 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.777789Z","caller":"v3rpc/interceptor.go:182","msg":"request stats","start time":"2026-04-20T18:39:19.777193Z","time spent":"591.188µs","remote":"199.204.45.169:37086","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
Apr 20 18:39:19.779307 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.779223Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":1}
Apr 20 18:39:19.779307 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.779287Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":7,"term":2,"type":"EntryNormal"}
Apr 20 18:39:19.779307 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.779304Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":6,"entry-index":7,"should-applyV3":true}
Apr 20 18:39:19.779535 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.779319Z","caller":"etcdserver/server.go:2314","msg":"applyEntryNormal","raftReq":"header:<ID:5185786858710604298 > lease_grant:<TTL:30 ID:5185786858710604297 > "}
Apr 20 18:39:19.779535 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.779476Z","caller":"v3rpc/interceptor.go:182","msg":"request stats","start time":"2026-04-20T18:39:19.779143Z","time spent":"329.28µs","remote":"199.204.45.169:37086","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
Apr 20 18:39:19.782790 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.782713Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:19.727216Z","now":"2026-04-20T18:39:19.782712Z"}
Apr 20 18:39:19.783169 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.783064Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:19.727216Z","now":"2026-04-20T18:39:19.783063Z"}
Apr 20 18:39:19.816746 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.816682Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":1}
Apr 20 18:39:19.816746 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.816718Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":8,"term":2,"type":"EntryNormal"}
Apr 20 18:39:19.816746 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.816730Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":7,"entry-index":8,"should-applyV3":true}
Apr 20 18:39:19.816969 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.816743Z","caller":"etcdserver/server.go:2314","msg":"applyEntryNormal","raftReq":"header:<ID:5185786858710604300 > lease_grant:<TTL:30 ID:5185786858710604299 > "}
Apr 20 18:39:19.816969 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.816941Z","caller":"v3rpc/interceptor.go:182","msg":"request stats","start time":"2026-04-20T18:39:19.816594Z","time spent":"343.621µs","remote":"199.204.45.169:37086","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
Apr 20 18:39:19.821349 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:19.821195Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:19.727216Z","now":"2026-04-20T18:39:19.821191Z"}
Apr 20 18:39:26.686814 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:26.686740Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":1}
Apr 20 18:39:26.687303 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:26.686806Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":9,"term":2,"type":"EntryNormal"}
Apr 20 18:39:26.687303 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:26.686826Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":8,"entry-index":9,"should-applyV3":true}
Apr 20 18:39:26.687303 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:26.686844Z","caller":"etcdserver/server.go:2314","msg":"applyEntryNormal","raftReq":"header:<ID:5185786858710604302 > lease_grant:<TTL:30 ID:5185786858710604301 > "}
Apr 20 18:39:26.687303 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:26.687085Z","caller":"v3rpc/interceptor.go:182","msg":"request stats","start time":"2026-04-20T18:39:26.686573Z","time spent":"506.535µs","remote":"199.204.45.169:37086","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
Apr 20 18:39:26.699484 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:26.699269Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:26.627662Z","now":"2026-04-20T18:39:26.699245Z"}
Apr 20 18:39:29.322460 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:29.322359Z","caller":"etcdserver/server.go:2224","msg":"Applying entries","num-entries":1}
Apr 20 18:39:29.322460 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:29.322422Z","caller":"etcdserver/server.go:2227","msg":"Applying entry","index":10,"term":2,"type":"EntryNormal"}
Apr 20 18:39:29.322460 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:29.322444Z","caller":"etcdserver/server.go:2287","msg":"apply entry normal","consistent-index":9,"entry-index":10,"should-applyV3":true}
Apr 20 18:39:29.322798 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:29.322463Z","caller":"etcdserver/server.go:2314","msg":"applyEntryNormal","raftReq":"header:<ID:5185786858710604304 > lease_grant:<TTL:30 ID:5185786858710604303 > "}
Apr 20 18:39:29.322798 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:29.322725Z","caller":"v3rpc/interceptor.go:182","msg":"request stats","start time":"2026-04-20T18:39:29.322160Z","time spent":"558.667µs","remote":"199.204.45.169:37086","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
Apr 20 18:39:29.326665 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:29.326581Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:29.227730Z","now":"2026-04-20T18:39:29.326578Z"}
Apr 20 18:39:34.778370 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:34.778219Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:34.727772Z","now":"2026-04-20T18:39:34.778217Z"}
Apr 20 18:39:34.784717 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:34.784564Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:34.727772Z","now":"2026-04-20T18:39:34.784558Z"}
Apr 20 18:39:34.785033 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:34.784907Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:34.727772Z","now":"2026-04-20T18:39:34.784905Z"}
Apr 20 18:39:34.826045 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:34.825941Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:34.727772Z","now":"2026-04-20T18:39:34.825939Z"}
Apr 20 18:39:41.703352 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:41.703175Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:41.627354Z","now":"2026-04-20T18:39:41.703172Z"}
Apr 20 18:39:44.335459 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:44.335316Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:44.327935Z","now":"2026-04-20T18:39:44.335314Z"}
Apr 20 18:39:49.781191 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:49.781051Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:49.727434Z","now":"2026-04-20T18:39:49.781048Z"}
Apr 20 18:39:49.786197 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:49.786044Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:49.727434Z","now":"2026-04-20T18:39:49.786043Z"}
Apr 20 18:39:49.787540 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:49.787096Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:49.727434Z","now":"2026-04-20T18:39:49.787093Z"}
Apr 20 18:39:49.827497 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:49.827384Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:49.827077Z","now":"2026-04-20T18:39:49.827383Z"}
Apr 20 18:39:56.706565 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:56.706412Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:56.627058Z","now":"2026-04-20T18:39:56.706409Z"}
Apr 20 18:39:59.337850 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:39:59.337660Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:39:59.327845Z","now":"2026-04-20T18:39:59.337657Z"}
Apr 20 18:40:04.782825 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:40:04.782714Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:40:04.727496Z","now":"2026-04-20T18:40:04.782711Z"}
Apr 20 18:40:04.787502 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:40:04.787341Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:40:04.727496Z","now":"2026-04-20T18:40:04.787340Z"}
Apr 20 18:40:04.789137 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:40:04.789059Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:40:04.727496Z","now":"2026-04-20T18:40:04.789057Z"}
Apr 20 18:40:04.829579 np0000168547 etcd[66187]: {"level":"debug","ts":"2026-04-20T18:40:04.829379Z","caller":"etcdserver/server.go:1230","msg":"The member is active, skip checking leadership","latestTickTs":"2026-04-20T18:40:04.827172Z","now":"2026-04-20T18:40:04.829376Z"}