{"level":"warn","ts":"2026-05-11T10:45:16.838221Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T10:45:16.838334Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.126: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://199.19.213.126:2380","--initial-cluster=instance=https://199.19.213.126:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.126:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.126: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-05-11T10:45:16.838426Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T10:45:16.838445Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.126:2380"]} {"level":"info","ts":"2026-05-11T10:45:16.838475Z","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-05-11T10:45:16.839548Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"]} {"level":"info","ts":"2026-05-11T10:45:16.839646Z","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://199.19.213.126:2380"],"listen-peer-urls":["https://199.19.213.126:2380"],"advertise-client-urls":["https://199.19.213.126:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.126: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-05-11T10:45:16.84478Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.87213ms"} {"level":"info","ts":"2026-05-11T10:45:16.868865Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e241c9714ab70808","cluster-id":"e3245fbcce84a6b1"} {"level":"info","ts":"2026-05-11T10:45:16.869288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T10:45:16.869321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became follower at term 0"} {"level":"info","ts":"2026-05-11T10:45:16.869334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e241c9714ab70808 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T10:45:16.869345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became follower at term 1"} {"level":"info","ts":"2026-05-11T10:45:16.869394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=(16303533614479902728)"} {"level":"warn","ts":"2026-05-11T10:45:16.87673Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T10:45:16.879927Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T10:45:16.881142Z","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-05-11T10:45:16.883892Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e241c9714ab70808","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T10:45:16.885243Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e241c9714ab70808","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T10:45:16.885567Z","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-05-11T10:45:16.886353Z","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-05-11T10:45:16.886404Z","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-05-11T10:45:16.886711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=(16303533614479902728)"} {"level":"info","ts":"2026-05-11T10:45:16.889403Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e3245fbcce84a6b1","local-member-id":"e241c9714ab70808","added-peer-id":"e241c9714ab70808","added-peer-peer-urls":["https://199.19.213.126:2380"]} {"level":"info","ts":"2026-05-11T10:45:16.890414Z","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-05-11T10:45:16.890518Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.126:2380"} {"level":"info","ts":"2026-05-11T10:45:16.890539Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.126:2380"} {"level":"info","ts":"2026-05-11T10:45:16.890732Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e241c9714ab70808","initial-advertise-peer-urls":["https://199.19.213.126:2380"],"listen-peer-urls":["https://199.19.213.126:2380"],"advertise-client-urls":["https://199.19.213.126:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T10:45:16.890802Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T10:45:17.370472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T10:45:17.370519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T10:45:17.370546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 received MsgPreVoteResp from e241c9714ab70808 at term 1"} {"level":"info","ts":"2026-05-11T10:45:17.370558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became candidate at term 2"} {"level":"info","ts":"2026-05-11T10:45:17.370595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 received MsgVoteResp from e241c9714ab70808 at term 2"} {"level":"info","ts":"2026-05-11T10:45:17.370604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became leader at term 2"} {"level":"info","ts":"2026-05-11T10:45:17.370612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e241c9714ab70808 elected leader e241c9714ab70808 at term 2"} {"level":"info","ts":"2026-05-11T10:45:17.388531Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e241c9714ab70808","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.126:2379]}","request-path":"/0/members/e241c9714ab70808/attributes","cluster-id":"e3245fbcce84a6b1","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T10:45:17.388539Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:45:17.388557Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:45:17.388677Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:45:17.391629Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T10:45:17.391668Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T10:45:17.391966Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e3245fbcce84a6b1","local-member-id":"e241c9714ab70808","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:45:17.392093Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:45:17.392132Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:45:17.393346Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.126:2379"} {"level":"info","ts":"2026-05-11T10:45:17.394203Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T10:45:23.133837Z","caller":"traceutil/trace.go:171","msg":"trace[1837195531] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"189.230253ms","start":"2026-05-11T10:45:22.94458Z","end":"2026-05-11T10:45:23.13381Z","steps":["trace[1837195531] 'process raft request' (duration: 189.00876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:23.503585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.057791ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-05-11T10:45:23.503949Z","caller":"traceutil/trace.go:171","msg":"trace[602545824] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:316; }","duration":"365.070212ms","start":"2026-05-11T10:45:23.138856Z","end":"2026-05-11T10:45:23.503927Z","steps":["trace[602545824] 'read index received' (duration: 242.095497ms)","trace[602545824] 'applied index is now lower than readState.Index' (duration: 122.973355ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:23.504067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.178853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:45:23.504029Z","caller":"traceutil/trace.go:171","msg":"trace[1199409739] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"466.402449ms","start":"2026-05-11T10:45:23.037559Z","end":"2026-05-11T10:45:23.503961Z","steps":["trace[1199409739] 'process raft request' (duration: 343.267512ms)","trace[1199409739] 'compare' (duration: 122.0208ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:23.504104Z","caller":"traceutil/trace.go:171","msg":"trace[1537718866] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:0; response_revision:308; }","duration":"365.270494ms","start":"2026-05-11T10:45:23.138823Z","end":"2026-05-11T10:45:23.504093Z","steps":["trace[1537718866] 'agreement among raft nodes before linearized reading' (duration: 365.184953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:23.504143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:23.138808Z","time spent":"365.325866ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" "} {"level":"warn","ts":"2026-05-11T10:45:23.504221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:23.037541Z","time spent":"466.585332ms","remote":"127.0.0.1:59446","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:45:23.672929Z","caller":"traceutil/trace.go:171","msg":"trace[337562578] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:317; }","duration":"168.928163ms","start":"2026-05-11T10:45:23.503983Z","end":"2026-05-11T10:45:23.672911Z","steps":["trace[337562578] 'read index received' (duration: 168.75964ms)","trace[337562578] 'applied index is now lower than readState.Index' (duration: 167.783µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:23.673045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.099986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:45:23.673065Z","caller":"traceutil/trace.go:171","msg":"trace[676850556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:309; }","duration":"534.175917ms","start":"2026-05-11T10:45:23.138882Z","end":"2026-05-11T10:45:23.673058Z","steps":["trace[676850556] 'agreement among raft nodes before linearized reading' (duration: 534.124606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:23.673039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.516653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-11T10:45:23.673087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:23.138861Z","time spent":"534.218257ms","remote":"127.0.0.1:59522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-11T10:45:23.673123Z","caller":"traceutil/trace.go:171","msg":"trace[602511723] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:309; }","duration":"222.645225ms","start":"2026-05-11T10:45:23.450456Z","end":"2026-05-11T10:45:23.673102Z","steps":["trace[602511723] 'agreement among raft nodes before linearized reading' (duration: 222.492392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:23.67325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.403517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-05-11T10:45:23.67333Z","caller":"traceutil/trace.go:171","msg":"trace[602673162] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:309; }","duration":"167.56201ms","start":"2026-05-11T10:45:23.505746Z","end":"2026-05-11T10:45:23.673308Z","steps":["trace[602673162] 'agreement among raft nodes before linearized reading' (duration: 167.375177ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:23.673332Z","caller":"traceutil/trace.go:171","msg":"trace[2126131404] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"521.453223ms","start":"2026-05-11T10:45:23.151815Z","end":"2026-05-11T10:45:23.673268Z","steps":["trace[2126131404] 'process raft request' (duration: 520.995346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:23.673404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.266579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-11T10:45:23.673496Z","caller":"traceutil/trace.go:171","msg":"trace[2105790648] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:309; }","duration":"166.390561ms","start":"2026-05-11T10:45:23.507084Z","end":"2026-05-11T10:45:23.673475Z","steps":["trace[2105790648] 'agreement among raft nodes before linearized reading' (duration: 166.184708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:23.673861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:23.151787Z","time spent":"521.676306ms","remote":"127.0.0.1:59446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6740,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:45:23.674427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.073791ms","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-05-11T10:45:23.674493Z","caller":"traceutil/trace.go:171","msg":"trace[1677748680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:309; }","duration":"455.369392ms","start":"2026-05-11T10:45:23.219106Z","end":"2026-05-11T10:45:23.674476Z","steps":["trace[1677748680] 'agreement among raft nodes before linearized reading' (duration: 453.911188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:23.674532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:23.219034Z","time spent":"455.489183ms","remote":"127.0.0.1:59522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-11T10:45:23.889107Z","caller":"traceutil/trace.go:171","msg":"trace[1586259106] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:318; }","duration":"210.829045ms","start":"2026-05-11T10:45:23.678253Z","end":"2026-05-11T10:45:23.889082Z","steps":["trace[1586259106] 'read index received' (duration: 167.333297ms)","trace[1586259106] 'applied index is now lower than readState.Index' (duration: 43.494608ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:23.889258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.999058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-05-11T10:45:23.88929Z","caller":"traceutil/trace.go:171","msg":"trace[2077831820] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:310; }","duration":"211.11003ms","start":"2026-05-11T10:45:23.678171Z","end":"2026-05-11T10:45:23.889281Z","steps":["trace[2077831820] 'agreement among raft nodes before linearized reading' (duration: 211.005158ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:23.889428Z","caller":"traceutil/trace.go:171","msg":"trace[854751541] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"211.658109ms","start":"2026-05-11T10:45:23.677694Z","end":"2026-05-11T10:45:23.889352Z","steps":["trace[854751541] 'process raft request' (duration: 167.876276ms)","trace[854751541] 'compare' (duration: 43.364486ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:23.916384Z","caller":"traceutil/trace.go:171","msg":"trace[1245410827] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"234.972713ms","start":"2026-05-11T10:45:23.681389Z","end":"2026-05-11T10:45:23.916362Z","steps":["trace[1245410827] 'process raft request' (duration: 234.884942ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:23.916448Z","caller":"traceutil/trace.go:171","msg":"trace[401389482] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"237.667956ms","start":"2026-05-11T10:45:23.678733Z","end":"2026-05-11T10:45:23.916401Z","steps":["trace[401389482] 'process raft request' (duration: 237.436613ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:23.916569Z","caller":"traceutil/trace.go:171","msg":"trace[1293457045] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"234.996524ms","start":"2026-05-11T10:45:23.681561Z","end":"2026-05-11T10:45:23.916558Z","steps":["trace[1293457045] 'process raft request' (duration: 234.76605ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.135433Z","caller":"traceutil/trace.go:171","msg":"trace[1035222210] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"166.600147ms","start":"2026-05-11T10:45:45.968796Z","end":"2026-05-11T10:45:46.135396Z","steps":["trace[1035222210] 'process raft request' (duration: 166.193197ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.136161Z","caller":"traceutil/trace.go:171","msg":"trace[1560877373] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"149.260372ms","start":"2026-05-11T10:45:45.986874Z","end":"2026-05-11T10:45:46.136134Z","steps":["trace[1560877373] 'process raft request' (duration: 148.362469ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.136355Z","caller":"traceutil/trace.go:171","msg":"trace[2077599827] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"190.984729ms","start":"2026-05-11T10:45:45.94531Z","end":"2026-05-11T10:45:46.136294Z","steps":["trace[2077599827] 'process raft request' (duration: 189.508722ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.135512Z","caller":"traceutil/trace.go:171","msg":"trace[1160411004] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"148.671257ms","start":"2026-05-11T10:45:45.986815Z","end":"2026-05-11T10:45:46.135486Z","steps":["trace[1160411004] 'process raft request' (duration: 148.297278ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.136676Z","caller":"traceutil/trace.go:171","msg":"trace[1133867902] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"149.438327ms","start":"2026-05-11T10:45:45.986937Z","end":"2026-05-11T10:45:46.136376Z","steps":["trace[1133867902] 'process raft request' (duration: 148.413501ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.13674Z","caller":"traceutil/trace.go:171","msg":"trace[786309394] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"154.409301ms","start":"2026-05-11T10:45:45.98218Z","end":"2026-05-11T10:45:46.136589Z","steps":["trace[786309394] 'process raft request' (duration: 152.845952ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.137139Z","caller":"traceutil/trace.go:171","msg":"trace[1938710254] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"154.648257ms","start":"2026-05-11T10:45:45.982232Z","end":"2026-05-11T10:45:46.13688Z","steps":["trace[1938710254] 'process raft request' (duration: 152.838562ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.13722Z","caller":"traceutil/trace.go:171","msg":"trace[696948010] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"134.231475ms","start":"2026-05-11T10:45:46.002767Z","end":"2026-05-11T10:45:46.136998Z","steps":["trace[696948010] 'process raft request' (duration: 132.672016ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.13734Z","caller":"traceutil/trace.go:171","msg":"trace[1764716490] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"191.848809ms","start":"2026-05-11T10:45:45.945383Z","end":"2026-05-11T10:45:46.137232Z","steps":["trace[1764716490] 'process raft request' (duration: 189.532132ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.137415Z","caller":"traceutil/trace.go:171","msg":"trace[1725702725] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"191.885661ms","start":"2026-05-11T10:45:45.945411Z","end":"2026-05-11T10:45:46.137296Z","steps":["trace[1725702725] 'process raft request' (duration: 189.544613ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:46.137569Z","caller":"traceutil/trace.go:171","msg":"trace[542150466] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"124.560764ms","start":"2026-05-11T10:45:46.012902Z","end":"2026-05-11T10:45:46.137463Z","steps":["trace[542150466] 'process raft request' (duration: 122.611585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:52.260721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.695736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8bkfx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-11T10:45:52.260895Z","caller":"traceutil/trace.go:171","msg":"trace[1653049639] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8bkfx; range_end:; response_count:1; response_revision:615; }","duration":"151.918972ms","start":"2026-05-11T10:45:52.108956Z","end":"2026-05-11T10:45:52.260875Z","steps":["trace[1653049639] 'range keys from in-memory index tree' (duration: 151.564072ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:52.486097Z","caller":"traceutil/trace.go:171","msg":"trace[7281704] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"288.463573ms","start":"2026-05-11T10:45:52.19761Z","end":"2026-05-11T10:45:52.486074Z","steps":["trace[7281704] 'read index received' (duration: 287.96574ms)","trace[7281704] 'applied index is now lower than readState.Index' (duration: 496.843µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:52.486225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.587345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-11T10:45:52.486278Z","caller":"traceutil/trace.go:171","msg":"trace[2140778405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:616; }","duration":"288.670097ms","start":"2026-05-11T10:45:52.197597Z","end":"2026-05-11T10:45:52.486267Z","steps":["trace[2140778405] 'agreement among raft nodes before linearized reading' (duration: 288.565255ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:52.486349Z","caller":"traceutil/trace.go:171","msg":"trace[377924015] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"289.151579ms","start":"2026-05-11T10:45:52.197161Z","end":"2026-05-11T10:45:52.486313Z","steps":["trace[377924015] 'process raft request' (duration: 288.302418ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:52.539635Z","caller":"traceutil/trace.go:171","msg":"trace[638385479] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"275.002298ms","start":"2026-05-11T10:45:52.264582Z","end":"2026-05-11T10:45:52.539584Z","steps":["trace[638385479] 'process raft request' (duration: 274.452076ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:52.540348Z","caller":"traceutil/trace.go:171","msg":"trace[1133638425] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"275.737206ms","start":"2026-05-11T10:45:52.264602Z","end":"2026-05-11T10:45:52.540339Z","steps":["trace[1133638425] 'process raft request' (duration: 274.65577ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:52.540476Z","caller":"traceutil/trace.go:171","msg":"trace[1001496000] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"267.263252ms","start":"2026-05-11T10:45:52.273177Z","end":"2026-05-11T10:45:52.540441Z","steps":["trace[1001496000] 'process raft request' (duration: 266.323409ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:52.540575Z","caller":"traceutil/trace.go:171","msg":"trace[918023700] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"134.215355ms","start":"2026-05-11T10:45:52.406351Z","end":"2026-05-11T10:45:52.540566Z","steps":["trace[918023700] 'process raft request' (duration: 133.836015ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:52.847392Z","caller":"traceutil/trace.go:171","msg":"trace[1969125078] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"275.365247ms","start":"2026-05-11T10:45:52.572005Z","end":"2026-05-11T10:45:52.847371Z","steps":["trace[1969125078] 'process raft request' (duration: 275.233754ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:53.2617Z","caller":"traceutil/trace.go:171","msg":"trace[1227560956] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"514.710145ms","start":"2026-05-11T10:45:52.746947Z","end":"2026-05-11T10:45:53.261657Z","steps":["trace[1227560956] 'process raft request' (duration: 514.452529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:53.26185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:52.746925Z","time spent":"514.848709ms","remote":"127.0.0.1:59436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4584,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:45:53.261974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.304194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:45:53.262044Z","caller":"traceutil/trace.go:171","msg":"trace[1398226573] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:642; }","duration":"479.027958ms","start":"2026-05-11T10:45:52.782519Z","end":"2026-05-11T10:45:53.261546Z","steps":["trace[1398226573] 'read index received' (duration: 64.830088ms)","trace[1398226573] 'applied index is now lower than readState.Index' (duration: 414.19671ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:53.262206Z","caller":"traceutil/trace.go:171","msg":"trace[1050339941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"479.646113ms","start":"2026-05-11T10:45:52.782461Z","end":"2026-05-11T10:45:53.262107Z","steps":["trace[1050339941] 'agreement among raft nodes before linearized reading' (duration: 479.294345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:53.262431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.633144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-11T10:45:53.262466Z","caller":"traceutil/trace.go:171","msg":"trace[2068226212] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:623; }","duration":"410.711585ms","start":"2026-05-11T10:45:52.851747Z","end":"2026-05-11T10:45:53.262458Z","steps":["trace[2068226212] 'agreement among raft nodes before linearized reading' (duration: 410.621263ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:53.26254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.829548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-11T10:45:53.262593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:52.782443Z","time spent":"480.143174ms","remote":"127.0.0.1:59268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-11T10:45:53.262656Z","caller":"traceutil/trace.go:171","msg":"trace[447425276] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"453.021372ms","start":"2026-05-11T10:45:52.809621Z","end":"2026-05-11T10:45:53.262643Z","steps":["trace[447425276] 'agreement among raft nodes before linearized reading' (duration: 452.695074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:53.262556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:52.851732Z","time spent":"410.751947ms","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-05-11T10:45:53.262781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:52.809605Z","time spent":"453.162676ms","remote":"127.0.0.1:59522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-11T10:46:09.399218Z","caller":"traceutil/trace.go:171","msg":"trace[883855380] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"183.341792ms","start":"2026-05-11T10:46:09.215826Z","end":"2026-05-11T10:46:09.399168Z","steps":["trace[883855380] 'process raft request' (duration: 183.128667ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:47:33.423919Z","caller":"traceutil/trace.go:171","msg":"trace[1548789159] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1236; }","duration":"234.306548ms","start":"2026-05-11T10:47:33.189592Z","end":"2026-05-11T10:47:33.423898Z","steps":["trace[1548789159] 'read index received' (duration: 234.155956ms)","trace[1548789159] 'applied index is now lower than readState.Index' (duration: 149.642µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:47:33.423995Z","caller":"traceutil/trace.go:171","msg":"trace[36422377] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"248.275076ms","start":"2026-05-11T10:47:33.17569Z","end":"2026-05-11T10:47:33.423965Z","steps":["trace[36422377] 'process raft request' (duration: 248.085492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:47:33.424162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.548422ms","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-05-11T10:47:33.424201Z","caller":"traceutil/trace.go:171","msg":"trace[297734537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1192; }","duration":"234.622954ms","start":"2026-05-11T10:47:33.189567Z","end":"2026-05-11T10:47:33.42419Z","steps":["trace[297734537] 'agreement among raft nodes before linearized reading' (duration: 234.474311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:47:33.424711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.330591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-11T10:47:33.424753Z","caller":"traceutil/trace.go:171","msg":"trace[1266871249] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1192; }","duration":"204.375712ms","start":"2026-05-11T10:47:33.220367Z","end":"2026-05-11T10:47:33.424743Z","steps":["trace[1266871249] 'agreement among raft nodes before linearized reading' (duration: 204.23534ms)"],"step_count":1}