{"level":"warn","ts":"2026-05-12T11:27:47.953049Z","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-12T11:27:47.953169Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.212: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.212:2380","--initial-cluster=instance=https://199.19.213.212:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.212:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.212: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-12T11:27:47.953266Z","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-12T11:27:47.953283Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.212:2380"]} {"level":"info","ts":"2026-05-12T11:27:47.953306Z","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-12T11:27:47.954081Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"]} {"level":"info","ts":"2026-05-12T11:27:47.954183Z","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.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.212: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-12T11:27:47.958288Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.76863ms"} {"level":"info","ts":"2026-05-12T11:27:47.96664Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e1ab0380b9290bdc","cluster-id":"a3ed131e36ad6843"} {"level":"info","ts":"2026-05-12T11:27:47.966745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T11:27:47.966778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 0"} {"level":"info","ts":"2026-05-12T11:27:47.966795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e1ab0380b9290bdc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T11:27:47.96681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 1"} {"level":"info","ts":"2026-05-12T11:27:47.966857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"} {"level":"warn","ts":"2026-05-12T11:27:47.975589Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T11:27:47.980154Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T11:27:47.983856Z","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-12T11:27:47.986935Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e1ab0380b9290bdc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T11:27:47.987045Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e1ab0380b9290bdc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T11:27:47.987206Z","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-12T11:27:47.987263Z","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-12T11:27:47.987274Z","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-12T11:27:47.992403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"} {"level":"info","ts":"2026-05-12T11:27:47.992703Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","added-peer-id":"e1ab0380b9290bdc","added-peer-peer-urls":["https://199.19.213.212:2380"]} {"level":"info","ts":"2026-05-12T11:27:47.99556Z","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-12T11:27:47.995777Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.212:2380"} {"level":"info","ts":"2026-05-12T11:27:47.99585Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.212:2380"} {"level":"info","ts":"2026-05-12T11:27:47.996708Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e1ab0380b9290bdc","initial-advertise-peer-urls":["https://199.19.213.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T11:27:47.996755Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T11:27:48.967299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T11:27:48.967392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T11:27:48.967422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgPreVoteResp from e1ab0380b9290bdc at term 1"} {"level":"info","ts":"2026-05-12T11:27:48.967447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became candidate at term 2"} {"level":"info","ts":"2026-05-12T11:27:48.96746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgVoteResp from e1ab0380b9290bdc at term 2"} {"level":"info","ts":"2026-05-12T11:27:48.967478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became leader at term 2"} {"level":"info","ts":"2026-05-12T11:27:48.967527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e1ab0380b9290bdc elected leader e1ab0380b9290bdc at term 2"} {"level":"info","ts":"2026-05-12T11:27:48.968718Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e1ab0380b9290bdc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.212:2379]}","request-path":"/0/members/e1ab0380b9290bdc/attributes","cluster-id":"a3ed131e36ad6843","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T11:27:48.968724Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:27:48.96877Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:27:48.968892Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:27:48.96948Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T11:27:48.96953Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T11:27:48.97002Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:27:48.970208Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:27:48.970252Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:27:48.971901Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-12T11:27:48.973906Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.212:2379"} {"level":"info","ts":"2026-05-12T11:27:54.782375Z","caller":"traceutil/trace.go:171","msg":"trace[1822549503] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"149.360292ms","start":"2026-05-12T11:27:54.632993Z","end":"2026-05-12T11:27:54.782353Z","steps":["trace[1822549503] 'process raft request' (duration: 149.175736ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:54.782376Z","caller":"traceutil/trace.go:171","msg":"trace[1572751647] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:321; }","duration":"131.611928ms","start":"2026-05-12T11:27:54.650733Z","end":"2026-05-12T11:27:54.782345Z","steps":["trace[1572751647] 'read index received' (duration: 131.599897ms)","trace[1572751647] 'applied index is now lower than readState.Index' (duration: 9.991µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:27:54.782652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.904657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-12T11:27:54.782723Z","caller":"traceutil/trace.go:171","msg":"trace[668361644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:313; }","duration":"132.042061ms","start":"2026-05-12T11:27:54.650662Z","end":"2026-05-12T11:27:54.782704Z","steps":["trace[668361644] 'agreement among raft nodes before linearized reading' (duration: 131.720941ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:55.03419Z","caller":"traceutil/trace.go:171","msg":"trace[191758157] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"362.027969ms","start":"2026-05-12T11:27:54.672123Z","end":"2026-05-12T11:27:55.034151Z","steps":["trace[191758157] 'process raft request' (duration: 361.853994ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:55.034203Z","caller":"traceutil/trace.go:171","msg":"trace[608471682] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:321; }","duration":"251.608916ms","start":"2026-05-12T11:27:54.782565Z","end":"2026-05-12T11:27:55.034174Z","steps":["trace[608471682] 'read index received' (duration: 251.469552ms)","trace[608471682] 'applied index is now lower than readState.Index' (duration: 138.144µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:27:55.034466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.457552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-05-12T11:27:55.034513Z","caller":"traceutil/trace.go:171","msg":"trace[174921971] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:314; }","duration":"361.550934ms","start":"2026-05-12T11:27:54.67295Z","end":"2026-05-12T11:27:55.034501Z","steps":["trace[174921971] 'agreement among raft nodes before linearized reading' (duration: 361.357998ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:55.034557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:54.672937Z","time spent":"361.607747ms","remote":"127.0.0.1:57556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5537,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-05-12T11:27:55.034816Z","caller":"traceutil/trace.go:171","msg":"trace[552099764] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"362.616778ms","start":"2026-05-12T11:27:54.67219Z","end":"2026-05-12T11:27:55.034806Z","steps":["trace[552099764] 'process raft request' (duration: 361.865584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:55.035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:54.672095Z","time spent":"362.212075ms","remote":"127.0.0.1:57556","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:27:55.03525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:54.672161Z","time spent":"362.69423ms","remote":"127.0.0.1:57556","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-12T11:27:55.035026Z","caller":"traceutil/trace.go:171","msg":"trace[76377116] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"362.128802ms","start":"2026-05-12T11:27:54.672886Z","end":"2026-05-12T11:27:55.035015Z","steps":["trace[76377116] 'process raft request' (duration: 361.202643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:55.035396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:54.672876Z","time spent":"362.495225ms","remote":"127.0.0.1:57574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":219,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:27:55.090231Z","caller":"traceutil/trace.go:171","msg":"trace[396487279] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"303.89637ms","start":"2026-05-12T11:27:54.786312Z","end":"2026-05-12T11:27:55.090208Z","steps":["trace[396487279] 'process raft request' (duration: 303.772736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:55.090565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:27:54.78629Z","time spent":"304.013634ms","remote":"127.0.0.1:57628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:27:55.172648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.932654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-05-12T11:27:55.173141Z","caller":"traceutil/trace.go:171","msg":"trace[887516103] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:316; }","duration":"136.229514ms","start":"2026-05-12T11:27:55.036668Z","end":"2026-05-12T11:27:55.172897Z","steps":["trace[887516103] 'agreement among raft nodes before linearized reading' (duration: 135.477721ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:55.173225Z","caller":"traceutil/trace.go:171","msg":"trace[1086128601] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"119.700998ms","start":"2026-05-12T11:27:55.053454Z","end":"2026-05-12T11:27:55.173155Z","steps":["trace[1086128601] 'process raft request' (duration: 118.520511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:27:55.174009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.049996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pvc-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:27:55.174146Z","caller":"traceutil/trace.go:171","msg":"trace[285198290] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pvc-protection-controller; range_end:; response_count:0; response_revision:316; }","duration":"134.215801ms","start":"2026-05-12T11:27:55.039878Z","end":"2026-05-12T11:27:55.174094Z","steps":["trace[285198290] 'agreement among raft nodes before linearized reading' (duration: 133.991364ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:30.921838Z","caller":"traceutil/trace.go:171","msg":"trace[1514809124] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"195.520865ms","start":"2026-05-12T11:28:30.726277Z","end":"2026-05-12T11:28:30.921798Z","steps":["trace[1514809124] 'process raft request' (duration: 195.199936ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:30.922078Z","caller":"traceutil/trace.go:171","msg":"trace[1265211244] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"171.380813ms","start":"2026-05-12T11:28:30.750679Z","end":"2026-05-12T11:28:30.92206Z","steps":["trace[1265211244] 'process raft request' (duration: 171.31743ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:30.92227Z","caller":"traceutil/trace.go:171","msg":"trace[1088855567] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"181.740413ms","start":"2026-05-12T11:28:30.740482Z","end":"2026-05-12T11:28:30.922222Z","steps":["trace[1088855567] 'process raft request' (duration: 181.301779ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:30.922329Z","caller":"traceutil/trace.go:171","msg":"trace[1744398940] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"173.232308ms","start":"2026-05-12T11:28:30.749059Z","end":"2026-05-12T11:28:30.922291Z","steps":["trace[1744398940] 'process raft request' (duration: 172.867626ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:30.922303Z","caller":"traceutil/trace.go:171","msg":"trace[433785887] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"184.339262ms","start":"2026-05-12T11:28:30.737908Z","end":"2026-05-12T11:28:30.922247Z","steps":["trace[433785887] 'process raft request' (duration: 183.735023ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:30.92815Z","caller":"traceutil/trace.go:171","msg":"trace[2011210658] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"159.345781ms","start":"2026-05-12T11:28:30.768618Z","end":"2026-05-12T11:28:30.927963Z","steps":["trace[2011210658] 'process raft request' (duration: 159.029851ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:36.973638Z","caller":"traceutil/trace.go:171","msg":"trace[1791385243] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"166.840567ms","start":"2026-05-12T11:28:36.806765Z","end":"2026-05-12T11:28:36.973605Z","steps":["trace[1791385243] 'process raft request' (duration: 166.771005ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:36.97374Z","caller":"traceutil/trace.go:171","msg":"trace[1967511035] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"184.564388ms","start":"2026-05-12T11:28:36.789128Z","end":"2026-05-12T11:28:36.973692Z","steps":["trace[1967511035] 'process raft request' (duration: 161.120994ms)","trace[1967511035] 'compare' (duration: 23.109814ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:28:37.614019Z","caller":"traceutil/trace.go:171","msg":"trace[2069238203] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"268.565398ms","start":"2026-05-12T11:28:37.345428Z","end":"2026-05-12T11:28:37.613993Z","steps":["trace[2069238203] 'process raft request' (duration: 268.391673ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:28:37.786654Z","caller":"traceutil/trace.go:171","msg":"trace[410725745] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"412.392324ms","start":"2026-05-12T11:28:37.374222Z","end":"2026-05-12T11:28:37.786615Z","steps":["trace[410725745] 'process raft request' (duration: 402.416204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:28:37.786809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:28:37.374189Z","time spent":"412.539118ms","remote":"127.0.0.1:57454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:28:55.874295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.440355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-12T11:28:55.874403Z","caller":"traceutil/trace.go:171","msg":"trace[1203509350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:815; }","duration":"175.62112ms","start":"2026-05-12T11:28:55.698761Z","end":"2026-05-12T11:28:55.874382Z","steps":["trace[1203509350] 'range keys from in-memory index tree' (duration: 175.147995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:29:31.494491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.09837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:29:31.494593Z","caller":"traceutil/trace.go:171","msg":"trace[2035724660] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"163.244069ms","start":"2026-05-12T11:29:31.331332Z","end":"2026-05-12T11:29:31.494576Z","steps":["trace[2035724660] 'read index received' (duration: 51.793719ms)","trace[2035724660] 'applied index is now lower than readState.Index' (duration: 111.44914ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:29:31.494608Z","caller":"traceutil/trace.go:171","msg":"trace[628176821] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"179.333331ms","start":"2026-05-12T11:29:31.315252Z","end":"2026-05-12T11:29:31.494585Z","steps":["trace[628176821] 'process raft request' (duration: 67.921542ms)","trace[628176821] 'compare' (duration: 110.989307ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:29:31.494716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.386163ms","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-05-12T11:29:31.494745Z","caller":"traceutil/trace.go:171","msg":"trace[1140724543] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1035; }","duration":"163.429265ms","start":"2026-05-12T11:29:31.331305Z","end":"2026-05-12T11:29:31.494735Z","steps":["trace[1140724543] 'agreement among raft nodes before linearized reading' (duration: 163.315171ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:29:55.262321Z","caller":"traceutil/trace.go:171","msg":"trace[584188591] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"248.079679ms","start":"2026-05-12T11:29:55.014219Z","end":"2026-05-12T11:29:55.262299Z","steps":["trace[584188591] 'read index received' (duration: 247.885424ms)","trace[584188591] 'applied index is now lower than readState.Index' (duration: 193.485µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:29:55.262478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.222083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:29:55.262481Z","caller":"traceutil/trace.go:171","msg":"trace[1066692868] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"260.40365ms","start":"2026-05-12T11:29:55.002033Z","end":"2026-05-12T11:29:55.262437Z","steps":["trace[1066692868] 'process raft request' (duration: 260.132942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:29:55.26261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.561177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:29:55.262534Z","caller":"traceutil/trace.go:171","msg":"trace[1665863887] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1113; }","duration":"248.319106ms","start":"2026-05-12T11:29:55.0142Z","end":"2026-05-12T11:29:55.262519Z","steps":["trace[1665863887] 'agreement among raft nodes before linearized reading' (duration: 248.217733ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:29:55.262675Z","caller":"traceutil/trace.go:171","msg":"trace[49953082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1113; }","duration":"135.689331ms","start":"2026-05-12T11:29:55.126969Z","end":"2026-05-12T11:29:55.262659Z","steps":["trace[49953082] 'agreement among raft nodes before linearized reading' (duration: 135.546667ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:29:56.308824Z","caller":"traceutil/trace.go:171","msg":"trace[1120202663] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"121.340851ms","start":"2026-05-12T11:29:56.18745Z","end":"2026-05-12T11:29:56.308791Z","steps":["trace[1120202663] 'process raft request' (duration: 120.572108ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:09.807611Z","caller":"traceutil/trace.go:171","msg":"trace[609741555] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1257; }","duration":"100.152098ms","start":"2026-05-12T11:30:09.707441Z","end":"2026-05-12T11:30:09.807593Z","steps":["trace[609741555] 'read index received' (duration: 99.943411ms)","trace[609741555] 'applied index is now lower than readState.Index' (duration: 207.757µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:09.807702Z","caller":"traceutil/trace.go:171","msg":"trace[1251666460] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"101.88102ms","start":"2026-05-12T11:30:09.705811Z","end":"2026-05-12T11:30:09.807692Z","steps":["trace[1251666460] 'process raft request' (duration: 101.653933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:09.808037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.5814ms","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-12T11:30:09.80806Z","caller":"traceutil/trace.go:171","msg":"trace[420004844] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1213; }","duration":"100.640772ms","start":"2026-05-12T11:30:09.707414Z","end":"2026-05-12T11:30:09.808055Z","steps":["trace[420004844] 'agreement among raft nodes before linearized reading' (duration: 100.54685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:26.632332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.812433ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:30:26.632574Z","caller":"traceutil/trace.go:171","msg":"trace[999583976] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1333; }","duration":"153.935828ms","start":"2026-05-12T11:30:26.478618Z","end":"2026-05-12T11:30:26.632553Z","steps":["trace[999583976] 'read index received' (duration: 9.762724ms)","trace[999583976] 'applied index is now lower than readState.Index' (duration: 144.172084ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:26.632604Z","caller":"traceutil/trace.go:171","msg":"trace[2009136790] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"363.0781ms","start":"2026-05-12T11:30:26.269462Z","end":"2026-05-12T11:30:26.63254Z","steps":["trace[2009136790] 'process raft request' (duration: 218.935727ms)","trace[2009136790] 'compare' (duration: 143.675089ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:26.632654Z","caller":"traceutil/trace.go:171","msg":"trace[1864486277] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"363.114531ms","start":"2026-05-12T11:30:26.269529Z","end":"2026-05-12T11:30:26.632644Z","steps":["trace[1864486277] 'process raft request' (duration: 362.930375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:26.63275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:30:26.26951Z","time spent":"363.179422ms","remote":"127.0.0.1:37580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:30:26.632858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:30:26.269426Z","time spent":"363.268065ms","remote":"127.0.0.1:57530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:30:26.632867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.238467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-12T11:30:26.632945Z","caller":"traceutil/trace.go:171","msg":"trace[672242365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1287; }","duration":"154.374971ms","start":"2026-05-12T11:30:26.478553Z","end":"2026-05-12T11:30:26.632928Z","steps":["trace[672242365] 'agreement among raft nodes before linearized reading' (duration: 154.111244ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:26.731448Z","caller":"traceutil/trace.go:171","msg":"trace[822778107] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"133.967406ms","start":"2026-05-12T11:30:26.597437Z","end":"2026-05-12T11:30:26.731405Z","steps":["trace[822778107] 'process raft request' (duration: 133.599975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:26.731715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.285622ms","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-05-12T11:30:26.731886Z","caller":"traceutil/trace.go:171","msg":"trace[1530201690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1288; }","duration":"250.482228ms","start":"2026-05-12T11:30:26.481377Z","end":"2026-05-12T11:30:26.731859Z","steps":["trace[1530201690] 'agreement among raft nodes before linearized reading' (duration: 249.999623ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:26.927367Z","caller":"traceutil/trace.go:171","msg":"trace[782867560] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"290.021598ms","start":"2026-05-12T11:30:26.637307Z","end":"2026-05-12T11:30:26.927329Z","steps":["trace[782867560] 'process raft request' (duration: 258.001264ms)","trace[782867560] 'compare' (duration: 31.744876ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:26.954757Z","caller":"traceutil/trace.go:171","msg":"trace[902704058] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"217.502383ms","start":"2026-05-12T11:30:26.737239Z","end":"2026-05-12T11:30:26.954741Z","steps":["trace[902704058] 'process raft request' (duration: 217.40405ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:27.802743Z","caller":"traceutil/trace.go:171","msg":"trace[82481021] linearizableReadLoop","detail":"{readStateIndex:1343; appliedIndex:1342; }","duration":"191.354156ms","start":"2026-05-12T11:30:27.611357Z","end":"2026-05-12T11:30:27.802711Z","steps":["trace[82481021] 'read index received' (duration: 191.182811ms)","trace[82481021] 'applied index is now lower than readState.Index' (duration: 169.885µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:27.80291Z","caller":"traceutil/trace.go:171","msg":"trace[630447766] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"207.856673ms","start":"2026-05-12T11:30:27.59504Z","end":"2026-05-12T11:30:27.802897Z","steps":["trace[630447766] 'process raft request' (duration: 207.514043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:27.803528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.111248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-12T11:30:27.8036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.07522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:30:27.803736Z","caller":"traceutil/trace.go:171","msg":"trace[289060913] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1294; }","duration":"131.232494ms","start":"2026-05-12T11:30:27.672474Z","end":"2026-05-12T11:30:27.803707Z","steps":["trace[289060913] 'agreement among raft nodes before linearized reading' (duration: 130.783191ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:27.803661Z","caller":"traceutil/trace.go:171","msg":"trace[1378464259] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1294; }","duration":"192.316094ms","start":"2026-05-12T11:30:27.611301Z","end":"2026-05-12T11:30:27.803617Z","steps":["trace[1378464259] 'agreement among raft nodes before linearized reading' (duration: 191.901191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:28.184339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.599658ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:30:28.184732Z","caller":"traceutil/trace.go:171","msg":"trace[57092616] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1343; }","duration":"303.68077ms","start":"2026-05-12T11:30:27.881026Z","end":"2026-05-12T11:30:28.184706Z","steps":["trace[57092616] 'read index received' (duration: 73.70995ms)","trace[57092616] 'applied index is now lower than readState.Index' (duration: 229.96965ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:28.18484Z","caller":"traceutil/trace.go:171","msg":"trace[345346103] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"375.426342ms","start":"2026-05-12T11:30:27.809371Z","end":"2026-05-12T11:30:28.184797Z","steps":["trace[345346103] 'process raft request' (duration: 145.269077ms)","trace[345346103] 'compare' (duration: 229.249288ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:28.184871Z","caller":"traceutil/trace.go:171","msg":"trace[1207809163] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"374.304778ms","start":"2026-05-12T11:30:27.810542Z","end":"2026-05-12T11:30:28.184847Z","steps":["trace[1207809163] 'process raft request' (duration: 374.070411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:28.184992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:30:27.809344Z","time spent":"375.574617ms","remote":"127.0.0.1:57444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:30:28.185011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:30:27.810511Z","time spent":"374.434332ms","remote":"127.0.0.1:57628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:30:28.185227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.181105ms","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-05-12T11:30:28.185332Z","caller":"traceutil/trace.go:171","msg":"trace[1099624137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1296; }","duration":"304.33739ms","start":"2026-05-12T11:30:27.880973Z","end":"2026-05-12T11:30:28.18531Z","steps":["trace[1099624137] 'agreement among raft nodes before linearized reading' (duration: 303.914577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:28.18529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.838068ms","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-12T11:30:28.18551Z","caller":"traceutil/trace.go:171","msg":"trace[1044794356] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1296; }","duration":"177.123657ms","start":"2026-05-12T11:30:28.008365Z","end":"2026-05-12T11:30:28.185488Z","steps":["trace[1044794356] 'agreement among raft nodes before linearized reading' (duration: 176.685664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:28.185433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:30:27.880953Z","time spent":"304.463024ms","remote":"127.0.0.1:57628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T11:30:29.060445Z","caller":"traceutil/trace.go:171","msg":"trace[1472660331] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1350; }","duration":"102.485749ms","start":"2026-05-12T11:30:28.957929Z","end":"2026-05-12T11:30:29.060415Z","steps":["trace[1472660331] 'read index received' (duration: 102.218581ms)","trace[1472660331] 'applied index is now lower than readState.Index' (duration: 265.708µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:29.060952Z","caller":"traceutil/trace.go:171","msg":"trace[610718259] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"125.636146ms","start":"2026-05-12T11:30:28.935263Z","end":"2026-05-12T11:30:29.060899Z","steps":["trace[610718259] 'process raft request' (duration: 125.004407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:29.062002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.057815ms","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-05-12T11:30:29.062062Z","caller":"traceutil/trace.go:171","msg":"trace[948088645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1302; }","duration":"104.166578ms","start":"2026-05-12T11:30:28.957881Z","end":"2026-05-12T11:30:29.062048Z","steps":["trace[948088645] 'agreement among raft nodes before linearized reading' (duration: 102.695664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:29.397495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.979872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:30:29.397682Z","caller":"traceutil/trace.go:171","msg":"trace[1256927484] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"331.031714ms","start":"2026-05-12T11:30:29.066623Z","end":"2026-05-12T11:30:29.397655Z","steps":["trace[1256927484] 'process raft request' (duration: 152.774083ms)","trace[1256927484] 'compare' (duration: 177.804287ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:30:29.397773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:30:29.066586Z","time spent":"331.146597ms","remote":"127.0.0.1:57628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:30:29.568653Z","caller":"traceutil/trace.go:171","msg":"trace[140196309] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"112.642174ms","start":"2026-05-12T11:30:29.455979Z","end":"2026-05-12T11:30:29.568621Z","steps":["trace[140196309] 'process raft request' (duration: 61.340809ms)","trace[140196309] 'compare' (duration: 51.052628ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:43.136939Z","caller":"traceutil/trace.go:171","msg":"trace[943885228] transaction","detail":"{read_only:false; response_revision:1392; number_of_response:1; }","duration":"127.518292ms","start":"2026-05-12T11:30:43.009387Z","end":"2026-05-12T11:30:43.136905Z","steps":["trace[943885228] 'process raft request' (duration: 127.199193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:43.334521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.197053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T11:30:43.334622Z","caller":"traceutil/trace.go:171","msg":"trace[618595048] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1393; }","duration":"125.374588ms","start":"2026-05-12T11:30:43.209225Z","end":"2026-05-12T11:30:43.3346Z","steps":["trace[618595048] 'count revisions from in-memory index tree' (duration: 125.080709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:30:43.334528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.105916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T11:30:43.335262Z","caller":"traceutil/trace.go:171","msg":"trace[496860393] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1393; }","duration":"101.883639ms","start":"2026-05-12T11:30:43.233307Z","end":"2026-05-12T11:30:43.335191Z","steps":["trace[496860393] 'count revisions from in-memory index tree' (duration: 101.009773ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:24.378054Z","caller":"traceutil/trace.go:171","msg":"trace[1679598715] linearizableReadLoop","detail":"{readStateIndex:2543; appliedIndex:2542; }","duration":"126.507654ms","start":"2026-05-12T11:34:24.25152Z","end":"2026-05-12T11:34:24.378027Z","steps":["trace[1679598715] 'read index received' (duration: 126.343799ms)","trace[1679598715] 'applied index is now lower than readState.Index' (duration: 162.445µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:34:24.378295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.751511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-05-12T11:34:24.378135Z","caller":"traceutil/trace.go:171","msg":"trace[256047970] transaction","detail":"{read_only:false; response_revision:2445; number_of_response:1; }","duration":"127.031649ms","start":"2026-05-12T11:34:24.251065Z","end":"2026-05-12T11:34:24.378096Z","steps":["trace[256047970] 'process raft request' (duration: 126.788602ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:24.378343Z","caller":"traceutil/trace.go:171","msg":"trace[398515315] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2445; }","duration":"126.832194ms","start":"2026-05-12T11:34:24.251496Z","end":"2026-05-12T11:34:24.378328Z","steps":["trace[398515315] 'agreement among raft nodes before linearized reading' (duration: 126.671249ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:25.295559Z","caller":"traceutil/trace.go:171","msg":"trace[1082004266] linearizableReadLoop","detail":"{readStateIndex:2548; appliedIndex:2547; }","duration":"170.028505ms","start":"2026-05-12T11:34:25.125512Z","end":"2026-05-12T11:34:25.295541Z","steps":["trace[1082004266] 'read index received' (duration: 169.901801ms)","trace[1082004266] 'applied index is now lower than readState.Index' (duration: 126.024µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:34:25.295672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.155829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:34:25.295692Z","caller":"traceutil/trace.go:171","msg":"trace[381049292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2450; }","duration":"170.221401ms","start":"2026-05-12T11:34:25.125465Z","end":"2026-05-12T11:34:25.295686Z","steps":["trace[381049292] 'agreement among raft nodes before linearized reading' (duration: 170.17491ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:25.295745Z","caller":"traceutil/trace.go:171","msg":"trace[891029404] transaction","detail":"{read_only:false; response_revision:2450; number_of_response:1; }","duration":"285.32299ms","start":"2026-05-12T11:34:25.010272Z","end":"2026-05-12T11:34:25.295595Z","steps":["trace[891029404] 'process raft request' (duration: 285.146555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:34:25.295799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.703166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T11:34:25.296749Z","caller":"traceutil/trace.go:171","msg":"trace[209058641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2450; }","duration":"108.670274ms","start":"2026-05-12T11:34:25.188047Z","end":"2026-05-12T11:34:25.296717Z","steps":["trace[209058641] 'agreement among raft nodes before linearized reading' (duration: 107.686035ms)"],"step_count":1}