{"level":"warn","ts":"2026-10-26T16:08:40.272301Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T16:08:40.272406Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.96:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.96:2380","--initial-cluster=instance=https://162.253.55.96:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.96:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.96:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-26T16:08:40.272475Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T16:08:40.272489Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.96:2380"]} {"level":"info","ts":"2026-10-26T16:08:40.272508Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-26T16:08:40.273229Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"]} {"level":"info","ts":"2026-10-26T16:08:40.273309Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.96:2380","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":true,"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"} {"level":"info","ts":"2026-10-26T16:08:40.279962Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.173803ms"} {"level":"info","ts":"2026-10-26T16:08:40.29009Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"64a80de7883e6886","cluster-id":"8160e60c0578d165"} {"level":"info","ts":"2026-10-26T16:08:40.290172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=()"} {"level":"info","ts":"2026-10-26T16:08:40.290196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 0"} {"level":"info","ts":"2026-10-26T16:08:40.290212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 64a80de7883e6886 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-26T16:08:40.290222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became follower at term 1"} {"level":"info","ts":"2026-10-26T16:08:40.290267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"} {"level":"warn","ts":"2026-10-26T16:08:40.301716Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-26T16:08:40.303268Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-26T16:08:40.304603Z","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"} {"level":"info","ts":"2026-10-26T16:08:40.306899Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"64a80de7883e6886","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-26T16:08:40.307319Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"64a80de7883e6886","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-26T16:08:40.307458Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-26T16:08:40.307521Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-26T16:08:40.307567Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-26T16:08:40.309173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 switched to configuration voters=(7253062487954581638)"} {"level":"info","ts":"2026-10-26T16:08:40.309734Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","added-peer-id":"64a80de7883e6886","added-peer-peer-urls":["https://162.253.55.96:2380"]} {"level":"info","ts":"2026-10-26T16:08:40.312541Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-26T16:08:40.312733Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.96:2380"} {"level":"info","ts":"2026-10-26T16:08:40.312751Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.96:2380"} {"level":"info","ts":"2026-10-26T16:08:40.313027Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"64a80de7883e6886","initial-advertise-peer-urls":["https://162.253.55.96:2380"],"listen-peer-urls":["https://162.253.55.96:2380"],"advertise-client-urls":["https://162.253.55.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-26T16:08:40.313059Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-26T16:08:41.290631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 is starting a new election at term 1"} {"level":"info","ts":"2026-10-26T16:08:41.290728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-26T16:08:41.290755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgPreVoteResp from 64a80de7883e6886 at term 1"} {"level":"info","ts":"2026-10-26T16:08:41.290778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became candidate at term 2"} {"level":"info","ts":"2026-10-26T16:08:41.290795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 received MsgVoteResp from 64a80de7883e6886 at term 2"} {"level":"info","ts":"2026-10-26T16:08:41.290827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"64a80de7883e6886 became leader at term 2"} {"level":"info","ts":"2026-10-26T16:08:41.290842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 64a80de7883e6886 elected leader 64a80de7883e6886 at term 2"} {"level":"info","ts":"2026-10-26T16:08:41.291977Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T16:08:41.293123Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"64a80de7883e6886","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.96:2379]}","request-path":"/0/members/64a80de7883e6886/attributes","cluster-id":"8160e60c0578d165","publish-timeout":"7s"} {"level":"info","ts":"2026-10-26T16:08:41.293135Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T16:08:41.293269Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T16:08:41.293497Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-26T16:08:41.293571Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-26T16:08:41.294063Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8160e60c0578d165","local-member-id":"64a80de7883e6886","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T16:08:41.294202Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T16:08:41.294235Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T16:08:41.297491Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-26T16:08:41.297481Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.96:2379"} {"level":"info","ts":"2026-10-26T16:08:45.006355Z","caller":"traceutil/trace.go:171","msg":"trace[1810362785] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"118.243857ms","start":"2026-10-26T16:08:44.888076Z","end":"2026-10-26T16:08:45.006319Z","steps":["trace[1810362785] 'process raft request' (duration: 118.024102ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:08:45.273729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.980738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T16:08:45.273878Z","caller":"traceutil/trace.go:171","msg":"trace[521584055] linearizableReadLoop","detail":"{readStateIndex:210; appliedIndex:209; }","duration":"217.323993ms","start":"2026-10-26T16:08:45.056537Z","end":"2026-10-26T16:08:45.273861Z","steps":["trace[521584055] 'read index received' (duration: 109.495573ms)","trace[521584055] 'applied index is now lower than readState.Index' (duration: 107.8273ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T16:08:45.273934Z","caller":"traceutil/trace.go:171","msg":"trace[4316936] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"260.185754ms","start":"2026-10-26T16:08:45.013713Z","end":"2026-10-26T16:08:45.273899Z","steps":["trace[4316936] 'process raft request' (duration: 152.289712ms)","trace[4316936] 'compare' (duration: 106.869106ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T16:08:45.273983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.451146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-10-26T16:08:45.274015Z","caller":"traceutil/trace.go:171","msg":"trace[1249816734] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:205; }","duration":"217.535309ms","start":"2026-10-26T16:08:45.056469Z","end":"2026-10-26T16:08:45.274005Z","steps":["trace[1249816734] 'agreement among raft nodes before linearized reading' (duration: 217.466107ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:08:45.466481Z","caller":"traceutil/trace.go:171","msg":"trace[1595767570] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:210; }","duration":"192.545666ms","start":"2026-10-26T16:08:45.273908Z","end":"2026-10-26T16:08:45.466453Z","steps":["trace[1595767570] 'read index received' (duration: 176.006802ms)","trace[1595767570] 'applied index is now lower than readState.Index' (duration: 16.537824ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T16:08:45.466532Z","caller":"traceutil/trace.go:171","msg":"trace[181550844] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"364.496113ms","start":"2026-10-26T16:08:45.101988Z","end":"2026-10-26T16:08:45.466484Z","steps":["trace[181550844] 'process raft request' (duration: 347.917097ms)","trace[181550844] 'compare' (duration: 16.413772ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T16:08:45.466643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.908225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T16:08:45.466683Z","caller":"traceutil/trace.go:171","msg":"trace[358229151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:206; }","duration":"249.009987ms","start":"2026-10-26T16:08:45.217663Z","end":"2026-10-26T16:08:45.466673Z","steps":["trace[358229151] 'agreement among raft nodes before linearized reading' (duration: 248.888734ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:08:45.466697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T16:08:45.101963Z","time spent":"364.657728ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T16:08:45.467855Z","caller":"traceutil/trace.go:171","msg":"trace[428915397] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"185.878805ms","start":"2026-10-26T16:08:45.281927Z","end":"2026-10-26T16:08:45.467806Z","steps":["trace[428915397] 'process raft request' (duration: 185.740582ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.4749Z","caller":"traceutil/trace.go:171","msg":"trace[352196806] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"133.584202ms","start":"2026-10-26T16:09:24.34129Z","end":"2026-10-26T16:09:24.474874Z","steps":["trace[352196806] 'process raft request' (duration: 133.428728ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.481054Z","caller":"traceutil/trace.go:171","msg":"trace[1805013622] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"114.578223ms","start":"2026-10-26T16:09:24.366462Z","end":"2026-10-26T16:09:24.48104Z","steps":["trace[1805013622] 'process raft request' (duration: 114.421479ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.481076Z","caller":"traceutil/trace.go:171","msg":"trace[546472772] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"134.260509ms","start":"2026-10-26T16:09:24.346763Z","end":"2026-10-26T16:09:24.481023Z","steps":["trace[546472772] 'process raft request' (duration: 134.056784ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.481205Z","caller":"traceutil/trace.go:171","msg":"trace[1426968378] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"110.662733ms","start":"2026-10-26T16:09:24.370504Z","end":"2026-10-26T16:09:24.481167Z","steps":["trace[1426968378] 'process raft request' (duration: 110.429127ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.481258Z","caller":"traceutil/trace.go:171","msg":"trace[1765039081] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"108.450245ms","start":"2026-10-26T16:09:24.372748Z","end":"2026-10-26T16:09:24.481198Z","steps":["trace[1765039081] 'process raft request' (duration: 108.301512ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.481184Z","caller":"traceutil/trace.go:171","msg":"trace[2083561596] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"110.621512ms","start":"2026-10-26T16:09:24.370553Z","end":"2026-10-26T16:09:24.481174Z","steps":["trace[2083561596] 'process raft request' (duration: 110.443927ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.481619Z","caller":"traceutil/trace.go:171","msg":"trace[2041885407] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"107.573423ms","start":"2026-10-26T16:09:24.374004Z","end":"2026-10-26T16:09:24.481577Z","steps":["trace[2041885407] 'process raft request' (duration: 107.104741ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.480998Z","caller":"traceutil/trace.go:171","msg":"trace[1592552021] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"134.456044ms","start":"2026-10-26T16:09:24.346524Z","end":"2026-10-26T16:09:24.48098Z","steps":["trace[1592552021] 'process raft request' (duration: 134.181737ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.481642Z","caller":"traceutil/trace.go:171","msg":"trace[153302880] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"105.322015ms","start":"2026-10-26T16:09:24.376306Z","end":"2026-10-26T16:09:24.481628Z","steps":["trace[153302880] 'process raft request' (duration: 105.143961ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:24.481748Z","caller":"traceutil/trace.go:171","msg":"trace[414071317] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"104.247258ms","start":"2026-10-26T16:09:24.377488Z","end":"2026-10-26T16:09:24.481735Z","steps":["trace[414071317] 'process raft request' (duration: 104.090444ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:30.803969Z","caller":"traceutil/trace.go:171","msg":"trace[1010699717] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"124.851207ms","start":"2026-10-26T16:09:30.679086Z","end":"2026-10-26T16:09:30.803937Z","steps":["trace[1010699717] 'process raft request' (duration: 124.462927ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:31.072431Z","caller":"traceutil/trace.go:171","msg":"trace[1349002596] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"247.908569ms","start":"2026-10-26T16:09:30.824493Z","end":"2026-10-26T16:09:31.072402Z","steps":["trace[1349002596] 'process raft request' (duration: 247.682423ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:09:31.616651Z","caller":"traceutil/trace.go:171","msg":"trace[645468054] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"373.039162ms","start":"2026-10-26T16:09:31.243587Z","end":"2026-10-26T16:09:31.616626Z","steps":["trace[645468054] 'read index received' (duration: 368.120806ms)","trace[645468054] 'applied index is now lower than readState.Index' (duration: 4.917416ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T16:09:31.616764Z","caller":"traceutil/trace.go:171","msg":"trace[1169613310] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"422.955016ms","start":"2026-10-26T16:09:31.193757Z","end":"2026-10-26T16:09:31.616712Z","steps":["trace[1169613310] 'process raft request' (duration: 418.205544ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:09:31.616951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T16:09:31.193728Z","time spent":"423.123629ms","remote":"127.0.0.1:38758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T16:09:31.617687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.598437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-26T16:09:31.617746Z","caller":"traceutil/trace.go:171","msg":"trace[880138930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:612; }","duration":"118.699989ms","start":"2026-10-26T16:09:31.499031Z","end":"2026-10-26T16:09:31.617731Z","steps":["trace[880138930] 'agreement among raft nodes before linearized reading' (duration: 117.827866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:09:31.618239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.651445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T16:09:31.61831Z","caller":"traceutil/trace.go:171","msg":"trace[1857366348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"374.752287ms","start":"2026-10-26T16:09:31.243542Z","end":"2026-10-26T16:09:31.618294Z","steps":["trace[1857366348] 'agreement among raft nodes before linearized reading' (duration: 373.215828ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:09:31.618348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T16:09:31.243522Z","time spent":"374.818698ms","remote":"127.0.0.1:38668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-26T16:10:46.223462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.913229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T16:10:46.223544Z","caller":"traceutil/trace.go:171","msg":"trace[224217749] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1163; }","duration":"130.024612ms","start":"2026-10-26T16:10:46.093502Z","end":"2026-10-26T16:10:46.223527Z","steps":["trace[224217749] 'count revisions from in-memory index tree' (duration: 129.761855ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:10:47.582594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.257198ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-26T16:10:47.582683Z","caller":"traceutil/trace.go:171","msg":"trace[1435464133] linearizableReadLoop","detail":"{readStateIndex:1213; appliedIndex:1211; }","duration":"238.97121ms","start":"2026-10-26T16:10:47.343697Z","end":"2026-10-26T16:10:47.582668Z","steps":["trace[1435464133] 'read index received' (duration: 3.614963ms)","trace[1435464133] 'applied index is now lower than readState.Index' (duration: 235.355136ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T16:10:47.582817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.122494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-10-26T16:10:47.58285Z","caller":"traceutil/trace.go:171","msg":"trace[1375739328] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1170; }","duration":"239.197006ms","start":"2026-10-26T16:10:47.343644Z","end":"2026-10-26T16:10:47.582841Z","steps":["trace[1375739328] 'agreement among raft nodes before linearized reading' (duration: 239.063333ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:10:47.582917Z","caller":"traceutil/trace.go:171","msg":"trace[89895415] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"239.770601ms","start":"2026-10-26T16:10:47.343095Z","end":"2026-10-26T16:10:47.582866Z","steps":["trace[89895415] 'process raft request' (duration: 128.177434ms)","trace[89895415] 'compare' (duration: 110.866788ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T16:10:47.645665Z","caller":"traceutil/trace.go:171","msg":"trace[1369731626] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"292.434488ms","start":"2026-10-26T16:10:47.35321Z","end":"2026-10-26T16:10:47.645644Z","steps":["trace[1369731626] 'process raft request' (duration: 292.376626ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:10:47.645698Z","caller":"traceutil/trace.go:171","msg":"trace[99460000] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"295.065206ms","start":"2026-10-26T16:10:47.350592Z","end":"2026-10-26T16:10:47.645657Z","steps":["trace[99460000] 'process raft request' (duration: 294.864001ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:10:48.186268Z","caller":"traceutil/trace.go:171","msg":"trace[1166834496] linearizableReadLoop","detail":"{readStateIndex:1217; appliedIndex:1216; }","duration":"173.716078ms","start":"2026-10-26T16:10:48.012529Z","end":"2026-10-26T16:10:48.186245Z","steps":["trace[1166834496] 'read index received' (duration: 173.465861ms)","trace[1166834496] 'applied index is now lower than readState.Index' (duration: 248.997µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T16:10:48.186347Z","caller":"traceutil/trace.go:171","msg":"trace[476699736] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"174.245932ms","start":"2026-10-26T16:10:48.012075Z","end":"2026-10-26T16:10:48.186321Z","steps":["trace[476699736] 'process raft request' (duration: 174.002476ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:10:48.186509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.955964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-26T16:10:48.186542Z","caller":"traceutil/trace.go:171","msg":"trace[1076824648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1174; }","duration":"174.030516ms","start":"2026-10-26T16:10:48.012502Z","end":"2026-10-26T16:10:48.186533Z","steps":["trace[1076824648] 'agreement among raft nodes before linearized reading' (duration: 173.885163ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:10:48.186606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.957702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-26T16:10:48.186641Z","caller":"traceutil/trace.go:171","msg":"trace[1510883248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1174; }","duration":"139.028854ms","start":"2026-10-26T16:10:48.047599Z","end":"2026-10-26T16:10:48.186628Z","steps":["trace[1510883248] 'agreement among raft nodes before linearized reading' (duration: 138.89854ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T16:10:48.304494Z","caller":"traceutil/trace.go:171","msg":"trace[167729635] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"111.956986ms","start":"2026-10-26T16:10:48.19251Z","end":"2026-10-26T16:10:48.304467Z","steps":["trace[167729635] 'process raft request' (duration: 109.696718ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T16:10:59.043939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.172131ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T16:10:59.044029Z","caller":"traceutil/trace.go:171","msg":"trace[1597846868] linearizableReadLoop","detail":"{readStateIndex:1288; appliedIndex:1287; }","duration":"291.873874ms","start":"2026-10-26T16:10:58.75213Z","end":"2026-10-26T16:10:59.044004Z","steps":["trace[1597846868] 'read index received' (duration: 73.482µs)","trace[1597846868] 'applied index is now lower than readState.Index' (duration: 291.799552ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T16:10:59.044075Z","caller":"traceutil/trace.go:171","msg":"trace[1178569930] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"367.40864ms","start":"2026-10-26T16:10:58.676627Z","end":"2026-10-26T16:10:59.044036Z","steps":["trace[1178569930] 'process raft request' (duration: 63.061555ms)","trace[1178569930] 'compare' (duration: 303.421091ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T16:10:59.044255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T16:10:58.676613Z","time spent":"367.550405ms","remote":"127.0.0.1:38940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T16:10:59.044278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.15277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-26T16:10:59.04431Z","caller":"traceutil/trace.go:171","msg":"trace[904542236] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1242; }","duration":"292.228723ms","start":"2026-10-26T16:10:58.752073Z","end":"2026-10-26T16:10:59.044301Z","steps":["trace[904542236] 'agreement among raft nodes before linearized reading' (duration: 291.974817ms)"],"step_count":1}