{"level":"warn","ts":"2026-04-17T04:13:22.20153Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T04:13:22.201611Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.204.45.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-04-17T04:13:22.201678Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T04:13:22.201692Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-17T04:13:22.201707Z","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-04-17T04:13:22.202419Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-04-17T04:13:22.202493Z","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.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-04-17T04:13:22.208231Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.447411ms"} {"level":"info","ts":"2026-04-17T04:13:22.219272Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-04-17T04:13:22.219508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T04:13:22.219571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-04-17T04:13:22.219599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T04:13:22.219664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-04-17T04:13:22.219842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-04-17T04:13:22.22727Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T04:13:22.229462Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T04:13:22.230551Z","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-04-17T04:13:22.232833Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T04:13:22.235563Z","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-04-17T04:13:22.235675Z","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-04-17T04:13:22.235688Z","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-04-17T04:13:22.235886Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T04:13:22.238374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-04-17T04:13:22.238377Z","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-04-17T04:13:22.238479Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-17T04:13:22.238495Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-17T04:13:22.23854Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-17T04:13:22.238646Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T04:13:22.238691Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T04:13:22.422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T04:13:22.422098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T04:13:22.422156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-04-17T04:13:22.42239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-04-17T04:13:22.422406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-17T04:13:22.422426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-04-17T04:13:22.422449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-17T04:13:22.423835Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T04:13:22.424537Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T04:13:22.424802Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T04:13:22.424863Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T04:13:22.425177Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T04:13:22.425419Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T04:13:22.42807Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T04:13:22.428157Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T04:13:22.428178Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T04:13:22.428639Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T04:13:22.429365Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-04-17T04:14:02.787247Z","caller":"traceutil/trace.go:171","msg":"trace[264905499] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:514; }","duration":"325.518386ms","start":"2026-04-17T04:14:02.461702Z","end":"2026-04-17T04:14:02.787221Z","steps":["trace[264905499] 'read index received' (duration: 325.261929ms)","trace[264905499] 'applied index is now lower than readState.Index' (duration: 255.337µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:02.787307Z","caller":"traceutil/trace.go:171","msg":"trace[454297105] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"367.357837ms","start":"2026-04-17T04:14:02.419911Z","end":"2026-04-17T04:14:02.787269Z","steps":["trace[454297105] 'process raft request' (duration: 367.110131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:02.787517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.782093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-04-17T04:14:02.787649Z","caller":"traceutil/trace.go:171","msg":"trace[1205515338] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:494; }","duration":"325.936297ms","start":"2026-04-17T04:14:02.461671Z","end":"2026-04-17T04:14:02.787607Z","steps":["trace[1205515338] 'agreement among raft nodes before linearized reading' (duration: 325.691471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:02.787709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:02.461655Z","time spent":"326.04082ms","remote":"127.0.0.1:49770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":559,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-04-17T04:14:02.788024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.501694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-17T04:14:02.788055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:02.41989Z","time spent":"367.508481ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:02.788092Z","caller":"traceutil/trace.go:171","msg":"trace[1223496559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:494; }","duration":"299.610248ms","start":"2026-04-17T04:14:02.488465Z","end":"2026-04-17T04:14:02.788076Z","steps":["trace[1223496559] 'agreement among raft nodes before linearized reading' (duration: 299.485874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:02.788112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.011289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-04-17T04:14:02.788173Z","caller":"traceutil/trace.go:171","msg":"trace[1065866109] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:494; }","duration":"326.098061ms","start":"2026-04-17T04:14:02.462061Z","end":"2026-04-17T04:14:02.788159Z","steps":["trace[1065866109] 'agreement among raft nodes before linearized reading' (duration: 325.898495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:02.788202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:02.462055Z","time spent":"326.141062ms","remote":"127.0.0.1:49770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":541,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"info","ts":"2026-04-17T04:14:03.879314Z","caller":"traceutil/trace.go:171","msg":"trace[1753550362] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"109.299413ms","start":"2026-04-17T04:14:03.769976Z","end":"2026-04-17T04:14:03.879275Z","steps":["trace[1753550362] 'process raft request' (duration: 109.143109ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:03.879354Z","caller":"traceutil/trace.go:171","msg":"trace[829319573] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"109.483937ms","start":"2026-04-17T04:14:03.76984Z","end":"2026-04-17T04:14:03.879324Z","steps":["trace[829319573] 'process raft request' (duration: 108.82996ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.096404Z","caller":"traceutil/trace.go:171","msg":"trace[1192857521] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"277.154171ms","start":"2026-04-17T04:14:03.819215Z","end":"2026-04-17T04:14:04.09637Z","steps":["trace[1192857521] 'process raft request' (duration: 276.884865ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.096518Z","caller":"traceutil/trace.go:171","msg":"trace[1814209970] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"276.038902ms","start":"2026-04-17T04:14:03.820436Z","end":"2026-04-17T04:14:04.096475Z","steps":["trace[1814209970] 'process raft request' (duration: 275.807786ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.096589Z","caller":"traceutil/trace.go:171","msg":"trace[1766009432] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"264.347692ms","start":"2026-04-17T04:14:03.832211Z","end":"2026-04-17T04:14:04.096559Z","steps":["trace[1766009432] 'process raft request' (duration: 264.238098ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.096684Z","caller":"traceutil/trace.go:171","msg":"trace[1447244902] transaction","detail":"{read_only:false; number_of_response:1; response_revision:510; }","duration":"275.623781ms","start":"2026-04-17T04:14:03.821003Z","end":"2026-04-17T04:14:04.096626Z","steps":["trace[1447244902] 'process raft request' (duration: 275.331423ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.423022Z","caller":"traceutil/trace.go:171","msg":"trace[1860710343] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"530.955023ms","start":"2026-04-17T04:14:03.892024Z","end":"2026-04-17T04:14:04.422979Z","steps":["trace[1860710343] 'process raft request' (duration: 528.702134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.423248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.892003Z","time spent":"531.126948ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:04.423659Z","caller":"traceutil/trace.go:171","msg":"trace[1776087319] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"526.834893ms","start":"2026-04-17T04:14:03.896605Z","end":"2026-04-17T04:14:04.42344Z","steps":["trace[1776087319] 'process raft request' (duration: 524.310766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.423807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.896598Z","time spent":"527.161052ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:04.424066Z","caller":"traceutil/trace.go:171","msg":"trace[185022661] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"532.052932ms","start":"2026-04-17T04:14:03.891993Z","end":"2026-04-17T04:14:04.424046Z","steps":["trace[185022661] 'process raft request' (duration: 527.981445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.424153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.891978Z","time spent":"532.127114ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:04.424246Z","caller":"traceutil/trace.go:171","msg":"trace[111496128] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"532.132565ms","start":"2026-04-17T04:14:03.892083Z","end":"2026-04-17T04:14:04.424216Z","steps":["trace[111496128] 'process raft request' (duration: 528.764866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.424345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.892077Z","time spent":"532.233288ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:04.424705Z","caller":"traceutil/trace.go:171","msg":"trace[2060598543] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"514.461915ms","start":"2026-04-17T04:14:03.910221Z","end":"2026-04-17T04:14:04.424683Z","steps":["trace[2060598543] 'process raft request' (duration: 512.863743ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.424773Z","caller":"traceutil/trace.go:171","msg":"trace[236014581] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"522.807716ms","start":"2026-04-17T04:14:03.901956Z","end":"2026-04-17T04:14:04.424764Z","steps":["trace[236014581] 'process raft request' (duration: 519.350614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.424856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.910204Z","time spent":"514.559258ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:04.424705Z","caller":"traceutil/trace.go:171","msg":"trace[1664354200] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"522.60574ms","start":"2026-04-17T04:14:03.902002Z","end":"2026-04-17T04:14:04.424608Z","steps":["trace[1664354200] 'process raft request' (duration: 519.777295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.429974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.901947Z","time spent":"522.857317ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:04.430087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.901988Z","time spent":"522.987411ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:04.430655Z","caller":"traceutil/trace.go:171","msg":"trace[244895362] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"498.590544ms","start":"2026-04-17T04:14:03.932047Z","end":"2026-04-17T04:14:04.430638Z","steps":["trace[244895362] 'process raft request' (duration: 498.020148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.430722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.932025Z","time spent":"498.668465ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:04.431083Z","caller":"traceutil/trace.go:171","msg":"trace[1284041575] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"526.650918ms","start":"2026-04-17T04:14:03.904404Z","end":"2026-04-17T04:14:04.431055Z","steps":["trace[1284041575] 'process raft request' (duration: 517.923647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.431188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:03.904395Z","time spent":"526.740191ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:04.706569Z","caller":"traceutil/trace.go:171","msg":"trace[1154175496] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"603.133311ms","start":"2026-04-17T04:14:04.103397Z","end":"2026-04-17T04:14:04.706531Z","steps":["trace[1154175496] 'process raft request' (duration: 566.668243ms)","trace[1154175496] 'compare' (duration: 35.757609ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:04.706883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.103376Z","time spent":"603.348307ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:04.707315Z","caller":"traceutil/trace.go:171","msg":"trace[1162779674] transaction","detail":"{read_only:false; number_of_response:1; response_revision:521; }","duration":"603.424529ms","start":"2026-04-17T04:14:04.103857Z","end":"2026-04-17T04:14:04.707281Z","steps":["trace[1162779674] 'process raft request' (duration: 603.11712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.70747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.103843Z","time spent":"603.561852ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":10110,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:04.707706Z","caller":"traceutil/trace.go:171","msg":"trace[1165855264] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"593.181816ms","start":"2026-04-17T04:14:04.114504Z","end":"2026-04-17T04:14:04.707686Z","steps":["trace[1165855264] 'process raft request' (duration: 592.657103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.70792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.114494Z","time spent":"593.264189ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:04.708036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.658659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:04.707388Z","caller":"traceutil/trace.go:171","msg":"trace[574867650] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:533; }","duration":"522.948351ms","start":"2026-04-17T04:14:04.18438Z","end":"2026-04-17T04:14:04.707328Z","steps":["trace[574867650] 'read index received' (duration: 235.773543ms)","trace[574867650] 'applied index is now lower than readState.Index' (duration: 287.173658ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:04.708083Z","caller":"traceutil/trace.go:171","msg":"trace[1988189804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"523.742262ms","start":"2026-04-17T04:14:04.184328Z","end":"2026-04-17T04:14:04.708071Z","steps":["trace[1988189804] 'agreement among raft nodes before linearized reading' (duration: 523.66104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.708119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.184309Z","time spent":"523.803364ms","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T04:14:04.740314Z","caller":"traceutil/trace.go:171","msg":"trace[595582324] transaction","detail":"{read_only:false; number_of_response:0; response_revision:522; }","duration":"309.969124ms","start":"2026-04-17T04:14:04.430332Z","end":"2026-04-17T04:14:04.740302Z","steps":["trace[595582324] 'process raft request' (duration: 309.8077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.740394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.430317Z","time spent":"310.038076ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:04.74046Z","caller":"traceutil/trace.go:171","msg":"trace[631982008] transaction","detail":"{read_only:false; number_of_response:0; response_revision:522; }","duration":"309.940294ms","start":"2026-04-17T04:14:04.430392Z","end":"2026-04-17T04:14:04.740332Z","steps":["trace[631982008] 'process raft request' (duration: 309.827421ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.740571Z","caller":"traceutil/trace.go:171","msg":"trace[1941505184] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"294.502322ms","start":"2026-04-17T04:14:04.446054Z","end":"2026-04-17T04:14:04.740556Z","steps":["trace[1941505184] 'process raft request' (duration: 294.269796ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.740488Z","caller":"traceutil/trace.go:171","msg":"trace[1236751613] transaction","detail":"{read_only:false; number_of_response:1; response_revision:522; }","duration":"301.17998ms","start":"2026-04-17T04:14:04.439299Z","end":"2026-04-17T04:14:04.740479Z","steps":["trace[1236751613] 'process raft request' (duration: 300.951424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.740743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.439281Z","time spent":"301.424787ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7373,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:04.740773Z","caller":"traceutil/trace.go:171","msg":"trace[1816969664] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"290.301551ms","start":"2026-04-17T04:14:04.450461Z","end":"2026-04-17T04:14:04.740763Z","steps":["trace[1816969664] 'process raft request' (duration: 290.018953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.740879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.43037Z","time spent":"310.251372ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:04.741008Z","caller":"traceutil/trace.go:171","msg":"trace[546970404] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"259.834931ms","start":"2026-04-17T04:14:04.481167Z","end":"2026-04-17T04:14:04.741002Z","steps":["trace[546970404] 'process raft request' (duration: 259.555064ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:04.741061Z","caller":"traceutil/trace.go:171","msg":"trace[1677593725] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"249.790665ms","start":"2026-04-17T04:14:04.491266Z","end":"2026-04-17T04:14:04.741057Z","steps":["trace[1677593725] 'process raft request' (duration: 249.637721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.74113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.863583ms","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-04-17T04:14:04.741148Z","caller":"traceutil/trace.go:171","msg":"trace[598585213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:526; }","duration":"503.906634ms","start":"2026-04-17T04:14:04.237237Z","end":"2026-04-17T04:14:04.741143Z","steps":["trace[598585213] 'agreement among raft nodes before linearized reading' (duration: 503.857973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:04.741161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.237224Z","time spent":"503.934096ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-17T04:14:04.987398Z","caller":"traceutil/trace.go:171","msg":"trace[939701361] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"226.23414ms","start":"2026-04-17T04:14:04.761141Z","end":"2026-04-17T04:14:04.987375Z","steps":["trace[939701361] 'process raft request' (duration: 213.245304ms)","trace[939701361] 'compare' (duration: 12.866542ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:05.215929Z","caller":"traceutil/trace.go:171","msg":"trace[109531570] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"450.106915ms","start":"2026-04-17T04:14:04.765796Z","end":"2026-04-17T04:14:05.215903Z","steps":["trace[109531570] 'process raft request' (duration: 413.821372ms)","trace[109531570] 'compare' (duration: 36.090658ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:05.21606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.765779Z","time spent":"450.209349ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:05.21616Z","caller":"traceutil/trace.go:171","msg":"trace[1180288342] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"445.542335ms","start":"2026-04-17T04:14:04.770592Z","end":"2026-04-17T04:14:05.216134Z","steps":["trace[1180288342] 'process raft request' (duration: 445.236776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.216334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.770583Z","time spent":"445.656038ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:05.216419Z","caller":"traceutil/trace.go:171","msg":"trace[462836870] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"442.633667ms","start":"2026-04-17T04:14:04.773772Z","end":"2026-04-17T04:14:05.216405Z","steps":["trace[462836870] 'process raft request' (duration: 442.282888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.216466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.773764Z","time spent":"442.680938ms","remote":"127.0.0.1:50106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:05.216484Z","caller":"traceutil/trace.go:171","msg":"trace[1469829921] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:553; }","duration":"424.763273ms","start":"2026-04-17T04:14:04.791705Z","end":"2026-04-17T04:14:05.216468Z","steps":["trace[1469829921] 'read index received' (duration: 182.754265ms)","trace[1469829921] 'applied index is now lower than readState.Index' (duration: 242.007938ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:05.216529Z","caller":"traceutil/trace.go:171","msg":"trace[1707821402] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"434.373648ms","start":"2026-04-17T04:14:04.782137Z","end":"2026-04-17T04:14:05.21651Z","steps":["trace[1707821402] 'process raft request' (duration: 434.192703ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:05.216612Z","caller":"traceutil/trace.go:171","msg":"trace[604978400] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"374.98929ms","start":"2026-04-17T04:14:04.841585Z","end":"2026-04-17T04:14:05.216574Z","steps":["trace[604978400] 'process raft request' (duration: 374.827226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.216676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.841547Z","time spent":"375.095203ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:14:05.216607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.782126Z","time spent":"434.435759ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:05.216777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.275481ms","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-04-17T04:14:05.216808Z","caller":"traceutil/trace.go:171","msg":"trace[1018110830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:533; }","duration":"357.331522ms","start":"2026-04-17T04:14:04.859467Z","end":"2026-04-17T04:14:05.216798Z","steps":["trace[1018110830] 'agreement among raft nodes before linearized reading' (duration: 357.26967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.216831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.859455Z","time spent":"357.372174ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T04:14:05.216898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.193515ms","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-04-17T04:14:05.216963Z","caller":"traceutil/trace.go:171","msg":"trace[484101204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:533; }","duration":"425.280647ms","start":"2026-04-17T04:14:04.791666Z","end":"2026-04-17T04:14:05.216947Z","steps":["trace[484101204] 'agreement among raft nodes before linearized reading' (duration: 425.177554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.217016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:04.791648Z","time spent":"425.355689ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T04:14:05.217035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.197922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T04:14:05.217064Z","caller":"traceutil/trace.go:171","msg":"trace[1376727559] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:533; }","duration":"269.224282ms","start":"2026-04-17T04:14:04.947829Z","end":"2026-04-17T04:14:05.217053Z","steps":["trace[1376727559] 'agreement among raft nodes before linearized reading' (duration: 269.071548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.605998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.917768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:05.606269Z","caller":"traceutil/trace.go:171","msg":"trace[1185995858] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"384.576185ms","start":"2026-04-17T04:14:05.221533Z","end":"2026-04-17T04:14:05.606109Z","steps":["trace[1185995858] 'process raft request' (duration: 169.308267ms)","trace[1185995858] 'compare' (duration: 214.748584ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:05.606535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.221507Z","time spent":"384.985216ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:05.624086Z","caller":"traceutil/trace.go:171","msg":"trace[1009669807] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"397.543278ms","start":"2026-04-17T04:14:05.226516Z","end":"2026-04-17T04:14:05.62406Z","steps":["trace[1009669807] 'process raft request' (duration: 397.136518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.625022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.226502Z","time spent":"398.431033ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:05.626535Z","caller":"traceutil/trace.go:171","msg":"trace[265603671] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"396.442679ms","start":"2026-04-17T04:14:05.230044Z","end":"2026-04-17T04:14:05.626487Z","steps":["trace[265603671] 'process raft request' (duration: 394.757074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.626843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.22997Z","time spent":"396.640555ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:05.628062Z","caller":"traceutil/trace.go:171","msg":"trace[624820323] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"396.881662ms","start":"2026-04-17T04:14:05.231142Z","end":"2026-04-17T04:14:05.628023Z","steps":["trace[624820323] 'process raft request' (duration: 394.628092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.628175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.231125Z","time spent":"396.990474ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:05.629041Z","caller":"traceutil/trace.go:171","msg":"trace[899022445] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"364.231824ms","start":"2026-04-17T04:14:05.264777Z","end":"2026-04-17T04:14:05.629008Z","steps":["trace[899022445] 'process raft request' (duration: 363.114805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.629117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.264758Z","time spent":"364.324398ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:14:05.935402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.601359ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:05.935684Z","caller":"traceutil/trace.go:171","msg":"trace[182987168] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"542.771897ms","start":"2026-04-17T04:14:05.392851Z","end":"2026-04-17T04:14:05.935623Z","steps":["trace[182987168] 'process raft request' (duration: 388.85916ms)","trace[182987168] 'compare' (duration: 153.441835ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:05.935838Z","caller":"traceutil/trace.go:171","msg":"trace[1545472801] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"293.178428ms","start":"2026-04-17T04:14:05.642639Z","end":"2026-04-17T04:14:05.935818Z","steps":["trace[1545472801] 'process raft request' (duration: 292.90021ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:05.936021Z","caller":"traceutil/trace.go:171","msg":"trace[1100098805] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"237.312004ms","start":"2026-04-17T04:14:05.698697Z","end":"2026-04-17T04:14:05.936009Z","steps":["trace[1100098805] 'process raft request' (duration: 237.215882ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:05.936049Z","caller":"traceutil/trace.go:171","msg":"trace[1431696505] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"292.075358ms","start":"2026-04-17T04:14:05.643935Z","end":"2026-04-17T04:14:05.936011Z","steps":["trace[1431696505] 'process raft request' (duration: 291.694317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:05.936274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.39283Z","time spent":"542.931252ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:06.417535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.702365ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:06.417622Z","caller":"traceutil/trace.go:171","msg":"trace[2069675978] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"471.556936ms","start":"2026-04-17T04:14:05.946052Z","end":"2026-04-17T04:14:06.417609Z","steps":["trace[2069675978] 'process raft request' (duration: 338.708037ms)","trace[2069675978] 'compare' (duration: 132.591622ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:06.417663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.946033Z","time spent":"471.610007ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:06.469474Z","caller":"traceutil/trace.go:171","msg":"trace[1379704659] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"518.564064ms","start":"2026-04-17T04:14:05.950886Z","end":"2026-04-17T04:14:06.469451Z","steps":["trace[1379704659] 'process raft request' (duration: 518.177623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:06.469597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.950876Z","time spent":"518.650067ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:06.469916Z","caller":"traceutil/trace.go:171","msg":"trace[981989753] linearizableReadLoop","detail":"{readStateIndex:572; appliedIndex:569; }","duration":"402.907012ms","start":"2026-04-17T04:14:06.066999Z","end":"2026-04-17T04:14:06.469906Z","steps":["trace[981989753] 'read index received' (duration: 217.844346ms)","trace[981989753] 'applied index is now lower than readState.Index' (duration: 185.061826ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:06.470066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.065446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T04:14:06.47009Z","caller":"traceutil/trace.go:171","msg":"trace[1064457268] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:546; }","duration":"403.125988ms","start":"2026-04-17T04:14:06.066958Z","end":"2026-04-17T04:14:06.470084Z","steps":["trace[1064457268] 'agreement among raft nodes before linearized reading' (duration: 403.047036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:06.470122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:06.066941Z","time spent":"403.162969ms","remote":"127.0.0.1:49590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"info","ts":"2026-04-17T04:14:06.470268Z","caller":"traceutil/trace.go:171","msg":"trace[799343499] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"506.242537ms","start":"2026-04-17T04:14:05.963724Z","end":"2026-04-17T04:14:06.469966Z","steps":["trace[799343499] 'process raft request' (duration: 506.109793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:06.470317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:05.963714Z","time spent":"506.585705ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:06.65835Z","caller":"traceutil/trace.go:171","msg":"trace[912250310] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:572; }","duration":"188.381114ms","start":"2026-04-17T04:14:06.469942Z","end":"2026-04-17T04:14:06.658323Z","steps":["trace[912250310] 'read index received' (duration: 180.758231ms)","trace[912250310] 'applied index is now lower than readState.Index' (duration: 7.621773ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:06.658441Z","caller":"traceutil/trace.go:171","msg":"trace[1231497554] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"227.823382ms","start":"2026-04-17T04:14:06.430597Z","end":"2026-04-17T04:14:06.658421Z","steps":["trace[1231497554] 'process raft request' (duration: 220.091216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:06.658475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.011754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:06.658512Z","caller":"traceutil/trace.go:171","msg":"trace[198882934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"473.088797ms","start":"2026-04-17T04:14:06.185408Z","end":"2026-04-17T04:14:06.658496Z","steps":["trace[198882934] 'agreement among raft nodes before linearized reading' (duration: 473.015205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:06.658543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:06.185391Z","time spent":"473.144688ms","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T04:14:06.659705Z","caller":"traceutil/trace.go:171","msg":"trace[636293961] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"170.9111ms","start":"2026-04-17T04:14:06.488773Z","end":"2026-04-17T04:14:06.659684Z","steps":["trace[636293961] 'process raft request' (duration: 170.783436ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:06.975837Z","caller":"traceutil/trace.go:171","msg":"trace[224196745] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"300.348167ms","start":"2026-04-17T04:14:06.675455Z","end":"2026-04-17T04:14:06.975803Z","steps":["trace[224196745] 'process raft request' (duration: 299.809263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:06.976162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:06.675425Z","time spent":"300.525812ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:07.238323Z","caller":"traceutil/trace.go:171","msg":"trace[1361036907] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"560.748264ms","start":"2026-04-17T04:14:06.675622Z","end":"2026-04-17T04:14:07.236371Z","steps":["trace[1361036907] 'process raft request' (duration: 560.409525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:07.238527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:06.675578Z","time spent":"562.840819ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:07.240987Z","caller":"traceutil/trace.go:171","msg":"trace[571946117] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"477.02604ms","start":"2026-04-17T04:14:06.763927Z","end":"2026-04-17T04:14:07.240953Z","steps":["trace[571946117] 'process raft request' (duration: 472.89894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:07.241232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:06.763895Z","time spent":"477.169794ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:14:07.546063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.31882ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:07.546542Z","caller":"traceutil/trace.go:171","msg":"trace[1693869758] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"214.591039ms","start":"2026-04-17T04:14:07.331933Z","end":"2026-04-17T04:14:07.546524Z","steps":["trace[1693869758] 'process raft request' (duration: 214.550858ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:07.546684Z","caller":"traceutil/trace.go:171","msg":"trace[2041845791] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"287.789964ms","start":"2026-04-17T04:14:07.258854Z","end":"2026-04-17T04:14:07.546644Z","steps":["trace[2041845791] 'process raft request' (duration: 287.384783ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:07.546789Z","caller":"traceutil/trace.go:171","msg":"trace[659850651] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"280.771748ms","start":"2026-04-17T04:14:07.266006Z","end":"2026-04-17T04:14:07.546778Z","steps":["trace[659850651] 'process raft request' (duration: 280.386147ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:07.54671Z","caller":"traceutil/trace.go:171","msg":"trace[531388382] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"300.765769ms","start":"2026-04-17T04:14:07.245912Z","end":"2026-04-17T04:14:07.546678Z","steps":["trace[531388382] 'process raft request' (duration: 113.72696ms)","trace[531388382] 'compare' (duration: 186.184916ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:07.546598Z","caller":"traceutil/trace.go:171","msg":"trace[1494880955] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"299.740401ms","start":"2026-04-17T04:14:07.246819Z","end":"2026-04-17T04:14:07.546559Z","steps":["trace[1494880955] 'process raft request' (duration: 299.347781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:07.547057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:07.245893Z","time spent":"301.064436ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:07.547347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:07.246806Z","time spent":"300.451281ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:08.098451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.516058ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:08.098816Z","caller":"traceutil/trace.go:171","msg":"trace[1780671660] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:557; }","duration":"389.889117ms","start":"2026-04-17T04:14:07.708897Z","end":"2026-04-17T04:14:08.098786Z","steps":["trace[1780671660] 'range keys from in-memory index tree' (duration: 389.500057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:08.098883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.923008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:08.099008Z","caller":"traceutil/trace.go:171","msg":"trace[788984199] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"502.080807ms","start":"2026-04-17T04:14:07.596909Z","end":"2026-04-17T04:14:08.09899Z","steps":["trace[788984199] 'process raft request' (duration: 248.668156ms)","trace[788984199] 'compare' (duration: 252.682112ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:08.099074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:07.596886Z","time spent":"502.163569ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:08.178452Z","caller":"traceutil/trace.go:171","msg":"trace[1065709765] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:584; }","duration":"567.093363ms","start":"2026-04-17T04:14:07.611337Z","end":"2026-04-17T04:14:08.17843Z","steps":["trace[1065709765] 'read index received' (duration: 234.338835ms)","trace[1065709765] 'applied index is now lower than readState.Index' (duration: 332.753738ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:08.178582Z","caller":"traceutil/trace.go:171","msg":"trace[1736663577] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"577.062058ms","start":"2026-04-17T04:14:07.601508Z","end":"2026-04-17T04:14:08.17857Z","steps":["trace[1736663577] 'process raft request' (duration: 576.587546ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:08.178688Z","caller":"traceutil/trace.go:171","msg":"trace[597336594] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"486.872111ms","start":"2026-04-17T04:14:07.691797Z","end":"2026-04-17T04:14:08.178669Z","steps":["trace[597336594] 'process raft request' (duration: 486.543263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:08.178711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:07.601479Z","time spent":"577.126049ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:08.178789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:07.691757Z","time spent":"486.982444ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:14:08.178978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.632438ms","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-04-17T04:14:08.17902Z","caller":"traceutil/trace.go:171","msg":"trace[704111997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:560; }","duration":"567.70181ms","start":"2026-04-17T04:14:07.611307Z","end":"2026-04-17T04:14:08.179009Z","steps":["trace[704111997] 'agreement among raft nodes before linearized reading' (duration: 567.560596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:08.179044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:07.611296Z","time spent":"567.742521ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T04:14:08.642953Z","caller":"traceutil/trace.go:171","msg":"trace[1904698246] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"464.407526ms","start":"2026-04-17T04:14:08.178524Z","end":"2026-04-17T04:14:08.642932Z","steps":["trace[1904698246] 'read index received' (duration: 463.907993ms)","trace[1904698246] 'applied index is now lower than readState.Index' (duration: 498.613µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:08.643049Z","caller":"traceutil/trace.go:171","msg":"trace[1253576168] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"487.045367ms","start":"2026-04-17T04:14:08.155973Z","end":"2026-04-17T04:14:08.643018Z","steps":["trace[1253576168] 'process raft request' (duration: 486.437051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:08.643196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01311078s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-17T04:14:08.643192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:08.155949Z","time spent":"487.165191ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:08.643229Z","caller":"traceutil/trace.go:171","msg":"trace[1528202377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:561; }","duration":"1.013179702s","start":"2026-04-17T04:14:07.630042Z","end":"2026-04-17T04:14:08.643222Z","steps":["trace[1528202377] 'agreement among raft nodes before linearized reading' (duration: 1.012981457s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:08.643276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:07.630031Z","time spent":"1.013237993s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T04:14:09.124228Z","caller":"traceutil/trace.go:171","msg":"trace[145846780] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"936.575448ms","start":"2026-04-17T04:14:08.187619Z","end":"2026-04-17T04:14:09.124194Z","steps":["trace[145846780] 'process raft request' (duration: 843.219729ms)","trace[145846780] 'compare' (duration: 92.945527ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:09.124382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:08.187598Z","time spent":"936.705091ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:09.126369Z","caller":"traceutil/trace.go:171","msg":"trace[445434243] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:588; }","duration":"483.329338ms","start":"2026-04-17T04:14:08.643005Z","end":"2026-04-17T04:14:09.126335Z","steps":["trace[445434243] 'read index received' (duration: 387.842372ms)","trace[445434243] 'applied index is now lower than readState.Index' (duration: 95.485246ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:09.126408Z","caller":"traceutil/trace.go:171","msg":"trace[734801632] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"907.512515ms","start":"2026-04-17T04:14:08.218877Z","end":"2026-04-17T04:14:09.126389Z","steps":["trace[734801632] 'process raft request' (duration: 906.099297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.126574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.057446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:14:09.126599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:08.218868Z","time spent":"907.617597ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:09.126628Z","caller":"traceutil/trace.go:171","msg":"trace[656170319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"941.147119ms","start":"2026-04-17T04:14:08.185466Z","end":"2026-04-17T04:14:09.126613Z","steps":["trace[656170319] 'agreement among raft nodes before linearized reading' (duration: 941.047136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.126667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:08.185449Z","time spent":"941.21072ms","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:14:09.126834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.10476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-17T04:14:09.126912Z","caller":"traceutil/trace.go:171","msg":"trace[1489311986] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:563; }","duration":"908.225335ms","start":"2026-04-17T04:14:08.218665Z","end":"2026-04-17T04:14:09.12689Z","steps":["trace[1489311986] 'agreement among raft nodes before linearized reading' (duration: 907.823453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.127906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:08.218649Z","time spent":"909.236002ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29591,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-17T04:14:09.722117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.417155ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:09.722385Z","caller":"traceutil/trace.go:171","msg":"trace[1423193871] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:590; }","duration":"594.769328ms","start":"2026-04-17T04:14:09.127596Z","end":"2026-04-17T04:14:09.722365Z","steps":["trace[1423193871] 'read index received' (duration: 184.963433ms)","trace[1423193871] 'applied index is now lower than readState.Index' (duration: 409.804795ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:09.722493Z","caller":"traceutil/trace.go:171","msg":"trace[38354484] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"1.074349166s","start":"2026-04-17T04:14:08.648073Z","end":"2026-04-17T04:14:09.722423Z","steps":["trace[38354484] 'process raft request' (duration: 664.523541ms)","trace[38354484] 'compare' (duration: 409.22415ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:09.722692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.088547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:09.722697Z","caller":"traceutil/trace.go:171","msg":"trace[843155782] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"1.055983189s","start":"2026-04-17T04:14:08.666671Z","end":"2026-04-17T04:14:09.722654Z","steps":["trace[843155782] 'process raft request' (duration: 1.055576658s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.72273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:08.648054Z","time spent":"1.074553073s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:09.722739Z","caller":"traceutil/trace.go:171","msg":"trace[534034940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"595.175969ms","start":"2026-04-17T04:14:09.127548Z","end":"2026-04-17T04:14:09.722724Z","steps":["trace[534034940] 'agreement among raft nodes before linearized reading' (duration: 595.091097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.722876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:08.666643Z","time spent":"1.056139093s","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:09.722878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:09.127523Z","time spent":"595.344384ms","remote":"127.0.0.1:49554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T04:14:09.907853Z","caller":"traceutil/trace.go:171","msg":"trace[2015292222] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"724.756431ms","start":"2026-04-17T04:14:09.18306Z","end":"2026-04-17T04:14:09.907817Z","steps":["trace[2015292222] 'process raft request' (duration: 724.31831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.908074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:09.183024Z","time spent":"724.941445ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:09.908155Z","caller":"traceutil/trace.go:171","msg":"trace[165207742] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:592; }","duration":"185.718594ms","start":"2026-04-17T04:14:09.722415Z","end":"2026-04-17T04:14:09.908134Z","steps":["trace[165207742] 'read index received' (duration: 184.119931ms)","trace[165207742] 'applied index is now lower than readState.Index' (duration: 1.595833ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:09.908248Z","caller":"traceutil/trace.go:171","msg":"trace[1020231069] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"715.551426ms","start":"2026-04-17T04:14:09.192671Z","end":"2026-04-17T04:14:09.908222Z","steps":["trace[1020231069] 'process raft request' (duration: 715.064813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.908297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.339373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-17T04:14:09.908324Z","caller":"traceutil/trace.go:171","msg":"trace[1089776104] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:567; }","duration":"357.419175ms","start":"2026-04-17T04:14:09.550897Z","end":"2026-04-17T04:14:09.908316Z","steps":["trace[1089776104] 'agreement among raft nodes before linearized reading' (duration: 357.330912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.908348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:09.550874Z","time spent":"357.468045ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T04:14:09.908345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:09.192651Z","time spent":"715.645899ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:09.908467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.868359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10861"} {"level":"info","ts":"2026-04-17T04:14:09.908496Z","caller":"traceutil/trace.go:171","msg":"trace[318884513] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:567; }","duration":"769.919741ms","start":"2026-04-17T04:14:09.138566Z","end":"2026-04-17T04:14:09.908486Z","steps":["trace[318884513] 'agreement among raft nodes before linearized reading' (duration: 769.794388ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.908512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:09.138552Z","time spent":"769.956192ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":10882,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-17T04:14:09.908653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.846148ms","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-04-17T04:14:09.908845Z","caller":"traceutil/trace.go:171","msg":"trace[1738015655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:567; }","duration":"357.098095ms","start":"2026-04-17T04:14:09.551677Z","end":"2026-04-17T04:14:09.908775Z","steps":["trace[1738015655] 'agreement among raft nodes before linearized reading' (duration: 356.589641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.908987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:09.551655Z","time spent":"357.315141ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-17T04:14:09.918968Z","caller":"traceutil/trace.go:171","msg":"trace[136259932] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"184.278664ms","start":"2026-04-17T04:14:09.734675Z","end":"2026-04-17T04:14:09.918953Z","steps":["trace[136259932] 'process raft request' (duration: 184.185471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:09.919386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.139983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:09.919444Z","caller":"traceutil/trace.go:171","msg":"trace[840450744] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:568; }","duration":"189.237766ms","start":"2026-04-17T04:14:09.730193Z","end":"2026-04-17T04:14:09.919431Z","steps":["trace[840450744] 'agreement among raft nodes before linearized reading' (duration: 189.146303ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:10.400962Z","caller":"traceutil/trace.go:171","msg":"trace[253097982] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"471.662678ms","start":"2026-04-17T04:14:09.92927Z","end":"2026-04-17T04:14:10.400933Z","steps":["trace[253097982] 'process raft request' (duration: 471.482433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:10.401136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:09.929232Z","time spent":"471.821953ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:10.758686Z","caller":"traceutil/trace.go:171","msg":"trace[953864116] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:597; }","duration":"564.067913ms","start":"2026-04-17T04:14:10.194585Z","end":"2026-04-17T04:14:10.758652Z","steps":["trace[953864116] 'read index received' (duration: 206.211687ms)","trace[953864116] 'applied index is now lower than readState.Index' (duration: 357.854536ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:10.758771Z","caller":"traceutil/trace.go:171","msg":"trace[1836459212] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"807.688884ms","start":"2026-04-17T04:14:09.951042Z","end":"2026-04-17T04:14:10.75873Z","steps":["trace[1836459212] 'process raft request' (duration: 807.353794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:10.758904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.232827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:10.759054Z","caller":"traceutil/trace.go:171","msg":"trace[998743066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"564.493594ms","start":"2026-04-17T04:14:10.194547Z","end":"2026-04-17T04:14:10.759041Z","steps":["trace[998743066] 'agreement among raft nodes before linearized reading' (duration: 564.236557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:10.758985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:09.951025Z","time spent":"807.829987ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:10.759201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:10.19453Z","time spent":"564.587226ms","remote":"127.0.0.1:49554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T04:14:11.080713Z","caller":"traceutil/trace.go:171","msg":"trace[135637388] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"667.180392ms","start":"2026-04-17T04:14:10.413514Z","end":"2026-04-17T04:14:11.080694Z","steps":["trace[135637388] 'process raft request' (duration: 667.015337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:11.080837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:10.413485Z","time spent":"667.285934ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:11.286134Z","caller":"traceutil/trace.go:171","msg":"trace[1410321212] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"502.531699ms","start":"2026-04-17T04:14:10.783567Z","end":"2026-04-17T04:14:11.286098Z","steps":["trace[1410321212] 'process raft request' (duration: 501.111761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:11.286475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:10.783529Z","time spent":"502.687773ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:11.994278Z","caller":"traceutil/trace.go:171","msg":"trace[1030135777] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"887.730239ms","start":"2026-04-17T04:14:11.1065Z","end":"2026-04-17T04:14:11.99423Z","steps":["trace[1030135777] 'process raft request' (duration: 887.429912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:11.994474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:11.106472Z","time spent":"887.909145ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:11.99531Z","caller":"traceutil/trace.go:171","msg":"trace[1832135009] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:600; }","duration":"864.635776ms","start":"2026-04-17T04:14:11.129511Z","end":"2026-04-17T04:14:11.994146Z","steps":["trace[1832135009] 'read index received' (duration: 155.1025ms)","trace[1832135009] 'applied index is now lower than readState.Index' (duration: 709.532066ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:11.994876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.021827ms","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-04-17T04:14:11.996454Z","caller":"traceutil/trace.go:171","msg":"trace[359976534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"866.797114ms","start":"2026-04-17T04:14:11.129443Z","end":"2026-04-17T04:14:11.99624Z","steps":["trace[359976534] 'agreement among raft nodes before linearized reading' (duration: 864.880844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:11.99671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:11.129416Z","time spent":"867.276596ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T04:14:12.637974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.259257ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-04-17T04:14:12.638312Z","caller":"traceutil/trace.go:171","msg":"trace[43098284] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:602; }","duration":"642.801964ms","start":"2026-04-17T04:14:11.995464Z","end":"2026-04-17T04:14:12.638265Z","steps":["trace[43098284] 'read index received' (duration: 450.164967ms)","trace[43098284] 'applied index is now lower than readState.Index' (duration: 192.636017ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:12.638408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454858094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:12.638436Z","caller":"traceutil/trace.go:171","msg":"trace[1086593656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"1.454933226s","start":"2026-04-17T04:14:11.183493Z","end":"2026-04-17T04:14:12.638426Z","steps":["trace[1086593656] 'agreement among raft nodes before linearized reading' (duration: 1.454859563s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.63848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:11.183473Z","time spent":"1.454989888s","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:14:12.638607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.787433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-17T04:14:12.638697Z","caller":"traceutil/trace.go:171","msg":"trace[967095225] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.32822871s","start":"2026-04-17T04:14:11.310447Z","end":"2026-04-17T04:14:12.638676Z","steps":["trace[967095225] 'process raft request' (duration: 1.327641945s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.638803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.178205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T04:14:12.638836Z","caller":"traceutil/trace.go:171","msg":"trace[182740698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:576; }","duration":"695.236596ms","start":"2026-04-17T04:14:11.943589Z","end":"2026-04-17T04:14:12.638826Z","steps":["trace[182740698] 'agreement among raft nodes before linearized reading' (duration: 695.145454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.638853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.015128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-17T04:14:12.638855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:11.310425Z","time spent":"1.328351113s","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:12.638891Z","caller":"traceutil/trace.go:171","msg":"trace[908992124] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:576; }","duration":"911.093631ms","start":"2026-04-17T04:14:11.727787Z","end":"2026-04-17T04:14:12.638881Z","steps":["trace[908992124] 'agreement among raft nodes before linearized reading' (duration: 910.963677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.63889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:11.943576Z","time spent":"695.304959ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T04:14:12.638919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:11.727764Z","time spent":"911.149471ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T04:14:12.638688Z","caller":"traceutil/trace.go:171","msg":"trace[1460636375] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:576; }","duration":"718.918636ms","start":"2026-04-17T04:14:11.919749Z","end":"2026-04-17T04:14:12.638668Z","steps":["trace[1460636375] 'agreement among raft nodes before linearized reading' (duration: 718.628389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.639022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:11.919732Z","time spent":"719.280625ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29591,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-17T04:14:12.63861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.343573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T04:14:12.639142Z","caller":"traceutil/trace.go:171","msg":"trace[627395131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"694.944169ms","start":"2026-04-17T04:14:11.944185Z","end":"2026-04-17T04:14:12.639129Z","steps":["trace[627395131] 'agreement among raft nodes before linearized reading' (duration: 694.167107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.639172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:11.944161Z","time spent":"695.002371ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-17T04:14:12.67209Z","caller":"traceutil/trace.go:171","msg":"trace[557869873] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"636.730893ms","start":"2026-04-17T04:14:12.035338Z","end":"2026-04-17T04:14:12.672069Z","steps":["trace[557869873] 'process raft request' (duration: 636.660702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.672227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:12.035313Z","time spent":"636.836365ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:12.672333Z","caller":"traceutil/trace.go:171","msg":"trace[754586435] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"671.199259ms","start":"2026-04-17T04:14:12.00105Z","end":"2026-04-17T04:14:12.67225Z","steps":["trace[754586435] 'process raft request' (duration: 670.772167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.672481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:12.001032Z","time spent":"671.381063ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:12.863287Z","caller":"traceutil/trace.go:171","msg":"trace[1351546464] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"219.553023ms","start":"2026-04-17T04:14:12.643692Z","end":"2026-04-17T04:14:12.863245Z","steps":["trace[1351546464] 'process raft request' (duration: 215.993648ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:12.863333Z","caller":"traceutil/trace.go:171","msg":"trace[1898899619] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"219.514231ms","start":"2026-04-17T04:14:12.643779Z","end":"2026-04-17T04:14:12.863293Z","steps":["trace[1898899619] 'process raft request' (duration: 219.310235ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:12.863351Z","caller":"traceutil/trace.go:171","msg":"trace[1442424381] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"217.960791ms","start":"2026-04-17T04:14:12.645364Z","end":"2026-04-17T04:14:12.863325Z","steps":["trace[1442424381] 'process raft request' (duration: 217.850128ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:12.863544Z","caller":"traceutil/trace.go:171","msg":"trace[1897869939] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:606; }","duration":"190.073399ms","start":"2026-04-17T04:14:12.673449Z","end":"2026-04-17T04:14:12.863523Z","steps":["trace[1897869939] 'read index received' (duration: 186.35447ms)","trace[1897869939] 'applied index is now lower than readState.Index' (duration: 3.568335ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:12.863587Z","caller":"traceutil/trace.go:171","msg":"trace[1520814972] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"196.768777ms","start":"2026-04-17T04:14:12.666804Z","end":"2026-04-17T04:14:12.863573Z","steps":["trace[1520814972] 'process raft request' (duration: 196.459059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:12.863744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.95088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10870"} {"level":"info","ts":"2026-04-17T04:14:12.863793Z","caller":"traceutil/trace.go:171","msg":"trace[1775023821] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:582; }","duration":"209.055302ms","start":"2026-04-17T04:14:12.654726Z","end":"2026-04-17T04:14:12.863781Z","steps":["trace[1775023821] 'agreement among raft nodes before linearized reading' (duration: 208.894938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:13.364648Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880323674223063,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T04:14:13.545025Z","caller":"traceutil/trace.go:171","msg":"trace[1226817706] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"836.612282ms","start":"2026-04-17T04:14:12.708095Z","end":"2026-04-17T04:14:13.544707Z","steps":["trace[1226817706] 'process raft request' (duration: 826.174355ms)","trace[1226817706] 'compare' (duration: 10.210991ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:13.545155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:12.708063Z","time spent":"837.021653ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74754,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:13.787462Z","caller":"traceutil/trace.go:171","msg":"trace[505561768] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:610; }","duration":"923.807738ms","start":"2026-04-17T04:14:12.863632Z","end":"2026-04-17T04:14:13.78744Z","steps":["trace[505561768] 'read index received' (duration: 670.693585ms)","trace[505561768] 'applied index is now lower than readState.Index' (duration: 253.113103ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:13.787688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106313255s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:13.787779Z","caller":"traceutil/trace.go:171","msg":"trace[364173115] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"1.106450059s","start":"2026-04-17T04:14:12.681316Z","end":"2026-04-17T04:14:13.787766Z","steps":["trace[364173115] 'agreement among raft nodes before linearized reading' (duration: 1.106318435s)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:13.787576Z","caller":"traceutil/trace.go:171","msg":"trace[1376007135] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"799.622719ms","start":"2026-04-17T04:14:12.987915Z","end":"2026-04-17T04:14:13.787538Z","steps":["trace[1376007135] 'process raft request' (duration: 799.017113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:13.787849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:12.681298Z","time spent":"1.1065405s","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:14:13.78806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:12.987888Z","time spent":"800.001549ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:14.259141Z","caller":"traceutil/trace.go:171","msg":"trace[953994486] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"471.502364ms","start":"2026-04-17T04:14:13.787606Z","end":"2026-04-17T04:14:14.259108Z","steps":["trace[953994486] 'read index received' (duration: 431.997364ms)","trace[953994486] 'applied index is now lower than readState.Index' (duration: 39.50337ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:14.259221Z","caller":"traceutil/trace.go:171","msg":"trace[1681961289] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"692.508375ms","start":"2026-04-17T04:14:13.566682Z","end":"2026-04-17T04:14:14.259191Z","steps":["trace[1681961289] 'process raft request' (duration: 652.904233ms)","trace[1681961289] 'compare' (duration: 39.354005ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:14.259394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:13.566664Z","time spent":"692.612047ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20851,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:14.259456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.381374421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-04-17T04:14:14.259524Z","caller":"traceutil/trace.go:171","msg":"trace[75769624] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:585; }","duration":"1.381442273s","start":"2026-04-17T04:14:12.878063Z","end":"2026-04-17T04:14:14.259505Z","steps":["trace[75769624] 'agreement among raft nodes before linearized reading' (duration: 1.381194777s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:14.259576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:12.877974Z","time spent":"1.381589267s","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":59652,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-17T04:14:14.801366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.55431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:14.801496Z","caller":"traceutil/trace.go:171","msg":"trace[1093206945] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"542.249173ms","start":"2026-04-17T04:14:14.259225Z","end":"2026-04-17T04:14:14.801474Z","steps":["trace[1093206945] 'read index received' (duration: 362.5264ms)","trace[1093206945] 'applied index is now lower than readState.Index' (duration: 179.721383ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:14.801751Z","caller":"traceutil/trace.go:171","msg":"trace[1289952747] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"963.146204ms","start":"2026-04-17T04:14:13.838557Z","end":"2026-04-17T04:14:14.801703Z","steps":["trace[1289952747] 'process raft request' (duration: 783.131611ms)","trace[1289952747] 'compare' (duration: 179.300584ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:14.801803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.012461653s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:14:14.801924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:13.838499Z","time spent":"963.337418ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:14.801937Z","caller":"traceutil/trace.go:171","msg":"trace[589918925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"1.012631519s","start":"2026-04-17T04:14:13.789265Z","end":"2026-04-17T04:14:14.801897Z","steps":["trace[589918925] 'agreement among raft nodes before linearized reading' (duration: 1.012432394s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:14.802041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:13.789241Z","time spent":"1.012787402s","remote":"127.0.0.1:49554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:14:15.167537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.790296ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:15.167679Z","caller":"traceutil/trace.go:171","msg":"trace[882801459] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"366.131815ms","start":"2026-04-17T04:14:14.801531Z","end":"2026-04-17T04:14:15.167663Z","steps":["trace[882801459] 'read index received' (duration: 151.300509ms)","trace[882801459] 'applied index is now lower than readState.Index' (duration: 214.830046ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:15.167714Z","caller":"traceutil/trace.go:171","msg":"trace[1355060369] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"763.241933ms","start":"2026-04-17T04:14:14.404434Z","end":"2026-04-17T04:14:15.167676Z","steps":["trace[1355060369] 'process raft request' (duration: 548.223571ms)","trace[1355060369] 'compare' (duration: 214.503009ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:15.167831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:14.404406Z","time spent":"763.368356ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:15.167857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.103529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-17T04:14:15.167865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.386575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-04-17T04:14:15.167903Z","caller":"traceutil/trace.go:171","msg":"trace[1277178719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"490.194881ms","start":"2026-04-17T04:14:14.677698Z","end":"2026-04-17T04:14:15.167893Z","steps":["trace[1277178719] 'agreement among raft nodes before linearized reading' (duration: 490.033766ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:15.167909Z","caller":"traceutil/trace.go:171","msg":"trace[1335683761] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:587; }","duration":"886.466486ms","start":"2026-04-17T04:14:14.281431Z","end":"2026-04-17T04:14:15.167897Z","steps":["trace[1335683761] 'agreement among raft nodes before linearized reading' (duration: 886.307041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:15.167931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:14.67767Z","time spent":"490.255773ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T04:14:15.167946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:14.281412Z","time spent":"886.525488ms","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":80724,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-17T04:14:15.668543Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880323674223072,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T04:14:16.065491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.869382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:16.065601Z","caller":"traceutil/trace.go:171","msg":"trace[425833386] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"1.219837672s","start":"2026-04-17T04:14:14.845745Z","end":"2026-04-17T04:14:16.065583Z","steps":["trace[425833386] 'process raft request' (duration: 953.784405ms)","trace[425833386] 'compare' (duration: 265.692677ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:16.065668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:14.84572Z","time spent":"1.219910983s","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:16.583586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.603876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:16.583853Z","caller":"traceutil/trace.go:171","msg":"trace[869499293] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"587.216077ms","start":"2026-04-17T04:14:15.996619Z","end":"2026-04-17T04:14:16.583835Z","steps":["trace[869499293] 'process raft request' (duration: 587.171136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.583932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:15.996581Z","time spent":"587.31696ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:16.584152Z","caller":"traceutil/trace.go:171","msg":"trace[1684936999] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:615; }","duration":"1.416416953s","start":"2026-04-17T04:14:15.16771Z","end":"2026-04-17T04:14:16.584127Z","steps":["trace[1684936999] 'read index received' (duration: 631.802312ms)","trace[1684936999] 'applied index is now lower than readState.Index' (duration: 784.612281ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:16.584168Z","caller":"traceutil/trace.go:171","msg":"trace[850208715] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"1.41253616s","start":"2026-04-17T04:14:15.1716Z","end":"2026-04-17T04:14:16.584136Z","steps":["trace[850208715] 'process raft request' (duration: 1.030280437s)","trace[850208715] 'compare' (duration: 381.457641ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:16.584266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.715412515s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T04:14:16.584268Z","caller":"traceutil/trace.go:171","msg":"trace[1920307155] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.374003286s","start":"2026-04-17T04:14:15.210217Z","end":"2026-04-17T04:14:16.584221Z","steps":["trace[1920307155] 'process raft request' (duration: 1.373486152s)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:16.584315Z","caller":"traceutil/trace.go:171","msg":"trace[78834930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"1.715461926s","start":"2026-04-17T04:14:14.868837Z","end":"2026-04-17T04:14:16.584299Z","steps":["trace[78834930] 'agreement among raft nodes before linearized reading' (duration: 1.715291232s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.584326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:15.171573Z","time spent":"1.412665643s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:16.584346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.716128323s","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-04-17T04:14:16.584384Z","caller":"traceutil/trace.go:171","msg":"trace[291791731] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"1.716202016s","start":"2026-04-17T04:14:14.868169Z","end":"2026-04-17T04:14:16.584371Z","steps":["trace[291791731] 'agreement among raft nodes before linearized reading' (duration: 1.716078423s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.584392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:14.868811Z","time spent":"1.715572369s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T04:14:16.584411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.716222346s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T04:14:16.584446Z","caller":"traceutil/trace.go:171","msg":"trace[168018040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"1.716254117s","start":"2026-04-17T04:14:14.868182Z","end":"2026-04-17T04:14:16.584436Z","steps":["trace[168018040] 'agreement among raft nodes before linearized reading' (duration: 1.716166254s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.584327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.774073222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:14:16.584474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:14.86811Z","time spent":"1.716357879s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-17T04:14:16.584481Z","caller":"traceutil/trace.go:171","msg":"trace[97048989] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"1.774271467s","start":"2026-04-17T04:14:14.8102Z","end":"2026-04-17T04:14:16.584471Z","steps":["trace[97048989] 'agreement among raft nodes before linearized reading' (duration: 1.774094593s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.584508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:14.810181Z","time spent":"1.774320929s","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:14:16.584499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:15.210194Z","time spent":"1.374166981s","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:16.584415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:14.86815Z","time spent":"1.716257577s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T04:14:16.58455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392703502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-04-17T04:14:16.584583Z","caller":"traceutil/trace.go:171","msg":"trace[1196643298] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:591; }","duration":"1.392772934s","start":"2026-04-17T04:14:15.191799Z","end":"2026-04-17T04:14:16.584571Z","steps":["trace[1196643298] 'agreement among raft nodes before linearized reading' (duration: 1.392643801s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.584613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:15.191757Z","time spent":"1.392850946s","remote":"127.0.0.1:49608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":151257,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-17T04:14:16.584657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.726581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T04:14:16.584737Z","caller":"traceutil/trace.go:171","msg":"trace[948432036] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:591; }","duration":"517.847924ms","start":"2026-04-17T04:14:16.06687Z","end":"2026-04-17T04:14:16.584718Z","steps":["trace[948432036] 'agreement among raft nodes before linearized reading' (duration: 517.603167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.584783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:16.066854Z","time spent":"517.920756ms","remote":"127.0.0.1:49590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"info","ts":"2026-04-17T04:14:16.867881Z","caller":"traceutil/trace.go:171","msg":"trace[826461680] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:620; }","duration":"274.272845ms","start":"2026-04-17T04:14:16.593579Z","end":"2026-04-17T04:14:16.867852Z","steps":["trace[826461680] 'read index received' (duration: 51.111338ms)","trace[826461680] 'applied index is now lower than readState.Index' (duration: 223.159987ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:16.868213Z","caller":"traceutil/trace.go:171","msg":"trace[17948102] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"278.738243ms","start":"2026-04-17T04:14:16.589458Z","end":"2026-04-17T04:14:16.868196Z","steps":["trace[17948102] 'process raft request' (duration: 278.038114ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:16.868439Z","caller":"traceutil/trace.go:171","msg":"trace[1144492810] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"278.900168ms","start":"2026-04-17T04:14:16.589498Z","end":"2026-04-17T04:14:16.868398Z","steps":["trace[1144492810] 'process raft request' (duration: 278.050945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.868483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.856341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:16.8686Z","caller":"traceutil/trace.go:171","msg":"trace[118484979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"275.011135ms","start":"2026-04-17T04:14:16.593564Z","end":"2026-04-17T04:14:16.868575Z","steps":["trace[118484979] 'agreement among raft nodes before linearized reading' (duration: 274.701436ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:16.868644Z","caller":"traceutil/trace.go:171","msg":"trace[90613556] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"226.619059ms","start":"2026-04-17T04:14:16.641989Z","end":"2026-04-17T04:14:16.868608Z","steps":["trace[90613556] 'process raft request' (duration: 225.644563ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:16.868723Z","caller":"traceutil/trace.go:171","msg":"trace[624659855] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"279.422062ms","start":"2026-04-17T04:14:16.589284Z","end":"2026-04-17T04:14:16.868706Z","steps":["trace[624659855] 'process raft request' (duration: 278.007534ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:16.887752Z","caller":"traceutil/trace.go:171","msg":"trace[306138155] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"242.418369ms","start":"2026-04-17T04:14:16.645289Z","end":"2026-04-17T04:14:16.887707Z","steps":["trace[306138155] 'process raft request' (duration: 242.203283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:16.887897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.785273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-17T04:14:16.888001Z","caller":"traceutil/trace.go:171","msg":"trace[943728736] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:596; }","duration":"255.947488ms","start":"2026-04-17T04:14:16.632027Z","end":"2026-04-17T04:14:16.887975Z","steps":["trace[943728736] 'agreement among raft nodes before linearized reading' (duration: 255.64453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:17.145004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.812864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:98713"} {"level":"info","ts":"2026-04-17T04:14:17.145085Z","caller":"traceutil/trace.go:171","msg":"trace[1122824745] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:596; }","duration":"171.922167ms","start":"2026-04-17T04:14:16.973143Z","end":"2026-04-17T04:14:17.145065Z","steps":["trace[1122824745] 'range keys from in-memory index tree' (duration: 171.513925ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:19.183319Z","caller":"traceutil/trace.go:171","msg":"trace[921127361] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:627; }","duration":"218.113723ms","start":"2026-04-17T04:14:18.965177Z","end":"2026-04-17T04:14:19.183291Z","steps":["trace[921127361] 'read index received' (duration: 51.088697ms)","trace[921127361] 'applied index is now lower than readState.Index' (duration: 167.023916ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:19.1834Z","caller":"traceutil/trace.go:171","msg":"trace[400380501] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"218.950446ms","start":"2026-04-17T04:14:18.964414Z","end":"2026-04-17T04:14:19.183365Z","steps":["trace[400380501] 'process raft request' (duration: 203.167507ms)","trace[400380501] 'compare' (duration: 15.464801ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:19.183439Z","caller":"traceutil/trace.go:171","msg":"trace[662034641] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"218.428022ms","start":"2026-04-17T04:14:18.964947Z","end":"2026-04-17T04:14:19.183375Z","steps":["trace[662034641] 'process raft request' (duration: 218.275818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:19.183541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.317888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-envoy-gateway-role\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:19.18379Z","caller":"traceutil/trace.go:171","msg":"trace[1877423190] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-envoy-gateway-role; range_end:; response_count:0; response_revision:600; }","duration":"218.580936ms","start":"2026-04-17T04:14:18.965171Z","end":"2026-04-17T04:14:19.183752Z","steps":["trace[1877423190] 'agreement among raft nodes before linearized reading' (duration: 218.243986ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:19.384329Z","caller":"traceutil/trace.go:171","msg":"trace[1684576020] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"148.131344ms","start":"2026-04-17T04:14:19.236173Z","end":"2026-04-17T04:14:19.384305Z","steps":["trace[1684576020] 'process raft request' (duration: 148.061352ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:19.385161Z","caller":"traceutil/trace.go:171","msg":"trace[23251291] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"149.142251ms","start":"2026-04-17T04:14:19.235409Z","end":"2026-04-17T04:14:19.384552Z","steps":["trace[23251291] 'process raft request' (duration: 67.771089ms)","trace[23251291] 'compare' (duration: 80.90103ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:19.988007Z","caller":"traceutil/trace.go:171","msg":"trace[1558701609] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"350.102141ms","start":"2026-04-17T04:14:19.637867Z","end":"2026-04-17T04:14:19.987969Z","steps":["trace[1558701609] 'process raft request' (duration: 349.046672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:19.988252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:19.637848Z","time spent":"350.301995ms","remote":"127.0.0.1:49658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:14:20.348402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.015459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:14:20.348535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.280407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:20.348576Z","caller":"traceutil/trace.go:171","msg":"trace[1420399123] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:604; }","duration":"297.152032ms","start":"2026-04-17T04:14:20.051342Z","end":"2026-04-17T04:14:20.348494Z","steps":["trace[1420399123] 'range keys from in-memory index tree' (duration: 296.930206ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:20.348634Z","caller":"traceutil/trace.go:171","msg":"trace[811838451] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"163.411401ms","start":"2026-04-17T04:14:20.185194Z","end":"2026-04-17T04:14:20.348605Z","steps":["trace[811838451] 'range keys from in-memory index tree' (duration: 163.181344ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:20.419175Z","caller":"traceutil/trace.go:171","msg":"trace[162626184] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"109.303623ms","start":"2026-04-17T04:14:20.309844Z","end":"2026-04-17T04:14:20.419148Z","steps":["trace[162626184] 'process raft request' (duration: 109.119298ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:20.893312Z","caller":"traceutil/trace.go:171","msg":"trace[741956748] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"235.431664ms","start":"2026-04-17T04:14:20.657851Z","end":"2026-04-17T04:14:20.893283Z","steps":["trace[741956748] 'process raft request' (duration: 235.223017ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:21.416311Z","caller":"traceutil/trace.go:171","msg":"trace[1730925603] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"395.705361ms","start":"2026-04-17T04:14:21.020573Z","end":"2026-04-17T04:14:21.416278Z","steps":["trace[1730925603] 'read index received' (duration: 394.928941ms)","trace[1730925603] 'applied index is now lower than readState.Index' (duration: 774.94µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:21.41644Z","caller":"traceutil/trace.go:171","msg":"trace[1834489670] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"653.030925ms","start":"2026-04-17T04:14:20.763375Z","end":"2026-04-17T04:14:21.416406Z","steps":["trace[1834489670] 'process raft request' (duration: 652.362048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:21.41656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.957597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T04:14:21.416621Z","caller":"traceutil/trace.go:171","msg":"trace[408916651] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"396.0709ms","start":"2026-04-17T04:14:21.020533Z","end":"2026-04-17T04:14:21.416604Z","steps":["trace[408916651] 'agreement among raft nodes before linearized reading' (duration: 395.930107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:21.416618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:20.763343Z","time spent":"653.178639ms","remote":"127.0.0.1:49658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:21.416659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:21.020517Z","time spent":"396.133142ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T04:14:21.416655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.558384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T04:14:21.416712Z","caller":"traceutil/trace.go:171","msg":"trace[761084915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"227.642217ms","start":"2026-04-17T04:14:21.189048Z","end":"2026-04-17T04:14:21.41669Z","steps":["trace[761084915] 'agreement among raft nodes before linearized reading' (duration: 227.549524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:21.416873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.717085ms","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-04-17T04:14:21.416993Z","caller":"traceutil/trace.go:171","msg":"trace[1759628751] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"228.961981ms","start":"2026-04-17T04:14:21.187995Z","end":"2026-04-17T04:14:21.416957Z","steps":["trace[1759628751] 'agreement among raft nodes before linearized reading' (duration: 228.57427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:21.861512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.183627ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:14:21.861742Z","caller":"traceutil/trace.go:171","msg":"trace[1540462650] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"391.511229ms","start":"2026-04-17T04:14:21.470215Z","end":"2026-04-17T04:14:21.861726Z","steps":["trace[1540462650] 'process raft request' (duration: 391.466568ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:21.86177Z","caller":"traceutil/trace.go:171","msg":"trace[1971716402] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"440.288435ms","start":"2026-04-17T04:14:21.421471Z","end":"2026-04-17T04:14:21.86176Z","steps":["trace[1971716402] 'process raft request' (duration: 440.132081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:21.861799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:21.470194Z","time spent":"391.581051ms","remote":"127.0.0.1:49770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T04:14:21.861813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:21.421433Z","time spent":"440.356786ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:21.861911Z","caller":"traceutil/trace.go:171","msg":"trace[1923576472] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"440.469089ms","start":"2026-04-17T04:14:21.42143Z","end":"2026-04-17T04:14:21.8619Z","steps":["trace[1923576472] 'process raft request' (duration: 108.82027ms)","trace[1923576472] 'compare' (duration: 330.831508ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:21.861936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:21.421414Z","time spent":"440.508341ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:21.861995Z","caller":"traceutil/trace.go:171","msg":"trace[1644135316] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"440.324275ms","start":"2026-04-17T04:14:21.42166Z","end":"2026-04-17T04:14:21.861984Z","steps":["trace[1644135316] 'process raft request' (duration: 439.992307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:21.862047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:21.421654Z","time spent":"440.364527ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:22.473563Z","caller":"traceutil/trace.go:171","msg":"trace[1480418426] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"140.673617ms","start":"2026-04-17T04:14:22.332809Z","end":"2026-04-17T04:14:22.473482Z","steps":["trace[1480418426] 'process raft request' (duration: 139.969458ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:27.61304Z","caller":"traceutil/trace.go:171","msg":"trace[1100394234] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"174.001632ms","start":"2026-04-17T04:14:27.439007Z","end":"2026-04-17T04:14:27.613008Z","steps":["trace[1100394234] 'read index received' (duration: 173.856128ms)","trace[1100394234] 'applied index is now lower than readState.Index' (duration: 143.984µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:27.613173Z","caller":"traceutil/trace.go:171","msg":"trace[2097094868] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"254.329075ms","start":"2026-04-17T04:14:27.358809Z","end":"2026-04-17T04:14:27.613138Z","steps":["trace[2097094868] 'process raft request' (duration: 254.012807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:27.613199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.175647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:27.61326Z","caller":"traceutil/trace.go:171","msg":"trace[2137306601] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:643; }","duration":"174.30851ms","start":"2026-04-17T04:14:27.438939Z","end":"2026-04-17T04:14:27.613248Z","steps":["trace[2137306601] 'agreement among raft nodes before linearized reading' (duration: 174.191897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:28.249476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.604239ms","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-04-17T04:14:28.249437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.882317ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:14:28.249522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.5909ms","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-04-17T04:14:28.249593Z","caller":"traceutil/trace.go:171","msg":"trace[1547082534] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"348.754583ms","start":"2026-04-17T04:14:27.900803Z","end":"2026-04-17T04:14:28.249557Z","steps":["trace[1547082534] 'range keys from in-memory index tree' (duration: 348.374984ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:28.249608Z","caller":"traceutil/trace.go:171","msg":"trace[800624357] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:643; }","duration":"541.295127ms","start":"2026-04-17T04:14:27.708292Z","end":"2026-04-17T04:14:28.249587Z","steps":["trace[800624357] 'range keys from in-memory index tree' (duration: 540.850946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:28.249476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.339619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-17T04:14:28.249648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:27.900783Z","time spent":"348.853306ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-17T04:14:28.249664Z","caller":"traceutil/trace.go:171","msg":"trace[4600220] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"345.813935ms","start":"2026-04-17T04:14:27.903816Z","end":"2026-04-17T04:14:28.24963Z","steps":["trace[4600220] 'range keys from in-memory index tree' (duration: 345.382765ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:28.24969Z","caller":"traceutil/trace.go:171","msg":"trace[8684167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"346.596886ms","start":"2026-04-17T04:14:27.903063Z","end":"2026-04-17T04:14:28.24966Z","steps":["trace[8684167] 'range keys from in-memory index tree' (duration: 346.078053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:28.249744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:27.903044Z","time spent":"346.683629ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T04:14:28.249743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:27.903807Z","time spent":"345.916608ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-17T04:14:29.679077Z","caller":"traceutil/trace.go:171","msg":"trace[617517280] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"493.429546ms","start":"2026-04-17T04:14:29.185628Z","end":"2026-04-17T04:14:29.679057Z","steps":["trace[617517280] 'read index received' (duration: 493.396865ms)","trace[617517280] 'applied index is now lower than readState.Index' (duration: 31.531µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:14:29.679204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.57474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:29.679233Z","caller":"traceutil/trace.go:171","msg":"trace[885595938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"493.675432ms","start":"2026-04-17T04:14:29.185548Z","end":"2026-04-17T04:14:29.679224Z","steps":["trace[885595938] 'agreement among raft nodes before linearized reading' (duration: 493.5944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:29.679262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:29.185508Z","time spent":"493.748704ms","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T04:14:29.679354Z","caller":"traceutil/trace.go:171","msg":"trace[1808064427] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"750.557555ms","start":"2026-04-17T04:14:28.928775Z","end":"2026-04-17T04:14:29.679333Z","steps":["trace[1808064427] 'process raft request' (duration: 750.171425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:29.679475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:28.92874Z","time spent":"750.674529ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:30.131154Z","caller":"traceutil/trace.go:171","msg":"trace[1447633388] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"450.65742ms","start":"2026-04-17T04:14:29.680477Z","end":"2026-04-17T04:14:30.131134Z","steps":["trace[1447633388] 'read index received' (duration: 450.471756ms)","trace[1447633388] 'applied index is now lower than readState.Index' (duration: 184.544µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:30.131202Z","caller":"traceutil/trace.go:171","msg":"trace[245084783] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"599.894534ms","start":"2026-04-17T04:14:29.531282Z","end":"2026-04-17T04:14:30.131177Z","steps":["trace[245084783] 'process raft request' (duration: 599.72554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:30.131303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.807424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:30.131347Z","caller":"traceutil/trace.go:171","msg":"trace[304772800] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"450.917257ms","start":"2026-04-17T04:14:29.680418Z","end":"2026-04-17T04:14:30.131335Z","steps":["trace[304772800] 'agreement among raft nodes before linearized reading' (duration: 450.828675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:30.131339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:29.53126Z","time spent":"600.003087ms","remote":"127.0.0.1:49744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4582,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:30.131375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:29.680397Z","time spent":"450.970968ms","remote":"127.0.0.1:49554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:14:30.131497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.917077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:30.131533Z","caller":"traceutil/trace.go:171","msg":"trace[255115152] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:648; }","duration":"380.995499ms","start":"2026-04-17T04:14:29.750527Z","end":"2026-04-17T04:14:30.131523Z","steps":["trace[255115152] 'agreement among raft nodes before linearized reading' (duration: 380.924237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:30.131555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:29.750505Z","time spent":"381.044801ms","remote":"127.0.0.1:49984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":26,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-17T04:14:30.131691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.532358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T04:14:30.131718Z","caller":"traceutil/trace.go:171","msg":"trace[1435255260] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:648; }","duration":"150.59075ms","start":"2026-04-17T04:14:29.981122Z","end":"2026-04-17T04:14:30.131713Z","steps":["trace[1435255260] 'agreement among raft nodes before linearized reading' (duration: 150.541599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.841404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.598233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.84152Z","caller":"traceutil/trace.go:171","msg":"trace[1851737760] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:673; }","duration":"321.772447ms","start":"2026-04-17T04:14:31.519724Z","end":"2026-04-17T04:14:31.841497Z","steps":["trace[1851737760] 'range keys from in-memory index tree' (duration: 321.48123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.841584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:31.5197Z","time spent":"321.865979ms","remote":"127.0.0.1:50134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-17T04:14:31.84146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.955776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.841757Z","caller":"traceutil/trace.go:171","msg":"trace[776404481] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:673; }","duration":"321.296145ms","start":"2026-04-17T04:14:31.520442Z","end":"2026-04-17T04:14:31.841738Z","steps":["trace[776404481] 'range keys from in-memory index tree' (duration: 320.897224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.841793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.850629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:14:31.84191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:31.520431Z","time spent":"321.434978ms","remote":"127.0.0.1:50134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-04-17T04:14:31.842087Z","caller":"traceutil/trace.go:171","msg":"trace[632992402] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:673; }","duration":"322.28772ms","start":"2026-04-17T04:14:31.519678Z","end":"2026-04-17T04:14:31.841966Z","steps":["trace[632992402] 'count revisions from in-memory index tree' (duration: 321.771137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.842187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:31.519621Z","time spent":"322.548117ms","remote":"127.0.0.1:50134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:14:31.848268Z","caller":"traceutil/trace.go:171","msg":"trace[1980539112] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"204.480801ms","start":"2026-04-17T04:14:31.643768Z","end":"2026-04-17T04:14:31.848249Z","steps":["trace[1980539112] 'read index received' (duration: 204.378339ms)","trace[1980539112] 'applied index is now lower than readState.Index' (duration: 101.492µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:31.848335Z","caller":"traceutil/trace.go:171","msg":"trace[137129864] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"290.303161ms","start":"2026-04-17T04:14:31.557987Z","end":"2026-04-17T04:14:31.848291Z","steps":["trace[137129864] 'process raft request' (duration: 290.122216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.848492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.692047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.848562Z","caller":"traceutil/trace.go:171","msg":"trace[316933566] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:674; }","duration":"204.808831ms","start":"2026-04-17T04:14:31.643737Z","end":"2026-04-17T04:14:31.848546Z","steps":["trace[316933566] 'agreement among raft nodes before linearized reading' (duration: 204.666517ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:31.853232Z","caller":"traceutil/trace.go:171","msg":"trace[1320185391] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"100.157361ms","start":"2026-04-17T04:14:31.753054Z","end":"2026-04-17T04:14:31.853211Z","steps":["trace[1320185391] 'process raft request' (duration: 99.76263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.857667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.899883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.85773Z","caller":"traceutil/trace.go:171","msg":"trace[883150960] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:677; }","duration":"105.982094ms","start":"2026-04-17T04:14:31.751733Z","end":"2026-04-17T04:14:31.857715Z","steps":["trace[883150960] 'agreement among raft nodes before linearized reading' (duration: 105.901252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.857573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.740778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.858509Z","caller":"traceutil/trace.go:171","msg":"trace[851925911] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:677; }","duration":"214.59486ms","start":"2026-04-17T04:14:31.643799Z","end":"2026-04-17T04:14:31.858394Z","steps":["trace[851925911] 'agreement among raft nodes before linearized reading' (duration: 213.691937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.858613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.717285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.858646Z","caller":"traceutil/trace.go:171","msg":"trace[277821558] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:677; }","duration":"106.765346ms","start":"2026-04-17T04:14:31.751873Z","end":"2026-04-17T04:14:31.858638Z","steps":["trace[277821558] 'agreement among raft nodes before linearized reading' (duration: 106.715954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.858827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.095375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.858869Z","caller":"traceutil/trace.go:171","msg":"trace[205475976] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:677; }","duration":"107.160156ms","start":"2026-04-17T04:14:31.751698Z","end":"2026-04-17T04:14:31.858858Z","steps":["trace[205475976] 'agreement among raft nodes before linearized reading' (duration: 107.081724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.859122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.590296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.859168Z","caller":"traceutil/trace.go:171","msg":"trace[753558925] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:677; }","duration":"122.646847ms","start":"2026-04-17T04:14:31.736502Z","end":"2026-04-17T04:14:31.859149Z","steps":["trace[753558925] 'agreement among raft nodes before linearized reading' (duration: 122.589596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.859429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.009484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.859472Z","caller":"traceutil/trace.go:171","msg":"trace[1794008020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:678; }","duration":"124.079945ms","start":"2026-04-17T04:14:31.735382Z","end":"2026-04-17T04:14:31.859462Z","steps":["trace[1794008020] 'agreement among raft nodes before linearized reading' (duration: 123.967752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.859672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.327312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.859726Z","caller":"traceutil/trace.go:171","msg":"trace[1760839130] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:678; }","duration":"124.376013ms","start":"2026-04-17T04:14:31.735333Z","end":"2026-04-17T04:14:31.859709Z","steps":["trace[1760839130] 'agreement among raft nodes before linearized reading' (duration: 124.306252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.859774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.2711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.859815Z","caller":"traceutil/trace.go:171","msg":"trace[506334426] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:678; }","duration":"168.401514ms","start":"2026-04-17T04:14:31.691404Z","end":"2026-04-17T04:14:31.859806Z","steps":["trace[506334426] 'agreement among raft nodes before linearized reading' (duration: 168.332972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.859959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.156167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.859988Z","caller":"traceutil/trace.go:171","msg":"trace[2069718696] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:678; }","duration":"168.186257ms","start":"2026-04-17T04:14:31.691794Z","end":"2026-04-17T04:14:31.85998Z","steps":["trace[2069718696] 'agreement among raft nodes before linearized reading' (duration: 168.138196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.859984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.239157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.860034Z","caller":"traceutil/trace.go:171","msg":"trace[1649413061] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:678; }","duration":"215.313719ms","start":"2026-04-17T04:14:31.644698Z","end":"2026-04-17T04:14:31.860012Z","steps":["trace[1649413061] 'agreement among raft nodes before linearized reading' (duration: 215.254238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.860094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.382432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.860121Z","caller":"traceutil/trace.go:171","msg":"trace[479041577] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:678; }","duration":"168.439444ms","start":"2026-04-17T04:14:31.691675Z","end":"2026-04-17T04:14:31.860114Z","steps":["trace[479041577] 'agreement among raft nodes before linearized reading' (duration: 168.392993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.859955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.854416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:14:31.860458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.99162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:14:31.860685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.33794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:31.86069Z","caller":"traceutil/trace.go:171","msg":"trace[795163866] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:678; }","duration":"192.237176ms","start":"2026-04-17T04:14:31.668446Z","end":"2026-04-17T04:14:31.860683Z","steps":["trace[795163866] 'agreement among raft nodes before linearized reading' (duration: 191.98556ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:31.860711Z","caller":"traceutil/trace.go:171","msg":"trace[719604795] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:678; }","duration":"192.625196ms","start":"2026-04-17T04:14:31.668076Z","end":"2026-04-17T04:14:31.860702Z","steps":["trace[719604795] 'agreement among raft nodes before linearized reading' (duration: 192.38546ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:31.860817Z","caller":"traceutil/trace.go:171","msg":"trace[230102522] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:678; }","duration":"192.820902ms","start":"2026-04-17T04:14:31.667963Z","end":"2026-04-17T04:14:31.860784Z","steps":["trace[230102522] 'agreement among raft nodes before linearized reading' (duration: 191.729053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:31.860845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.302872ms","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-04-17T04:14:31.860872Z","caller":"traceutil/trace.go:171","msg":"trace[227139844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:678; }","duration":"176.355954ms","start":"2026-04-17T04:14:31.684509Z","end":"2026-04-17T04:14:31.860865Z","steps":["trace[227139844] 'agreement among raft nodes before linearized reading' (duration: 176.251261ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:43.957087Z","caller":"traceutil/trace.go:171","msg":"trace[829754467] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"459.759932ms","start":"2026-04-17T04:14:43.497296Z","end":"2026-04-17T04:14:43.957056Z","steps":["trace[829754467] 'process raft request' (duration: 459.260709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:43.957278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:43.497276Z","time spent":"459.912926ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:48.487136Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880323674223600,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T04:14:48.63868Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.3139411s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T04:14:48.639848Z","caller":"traceutil/trace.go:171","msg":"trace[670042038] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"1.315255225s","start":"2026-04-17T04:14:47.32455Z","end":"2026-04-17T04:14:48.639805Z","steps":["trace[670042038] 'process raft request' (duration: 1.314375742s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:48.640066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:47.324501Z","time spent":"1.31544813s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:14:48.650551Z","caller":"traceutil/trace.go:171","msg":"trace[783369412] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:846; }","duration":"663.996578ms","start":"2026-04-17T04:14:47.986532Z","end":"2026-04-17T04:14:48.650528Z","steps":["trace[783369412] 'read index received' (duration: 652.424321ms)","trace[783369412] 'applied index is now lower than readState.Index' (duration: 11.571367ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:14:48.650623Z","caller":"traceutil/trace.go:171","msg":"trace[32343589] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"1.157125315s","start":"2026-04-17T04:14:47.493466Z","end":"2026-04-17T04:14:48.650592Z","steps":["trace[32343589] 'process raft request' (duration: 1.156923049s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:48.650775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:47.493446Z","time spent":"1.157249418s","remote":"127.0.0.1:49808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:14:48.65081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.256366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-17T04:14:48.650873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.015922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T04:14:48.650901Z","caller":"traceutil/trace.go:171","msg":"trace[390618789] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:811; }","duration":"229.075324ms","start":"2026-04-17T04:14:48.421814Z","end":"2026-04-17T04:14:48.650889Z","steps":["trace[390618789] 'agreement among raft nodes before linearized reading' (duration: 228.993332ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:48.650886Z","caller":"traceutil/trace.go:171","msg":"trace[498974473] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:811; }","duration":"664.382108ms","start":"2026-04-17T04:14:47.986489Z","end":"2026-04-17T04:14:48.650871Z","steps":["trace[498974473] 'agreement among raft nodes before linearized reading' (duration: 664.129602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:48.650942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:47.986467Z","time spent":"664.467691ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-17T04:14:48.650987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.800606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T04:14:48.651073Z","caller":"traceutil/trace.go:171","msg":"trace[1278665386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:811; }","duration":"237.94241ms","start":"2026-04-17T04:14:48.413111Z","end":"2026-04-17T04:14:48.651053Z","steps":["trace[1278665386] 'agreement among raft nodes before linearized reading' (duration: 237.740655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:48.651131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.31038ms","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-04-17T04:14:48.651206Z","caller":"traceutil/trace.go:171","msg":"trace[1637407500] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:811; }","duration":"229.423563ms","start":"2026-04-17T04:14:48.421775Z","end":"2026-04-17T04:14:48.651199Z","steps":["trace[1637407500] 'agreement among raft nodes before linearized reading' (duration: 229.302299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:48.651219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.428572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:14:48.651248Z","caller":"traceutil/trace.go:171","msg":"trace[1044687530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"468.536245ms","start":"2026-04-17T04:14:48.182705Z","end":"2026-04-17T04:14:48.651241Z","steps":["trace[1044687530] 'agreement among raft nodes before linearized reading' (duration: 468.430222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:48.650784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.119136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-17T04:14:48.651285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:48.182688Z","time spent":"468.592927ms","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-17T04:14:48.651294Z","caller":"traceutil/trace.go:171","msg":"trace[1813634842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"654.683482ms","start":"2026-04-17T04:14:47.996603Z","end":"2026-04-17T04:14:48.651286Z","steps":["trace[1813634842] 'agreement among raft nodes before linearized reading' (duration: 654.062675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:48.651316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:47.996587Z","time spent":"654.721642ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T04:14:52.649321Z","caller":"traceutil/trace.go:171","msg":"trace[937578007] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"126.402177ms","start":"2026-04-17T04:14:52.522891Z","end":"2026-04-17T04:14:52.649293Z","steps":["trace[937578007] 'process raft request' (duration: 126.236962ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:57.269699Z","caller":"traceutil/trace.go:171","msg":"trace[2025578689] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"226.144107ms","start":"2026-04-17T04:14:57.043535Z","end":"2026-04-17T04:14:57.269679Z","steps":["trace[2025578689] 'process raft request' (duration: 225.793017ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:14:58.41977Z","caller":"traceutil/trace.go:171","msg":"trace[44331012] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"302.820564ms","start":"2026-04-17T04:14:58.116927Z","end":"2026-04-17T04:14:58.419748Z","steps":["trace[44331012] 'process raft request' (duration: 302.667449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:14:58.419913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:58.116907Z","time spent":"302.942717ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":802,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T04:14:59.750822Z","caller":"traceutil/trace.go:171","msg":"trace[1452295678] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"165.796834ms","start":"2026-04-17T04:14:59.585005Z","end":"2026-04-17T04:14:59.750802Z","steps":["trace[1452295678] 'process raft request' (duration: 165.62191ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:15:00.202847Z","caller":"traceutil/trace.go:171","msg":"trace[952971435] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"440.139307ms","start":"2026-04-17T04:14:59.762668Z","end":"2026-04-17T04:15:00.202808Z","steps":["trace[952971435] 'process raft request' (duration: 439.84458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:00.203092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:59.762648Z","time spent":"440.319602ms","remote":"127.0.0.1:49846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1449,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:15:00.434744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.075289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:15:00.435157Z","caller":"traceutil/trace.go:171","msg":"trace[2101860520] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:949; }","duration":"585.869368ms","start":"2026-04-17T04:14:59.849274Z","end":"2026-04-17T04:15:00.435143Z","steps":["trace[2101860520] 'read index received' (duration: 353.292791ms)","trace[2101860520] 'applied index is now lower than readState.Index' (duration: 232.575367ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:15:00.435235Z","caller":"traceutil/trace.go:171","msg":"trace[2008572677] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"672.379026ms","start":"2026-04-17T04:14:59.762847Z","end":"2026-04-17T04:15:00.435226Z","steps":["trace[2008572677] 'process raft request' (duration: 535.601529ms)","trace[2008572677] 'compare' (duration: 135.704821ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:15:00.435287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:59.762826Z","time spent":"672.431089ms","remote":"127.0.0.1:49730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:15:00.43552Z","caller":"traceutil/trace.go:171","msg":"trace[750100937] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"666.322215ms","start":"2026-04-17T04:14:59.769189Z","end":"2026-04-17T04:15:00.435511Z","steps":["trace[750100937] 'process raft request' (duration: 665.846992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:00.435567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:59.769164Z","time spent":"666.380406ms","remote":"127.0.0.1:49750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4893,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:15:00.435693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.047525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:15:00.435725Z","caller":"traceutil/trace.go:171","msg":"trace[2055676160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:914; }","duration":"252.131667ms","start":"2026-04-17T04:15:00.183585Z","end":"2026-04-17T04:15:00.435716Z","steps":["trace[2055676160] 'agreement among raft nodes before linearized reading' (duration: 252.084326ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:15:00.435897Z","caller":"traceutil/trace.go:171","msg":"trace[965161203] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"491.429134ms","start":"2026-04-17T04:14:59.94446Z","end":"2026-04-17T04:15:00.435889Z","steps":["trace[965161203] 'process raft request' (duration: 490.641344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:00.435944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:59.944441Z","time spent":"491.478184ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:15:00.436095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.781081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T04:15:00.436122Z","caller":"traceutil/trace.go:171","msg":"trace[1574645602] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:914; }","duration":"586.880125ms","start":"2026-04-17T04:14:59.849236Z","end":"2026-04-17T04:15:00.436116Z","steps":["trace[1574645602] 'agreement among raft nodes before linearized reading' (duration: 586.797923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:00.436142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:14:59.849217Z","time spent":"586.918876ms","remote":"127.0.0.1:49940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":28,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:15:25.138756Z","caller":"traceutil/trace.go:171","msg":"trace[1154940969] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1072; }","duration":"269.798839ms","start":"2026-04-17T04:15:24.868925Z","end":"2026-04-17T04:15:25.138723Z","steps":["trace[1154940969] 'read index received' (duration: 269.636846ms)","trace[1154940969] 'applied index is now lower than readState.Index' (duration: 160.803µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:15:25.138925Z","caller":"traceutil/trace.go:171","msg":"trace[1574430064] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"305.389762ms","start":"2026-04-17T04:15:24.833524Z","end":"2026-04-17T04:15:25.138914Z","steps":["trace[1574430064] 'process raft request' (duration: 305.011132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:25.139033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:24.833494Z","time spent":"305.461615ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:15:25.13921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.290792ms","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-04-17T04:15:25.139284Z","caller":"traceutil/trace.go:171","msg":"trace[118532988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1028; }","duration":"262.406635ms","start":"2026-04-17T04:15:24.87686Z","end":"2026-04-17T04:15:25.139267Z","steps":["trace[118532988] 'agreement among raft nodes before linearized reading' (duration: 262.245201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:25.139408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.493667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T04:15:25.139433Z","caller":"traceutil/trace.go:171","msg":"trace[1648234647] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1028; }","duration":"270.547349ms","start":"2026-04-17T04:15:24.868877Z","end":"2026-04-17T04:15:25.139424Z","steps":["trace[1648234647] 'agreement among raft nodes before linearized reading' (duration: 270.492238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:25.139589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.840618ms","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-04-17T04:15:25.139652Z","caller":"traceutil/trace.go:171","msg":"trace[1913279298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1028; }","duration":"207.93216ms","start":"2026-04-17T04:15:24.931696Z","end":"2026-04-17T04:15:25.139628Z","steps":["trace[1913279298] 'agreement among raft nodes before linearized reading' (duration: 207.782786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:25.139698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.484272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T04:15:25.139741Z","caller":"traceutil/trace.go:171","msg":"trace[1890498514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1028; }","duration":"261.528623ms","start":"2026-04-17T04:15:24.8782Z","end":"2026-04-17T04:15:25.139728Z","steps":["trace[1890498514] 'agreement among raft nodes before linearized reading' (duration: 261.354029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:26.186146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.090714ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:15:26.18625Z","caller":"traceutil/trace.go:171","msg":"trace[2027061322] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"1.04408343s","start":"2026-04-17T04:15:25.142146Z","end":"2026-04-17T04:15:26.18623Z","steps":["trace[2027061322] 'process raft request' (duration: 449.828011ms)","trace[2027061322] 'compare' (duration: 593.799948ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:15:26.186327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:25.142126Z","time spent":"1.044177952s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:15:26.215155Z","caller":"traceutil/trace.go:171","msg":"trace[2125903748] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1073; }","duration":"1.030591061s","start":"2026-04-17T04:15:25.184539Z","end":"2026-04-17T04:15:26.21513Z","steps":["trace[2125903748] 'read index received' (duration: 407.448928ms)","trace[2125903748] 'applied index is now lower than readState.Index' (duration: 623.141153ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:15:26.215659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031110375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:15:26.215724Z","caller":"traceutil/trace.go:171","msg":"trace[1435290873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1032; }","duration":"1.031205977s","start":"2026-04-17T04:15:25.184494Z","end":"2026-04-17T04:15:26.2157Z","steps":["trace[1435290873] 'agreement among raft nodes before linearized reading' (duration: 1.031114605s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:26.215767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:25.184476Z","time spent":"1.031282759s","remote":"127.0.0.1:49566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T04:15:26.215787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.036197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T04:15:26.215865Z","caller":"traceutil/trace.go:171","msg":"trace[430289697] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1032; }","duration":"379.16196ms","start":"2026-04-17T04:15:25.836685Z","end":"2026-04-17T04:15:26.215847Z","steps":["trace[430289697] 'agreement among raft nodes before linearized reading' (duration: 379.014457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:26.215922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:25.836664Z","time spent":"379.248263ms","remote":"127.0.0.1:49964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":28,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:15:26.216005Z","caller":"traceutil/trace.go:171","msg":"trace[1535149595] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"1.072765728s","start":"2026-04-17T04:15:25.143227Z","end":"2026-04-17T04:15:26.215993Z","steps":["trace[1535149595] 'process raft request' (duration: 1.07163185s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:26.216101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:25.143205Z","time spent":"1.07282788s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:15:26.21619Z","caller":"traceutil/trace.go:171","msg":"trace[1096826294] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"1.072802139s","start":"2026-04-17T04:15:25.143379Z","end":"2026-04-17T04:15:26.216181Z","steps":["trace[1096826294] 'process raft request' (duration: 1.07160515s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:26.216245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:25.143357Z","time spent":"1.072861951s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:15:26.216374Z","caller":"traceutil/trace.go:171","msg":"trace[1771278281] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"1.071837016s","start":"2026-04-17T04:15:25.144528Z","end":"2026-04-17T04:15:26.216365Z","steps":["trace[1771278281] 'process raft request' (duration: 1.070515382s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:26.216413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.527791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-17T04:15:26.216435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:25.144519Z","time spent":"1.071877576s","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T04:15:26.216464Z","caller":"traceutil/trace.go:171","msg":"trace[224759089] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:1032; }","duration":"144.625454ms","start":"2026-04-17T04:15:26.071823Z","end":"2026-04-17T04:15:26.216448Z","steps":["trace[224759089] 'agreement among raft nodes before linearized reading' (duration: 144.46618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:48.825871Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880323674224263,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-17T04:15:48.915063Z","caller":"traceutil/trace.go:171","msg":"trace[565818089] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"640.777014ms","start":"2026-04-17T04:15:48.274257Z","end":"2026-04-17T04:15:48.915034Z","steps":["trace[565818089] 'process raft request' (duration: 640.5884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:48.915229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:48.27424Z","time spent":"640.914678ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:15:49.312832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.454441ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:15:49.313Z","caller":"traceutil/trace.go:171","msg":"trace[1617883597] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1151; }","duration":"987.875481ms","start":"2026-04-17T04:15:48.325101Z","end":"2026-04-17T04:15:49.312977Z","steps":["trace[1617883597] 'read index received' (duration: 589.695445ms)","trace[1617883597] 'applied index is now lower than readState.Index' (duration: 398.178286ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:15:49.313109Z","caller":"traceutil/trace.go:171","msg":"trace[771687465] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"627.692138ms","start":"2026-04-17T04:15:48.685386Z","end":"2026-04-17T04:15:49.313078Z","steps":["trace[771687465] 'process raft request' (duration: 349.883977ms)","trace[771687465] 'compare' (duration: 277.310268ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:15:49.313211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.110849ms","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-04-17T04:15:49.313517Z","caller":"traceutil/trace.go:171","msg":"trace[95647823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1103; }","duration":"988.447436ms","start":"2026-04-17T04:15:48.325058Z","end":"2026-04-17T04:15:49.313506Z","steps":["trace[95647823] 'agreement among raft nodes before linearized reading' (duration: 988.028946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:49.313286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.553621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:15:49.313623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:48.325019Z","time spent":"988.593559ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-17T04:15:49.31359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.167749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T04:15:49.313672Z","caller":"traceutil/trace.go:171","msg":"trace[1614432720] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1103; }","duration":"478.984321ms","start":"2026-04-17T04:15:48.834662Z","end":"2026-04-17T04:15:49.313646Z","steps":["trace[1614432720] 'agreement among raft nodes before linearized reading' (duration: 478.555021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:49.313304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:48.685366Z","time spent":"627.827971ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:15:49.313734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:48.834641Z","time spent":"479.072994ms","remote":"127.0.0.1:50098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-17T04:15:49.31376Z","caller":"traceutil/trace.go:171","msg":"trace[397952718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1103; }","duration":"988.394375ms","start":"2026-04-17T04:15:48.325312Z","end":"2026-04-17T04:15:49.313707Z","steps":["trace[397952718] 'agreement among raft nodes before linearized reading' (duration: 987.926833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:49.313316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.610118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T04:15:49.313854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:48.325292Z","time spent":"988.548739ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-17T04:15:49.313882Z","caller":"traceutil/trace.go:171","msg":"trace[1802725466] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1103; }","duration":"759.231083ms","start":"2026-04-17T04:15:48.554638Z","end":"2026-04-17T04:15:49.313869Z","steps":["trace[1802725466] 'agreement among raft nodes before linearized reading' (duration: 758.592857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:49.314048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:48.554619Z","time spent":"759.411867ms","remote":"127.0.0.1:43284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":26,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-17T04:15:49.313443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.64091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T04:15:49.31411Z","caller":"traceutil/trace.go:171","msg":"trace[2124394354] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1103; }","duration":"985.369109ms","start":"2026-04-17T04:15:48.328726Z","end":"2026-04-17T04:15:49.314095Z","steps":["trace[2124394354] 'agreement among raft nodes before linearized reading' (duration: 984.548628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:49.314185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:15:48.328716Z","time spent":"985.45243ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-17T04:15:49.313354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.136565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:15:49.314352Z","caller":"traceutil/trace.go:171","msg":"trace[785721075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1103; }","duration":"130.16892ms","start":"2026-04-17T04:15:49.184169Z","end":"2026-04-17T04:15:49.314338Z","steps":["trace[785721075] 'agreement among raft nodes before linearized reading' (duration: 129.162316ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:15:50.46143Z","caller":"traceutil/trace.go:171","msg":"trace[97473677] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"120.671763ms","start":"2026-04-17T04:15:50.34074Z","end":"2026-04-17T04:15:50.461411Z","steps":["trace[97473677] 'process raft request' (duration: 120.54031ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:15:51.502657Z","caller":"traceutil/trace.go:171","msg":"trace[769211284] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"184.507832ms","start":"2026-04-17T04:15:51.318128Z","end":"2026-04-17T04:15:51.502636Z","steps":["trace[769211284] 'process raft request' (duration: 184.378059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:51.502999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.644051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-17T04:15:51.50303Z","caller":"traceutil/trace.go:171","msg":"trace[219966502] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1110; }","duration":"159.721341ms","start":"2026-04-17T04:15:51.343301Z","end":"2026-04-17T04:15:51.503023Z","steps":["trace[219966502] 'agreement among raft nodes before linearized reading' (duration: 159.616379ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:15:51.503096Z","caller":"traceutil/trace.go:171","msg":"trace[539865379] linearizableReadLoop","detail":"{readStateIndex:1160; appliedIndex:1159; }","duration":"159.738002ms","start":"2026-04-17T04:15:51.34335Z","end":"2026-04-17T04:15:51.503088Z","steps":["trace[539865379] 'read index received' (duration: 159.139977ms)","trace[539865379] 'applied index is now lower than readState.Index' (duration: 118.463µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:15:51.606745Z","caller":"traceutil/trace.go:171","msg":"trace[1571701694] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"103.598615ms","start":"2026-04-17T04:15:51.503112Z","end":"2026-04-17T04:15:51.606711Z","steps":["trace[1571701694] 'read index received' (duration: 8.782679ms)","trace[1571701694] 'applied index is now lower than readState.Index' (duration: 94.809786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:15:51.60705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.029526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-17T04:15:51.607042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.661581ms","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-04-17T04:15:51.6071Z","caller":"traceutil/trace.go:171","msg":"trace[13368181] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1111; }","duration":"254.112267ms","start":"2026-04-17T04:15:51.352974Z","end":"2026-04-17T04:15:51.607086Z","steps":["trace[13368181] 'agreement among raft nodes before linearized reading' (duration: 253.895522ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:15:51.607123Z","caller":"traceutil/trace.go:171","msg":"trace[1524914619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1111; }","duration":"254.779803ms","start":"2026-04-17T04:15:51.352322Z","end":"2026-04-17T04:15:51.607102Z","steps":["trace[1524914619] 'agreement among raft nodes before linearized reading' (duration: 254.577009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:15:51.60723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.362534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T04:15:51.607272Z","caller":"traceutil/trace.go:171","msg":"trace[1392546561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1111; }","duration":"254.422285ms","start":"2026-04-17T04:15:51.35284Z","end":"2026-04-17T04:15:51.607262Z","steps":["trace[1392546561] 'agreement among raft nodes before linearized reading' (duration: 254.319802ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:15:51.81354Z","caller":"traceutil/trace.go:171","msg":"trace[75533670] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"201.637702ms","start":"2026-04-17T04:15:51.611873Z","end":"2026-04-17T04:15:51.81351Z","steps":["trace[75533670] 'process raft request' (duration: 201.55897ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:15:51.813733Z","caller":"traceutil/trace.go:171","msg":"trace[268277205] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"202.264457ms","start":"2026-04-17T04:15:51.611444Z","end":"2026-04-17T04:15:51.813709Z","steps":["trace[268277205] 'process raft request' (duration: 193.59181ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:03.774613Z","caller":"traceutil/trace.go:171","msg":"trace[1732666020] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"115.557663ms","start":"2026-04-17T04:16:03.659018Z","end":"2026-04-17T04:16:03.774576Z","steps":["trace[1732666020] 'process raft request' (duration: 115.356808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:25.383711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.233979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T04:16:25.383813Z","caller":"traceutil/trace.go:171","msg":"trace[285985496] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1301; }","duration":"106.343142ms","start":"2026-04-17T04:16:25.277433Z","end":"2026-04-17T04:16:25.383776Z","steps":["trace[285985496] 'count revisions from in-memory index tree' (duration: 106.148717ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:25.796538Z","caller":"traceutil/trace.go:171","msg":"trace[1080999697] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"112.063341ms","start":"2026-04-17T04:16:25.684449Z","end":"2026-04-17T04:16:25.796512Z","steps":["trace[1080999697] 'process raft request' (duration: 111.928628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:26.007023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.241151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:16:26.007113Z","caller":"traceutil/trace.go:171","msg":"trace[410231095] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1303; }","duration":"153.386466ms","start":"2026-04-17T04:16:25.853705Z","end":"2026-04-17T04:16:26.007091Z","steps":["trace[410231095] 'count revisions from in-memory index tree' (duration: 153.1662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:26.007428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.215931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T04:16:26.007601Z","caller":"traceutil/trace.go:171","msg":"trace[1834570571] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1303; }","duration":"145.450087ms","start":"2026-04-17T04:16:25.862125Z","end":"2026-04-17T04:16:26.007575Z","steps":["trace[1834570571] 'range keys from in-memory index tree' (duration: 144.769529ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:26.007743Z","caller":"traceutil/trace.go:171","msg":"trace[688819642] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"111.215029ms","start":"2026-04-17T04:16:25.89651Z","end":"2026-04-17T04:16:26.007725Z","steps":["trace[688819642] 'read index received' (duration: 92.835545ms)","trace[688819642] 'applied index is now lower than readState.Index' (duration: 18.378454ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:16:26.007844Z","caller":"traceutil/trace.go:171","msg":"trace[96453639] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"127.904478ms","start":"2026-04-17T04:16:25.879896Z","end":"2026-04-17T04:16:26.007801Z","steps":["trace[96453639] 'process raft request' (duration: 109.450053ms)","trace[96453639] 'compare' (duration: 18.257139ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:16:26.008542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.677051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T04:16:26.008757Z","caller":"traceutil/trace.go:171","msg":"trace[1190473703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1304; }","duration":"112.110392ms","start":"2026-04-17T04:16:25.89648Z","end":"2026-04-17T04:16:26.00859Z","steps":["trace[1190473703] 'agreement among raft nodes before linearized reading' (duration: 111.359523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:26.330575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.125953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:16:26.330733Z","caller":"traceutil/trace.go:171","msg":"trace[1921155970] linearizableReadLoop","detail":"{readStateIndex:1366; appliedIndex:1364; }","duration":"256.189024ms","start":"2026-04-17T04:16:26.074529Z","end":"2026-04-17T04:16:26.330718Z","steps":["trace[1921155970] 'read index received' (duration: 127.798244ms)","trace[1921155970] 'applied index is now lower than readState.Index' (duration: 128.38992ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:16:26.330749Z","caller":"traceutil/trace.go:171","msg":"trace[1753712338] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"312.321788ms","start":"2026-04-17T04:16:26.018412Z","end":"2026-04-17T04:16:26.330734Z","steps":["trace[1753712338] 'process raft request' (duration: 183.964349ms)","trace[1753712338] 'compare' (duration: 127.987769ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:16:26.330746Z","caller":"traceutil/trace.go:171","msg":"trace[1023600415] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"286.580932ms","start":"2026-04-17T04:16:26.044153Z","end":"2026-04-17T04:16:26.330734Z","steps":["trace[1023600415] 'process raft request' (duration: 286.51555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:26.330811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:16:26.018386Z","time spent":"312.39761ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:16:26.330902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.377839ms","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-04-17T04:16:26.330935Z","caller":"traceutil/trace.go:171","msg":"trace[1950553306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1307; }","duration":"256.442801ms","start":"2026-04-17T04:16:26.074483Z","end":"2026-04-17T04:16:26.330926Z","steps":["trace[1950553306] 'agreement among raft nodes before linearized reading' (duration: 256.319637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:26.331065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.007363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T04:16:26.331094Z","caller":"traceutil/trace.go:171","msg":"trace[1707601325] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:1307; }","duration":"255.068915ms","start":"2026-04-17T04:16:26.076018Z","end":"2026-04-17T04:16:26.331086Z","steps":["trace[1707601325] 'agreement among raft nodes before linearized reading' (duration: 254.996933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:26.331138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.581555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:16:26.331165Z","caller":"traceutil/trace.go:171","msg":"trace[786819788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1307; }","duration":"136.641846ms","start":"2026-04-17T04:16:26.194516Z","end":"2026-04-17T04:16:26.331158Z","steps":["trace[786819788] 'agreement among raft nodes before linearized reading' (duration: 136.601935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:26.331273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.810908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T04:16:26.331305Z","caller":"traceutil/trace.go:171","msg":"trace[869492126] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1307; }","duration":"241.863199ms","start":"2026-04-17T04:16:26.089434Z","end":"2026-04-17T04:16:26.331297Z","steps":["trace[869492126] 'agreement among raft nodes before linearized reading' (duration: 241.787697ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:26.985909Z","caller":"traceutil/trace.go:171","msg":"trace[1094208385] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"109.702469ms","start":"2026-04-17T04:16:26.876178Z","end":"2026-04-17T04:16:26.98588Z","steps":["trace[1094208385] 'process raft request' (duration: 109.555415ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:27.02106Z","caller":"traceutil/trace.go:171","msg":"trace[1751366106] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"134.775858ms","start":"2026-04-17T04:16:26.886271Z","end":"2026-04-17T04:16:27.021046Z","steps":["trace[1751366106] 'process raft request' (duration: 134.463889ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:27.021193Z","caller":"traceutil/trace.go:171","msg":"trace[871030190] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"142.564773ms","start":"2026-04-17T04:16:26.878622Z","end":"2026-04-17T04:16:27.021187Z","steps":["trace[871030190] 'process raft request' (duration: 119.441256ms)","trace[871030190] 'compare' (duration: 22.589042ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:16:29.468805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.550289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:16:29.469044Z","caller":"traceutil/trace.go:171","msg":"trace[69193103] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1409; }","duration":"130.573358ms","start":"2026-04-17T04:16:29.338452Z","end":"2026-04-17T04:16:29.469025Z","steps":["trace[69193103] 'read index received' (duration: 74.112µs)","trace[69193103] 'applied index is now lower than readState.Index' (duration: 130.497286ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:16:29.469072Z","caller":"traceutil/trace.go:171","msg":"trace[783934606] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"224.808912ms","start":"2026-04-17T04:16:29.244234Z","end":"2026-04-17T04:16:29.469043Z","steps":["trace[783934606] 'process raft request' (duration: 40.940475ms)","trace[783934606] 'compare' (duration: 183.424095ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:16:29.469243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.782403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:16:29.4693Z","caller":"traceutil/trace.go:171","msg":"trace[620995109] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1350; }","duration":"130.845165ms","start":"2026-04-17T04:16:29.338443Z","end":"2026-04-17T04:16:29.469288Z","steps":["trace[620995109] 'agreement among raft nodes before linearized reading' (duration: 130.701931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:35.632134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.97338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-04-17T04:16:35.632241Z","caller":"traceutil/trace.go:171","msg":"trace[1537925504] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1379; }","duration":"122.135456ms","start":"2026-04-17T04:16:35.510078Z","end":"2026-04-17T04:16:35.632213Z","steps":["trace[1537925504] 'range keys from in-memory index tree' (duration: 121.762475ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:35.897639Z","caller":"traceutil/trace.go:171","msg":"trace[251397455] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"240.41987ms","start":"2026-04-17T04:16:35.65719Z","end":"2026-04-17T04:16:35.897609Z","steps":["trace[251397455] 'process raft request' (duration: 196.59081ms)","trace[251397455] 'compare' (duration: 43.659836ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:16:35.927782Z","caller":"traceutil/trace.go:171","msg":"trace[1512090780] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"101.097354ms","start":"2026-04-17T04:16:35.82666Z","end":"2026-04-17T04:16:35.927758Z","steps":["trace[1512090780] 'process raft request' (duration: 100.97154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:36.211994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.585744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T04:16:36.212152Z","caller":"traceutil/trace.go:171","msg":"trace[964358734] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1382; }","duration":"115.773058ms","start":"2026-04-17T04:16:36.096359Z","end":"2026-04-17T04:16:36.212132Z","steps":["trace[964358734] 'count revisions from in-memory index tree' (duration: 115.551663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:36.212009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.200159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-17T04:16:36.212313Z","caller":"traceutil/trace.go:171","msg":"trace[1214047774] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:1382; }","duration":"135.533107ms","start":"2026-04-17T04:16:36.076756Z","end":"2026-04-17T04:16:36.212289Z","steps":["trace[1214047774] 'range keys from in-memory index tree' (duration: 135.033845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:16:36.21209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.717361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-17T04:16:36.212548Z","caller":"traceutil/trace.go:171","msg":"trace[529548453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1382; }","duration":"128.181844ms","start":"2026-04-17T04:16:36.084355Z","end":"2026-04-17T04:16:36.212537Z","steps":["trace[529548453] 'range keys from in-memory index tree' (duration: 127.66207ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:36.380169Z","caller":"traceutil/trace.go:171","msg":"trace[717451628] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"163.575183ms","start":"2026-04-17T04:16:36.216573Z","end":"2026-04-17T04:16:36.380148Z","steps":["trace[717451628] 'process raft request' (duration: 160.288467ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:16:36.380614Z","caller":"traceutil/trace.go:171","msg":"trace[779221691] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"123.193844ms","start":"2026-04-17T04:16:36.257408Z","end":"2026-04-17T04:16:36.380602Z","steps":["trace[779221691] 'process raft request' (duration: 122.67656ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:17:26.883448Z","caller":"traceutil/trace.go:171","msg":"trace[468851712] linearizableReadLoop","detail":"{readStateIndex:1712; appliedIndex:1710; }","duration":"251.01686ms","start":"2026-04-17T04:17:26.632401Z","end":"2026-04-17T04:17:26.883418Z","steps":["trace[468851712] 'read index received' (duration: 54.610689ms)","trace[468851712] 'applied index is now lower than readState.Index' (duration: 196.405151ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:17:26.883496Z","caller":"traceutil/trace.go:171","msg":"trace[821178333] transaction","detail":"{read_only:false; response_revision:1640; number_of_response:1; }","duration":"259.725558ms","start":"2026-04-17T04:17:26.62374Z","end":"2026-04-17T04:17:26.883465Z","steps":["trace[821178333] 'process raft request' (duration: 177.712082ms)","trace[821178333] 'compare' (duration: 81.848252ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:17:26.883736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.308168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-17T04:17:26.883786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.270198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T04:17:26.883816Z","caller":"traceutil/trace.go:171","msg":"trace[451546088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1640; }","duration":"251.397921ms","start":"2026-04-17T04:17:26.632382Z","end":"2026-04-17T04:17:26.88378Z","steps":["trace[451546088] 'agreement among raft nodes before linearized reading' (duration: 251.213295ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:17:26.883865Z","caller":"traceutil/trace.go:171","msg":"trace[75669839] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1640; }","duration":"248.389122ms","start":"2026-04-17T04:17:26.635459Z","end":"2026-04-17T04:17:26.883848Z","steps":["trace[75669839] 'agreement among raft nodes before linearized reading' (duration: 248.185946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:17:34.935668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.415173ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:17:34.935876Z","caller":"traceutil/trace.go:171","msg":"trace[1879803435] transaction","detail":"{read_only:false; response_revision:1681; number_of_response:1; }","duration":"215.315656ms","start":"2026-04-17T04:17:34.720485Z","end":"2026-04-17T04:17:34.935801Z","steps":["trace[1879803435] 'process raft request' (duration: 89.702568ms)","trace[1879803435] 'compare' (duration: 125.3378ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:17:37.062395Z","caller":"traceutil/trace.go:171","msg":"trace[747318270] transaction","detail":"{read_only:false; response_revision:1691; number_of_response:1; }","duration":"112.38306ms","start":"2026-04-17T04:17:36.949973Z","end":"2026-04-17T04:17:37.062356Z","steps":["trace[747318270] 'process raft request' (duration: 109.364522ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:17:51.4524Z","caller":"traceutil/trace.go:171","msg":"trace[103290241] linearizableReadLoop","detail":"{readStateIndex:1840; appliedIndex:1839; }","duration":"153.300722ms","start":"2026-04-17T04:17:51.299081Z","end":"2026-04-17T04:17:51.452381Z","steps":["trace[103290241] 'read index received' (duration: 66.453639ms)","trace[103290241] 'applied index is now lower than readState.Index' (duration: 86.846073ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:17:51.452415Z","caller":"traceutil/trace.go:171","msg":"trace[1518397536] transaction","detail":"{read_only:false; response_revision:1763; number_of_response:1; }","duration":"178.697497ms","start":"2026-04-17T04:17:51.273691Z","end":"2026-04-17T04:17:51.452388Z","steps":["trace[1518397536] 'process raft request' (duration: 91.892665ms)","trace[1518397536] 'compare' (duration: 86.651258ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:17:51.452571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.471637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T04:17:51.452605Z","caller":"traceutil/trace.go:171","msg":"trace[430341193] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1763; }","duration":"153.572289ms","start":"2026-04-17T04:17:51.299022Z","end":"2026-04-17T04:17:51.452594Z","steps":["trace[430341193] 'agreement among raft nodes before linearized reading' (duration: 153.434176ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:17:51.714922Z","caller":"traceutil/trace.go:171","msg":"trace[963448472] transaction","detail":"{read_only:false; response_revision:1764; number_of_response:1; }","duration":"258.926687ms","start":"2026-04-17T04:17:51.455965Z","end":"2026-04-17T04:17:51.714892Z","steps":["trace[963448472] 'process raft request' (duration: 258.730572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:19:16.260013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.017523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T04:19:16.260094Z","caller":"traceutil/trace.go:171","msg":"trace[447113674] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2194; }","duration":"106.151486ms","start":"2026-04-17T04:19:16.153927Z","end":"2026-04-17T04:19:16.260078Z","steps":["trace[447113674] 'range keys from in-memory index tree' (duration: 105.855619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:19:16.260358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.29514ms","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-04-17T04:19:16.260437Z","caller":"traceutil/trace.go:171","msg":"trace[525234874] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2194; }","duration":"120.404933ms","start":"2026-04-17T04:19:16.140011Z","end":"2026-04-17T04:19:16.260416Z","steps":["trace[525234874] 'range keys from in-memory index tree' (duration: 120.152326ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:19:51.778803Z","caller":"traceutil/trace.go:171","msg":"trace[1491690680] transaction","detail":"{read_only:false; response_revision:2396; number_of_response:1; }","duration":"189.586622ms","start":"2026-04-17T04:19:51.589185Z","end":"2026-04-17T04:19:51.778772Z","steps":["trace[1491690680] 'process raft request' (duration: 189.363326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:19:52.063294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.360823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T04:19:52.063387Z","caller":"traceutil/trace.go:171","msg":"trace[950944279] linearizableReadLoop","detail":"{readStateIndex:2500; appliedIndex:2499; }","duration":"139.050339ms","start":"2026-04-17T04:19:51.924322Z","end":"2026-04-17T04:19:52.063372Z","steps":["trace[950944279] 'read index received' (duration: 17.538532ms)","trace[950944279] 'applied index is now lower than readState.Index' (duration: 121.510737ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:19:52.063529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.201253ms","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-04-17T04:19:52.063562Z","caller":"traceutil/trace.go:171","msg":"trace[170671248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2398; }","duration":"139.260594ms","start":"2026-04-17T04:19:51.924292Z","end":"2026-04-17T04:19:52.063553Z","steps":["trace[170671248] 'agreement among raft nodes before linearized reading' (duration: 139.121361ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:19:52.063689Z","caller":"traceutil/trace.go:171","msg":"trace[151361379] transaction","detail":"{read_only:false; response_revision:2398; number_of_response:1; }","duration":"178.420593ms","start":"2026-04-17T04:19:51.885255Z","end":"2026-04-17T04:19:52.063676Z","steps":["trace[151361379] 'process raft request' (duration: 56.606979ms)","trace[151361379] 'compare' (duration: 121.243411ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:19:52.363676Z","caller":"traceutil/trace.go:171","msg":"trace[742653227] linearizableReadLoop","detail":"{readStateIndex:2501; appliedIndex:2500; }","duration":"254.811035ms","start":"2026-04-17T04:19:52.10884Z","end":"2026-04-17T04:19:52.363651Z","steps":["trace[742653227] 'read index received' (duration: 223.059896ms)","trace[742653227] 'applied index is now lower than readState.Index' (duration: 31.750089ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:19:52.363766Z","caller":"traceutil/trace.go:171","msg":"trace[1557460764] transaction","detail":"{read_only:false; response_revision:2399; number_of_response:1; }","duration":"296.078261ms","start":"2026-04-17T04:19:52.067657Z","end":"2026-04-17T04:19:52.363735Z","steps":["trace[1557460764] 'process raft request' (duration: 264.325532ms)","trace[1557460764] 'compare' (duration: 31.564285ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:19:52.363925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.076152ms","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-04-17T04:19:52.363969Z","caller":"traceutil/trace.go:171","msg":"trace[2085884937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2399; }","duration":"255.167005ms","start":"2026-04-17T04:19:52.108789Z","end":"2026-04-17T04:19:52.363956Z","steps":["trace[2085884937] 'agreement among raft nodes before linearized reading' (duration: 254.99343ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:19:52.609788Z","caller":"traceutil/trace.go:171","msg":"trace[1211499860] transaction","detail":"{read_only:false; response_revision:2403; number_of_response:1; }","duration":"116.325802ms","start":"2026-04-17T04:19:52.493428Z","end":"2026-04-17T04:19:52.609754Z","steps":["trace[1211499860] 'process raft request' (duration: 116.037875ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T04:20:00.766035Z","caller":"traceutil/trace.go:171","msg":"trace[1609477249] linearizableReadLoop","detail":"{readStateIndex:2551; appliedIndex:2550; }","duration":"361.576592ms","start":"2026-04-17T04:20:00.404375Z","end":"2026-04-17T04:20:00.765952Z","steps":["trace[1609477249] 'read index received' (duration: 361.439117ms)","trace[1609477249] 'applied index is now lower than readState.Index' (duration: 136.375µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:20:00.766084Z","caller":"traceutil/trace.go:171","msg":"trace[980559685] transaction","detail":"{read_only:false; response_revision:2448; number_of_response:1; }","duration":"361.852658ms","start":"2026-04-17T04:20:00.404193Z","end":"2026-04-17T04:20:00.766046Z","steps":["trace[980559685] 'process raft request' (duration: 361.55342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:20:00.766357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:20:00.404177Z","time spent":"362.077923ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T04:20:00.766446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.016152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-17T04:20:00.76656Z","caller":"traceutil/trace.go:171","msg":"trace[1042346580] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2448; }","duration":"362.184686ms","start":"2026-04-17T04:20:00.404354Z","end":"2026-04-17T04:20:00.766538Z","steps":["trace[1042346580] 'agreement among raft nodes before linearized reading' (duration: 361.734565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:20:00.76664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:20:00.404345Z","time spent":"362.282659ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T04:20:00.791574Z","caller":"traceutil/trace.go:171","msg":"trace[903001721] transaction","detail":"{read_only:false; response_revision:2449; number_of_response:1; }","duration":"123.905557ms","start":"2026-04-17T04:20:00.667624Z","end":"2026-04-17T04:20:00.79153Z","steps":["trace[903001721] 'process raft request' (duration: 123.723833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:20:00.791641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.98595ms","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-04-17T04:20:00.791718Z","caller":"traceutil/trace.go:171","msg":"trace[946062060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2449; }","duration":"312.100443ms","start":"2026-04-17T04:20:00.479597Z","end":"2026-04-17T04:20:00.791698Z","steps":["trace[946062060] 'agreement among raft nodes before linearized reading' (duration: 311.893188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:20:00.791778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:20:00.479585Z","time spent":"312.181865ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T04:20:00.7918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.696495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-17T04:20:00.791932Z","caller":"traceutil/trace.go:171","msg":"trace[1051783998] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2449; }","duration":"306.890661ms","start":"2026-04-17T04:20:00.485021Z","end":"2026-04-17T04:20:00.791912Z","steps":["trace[1051783998] 'agreement among raft nodes before linearized reading' (duration: 306.473009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:20:00.792014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T04:20:00.484984Z","time spent":"307.018344ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-17T04:20:26.062873Z","caller":"traceutil/trace.go:171","msg":"trace[301472893] linearizableReadLoop","detail":"{readStateIndex:2692; appliedIndex:2691; }","duration":"117.635893ms","start":"2026-04-17T04:20:25.945215Z","end":"2026-04-17T04:20:26.062851Z","steps":["trace[301472893] 'read index received' (duration: 91.223174ms)","trace[301472893] 'applied index is now lower than readState.Index' (duration: 26.411359ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T04:20:26.062941Z","caller":"traceutil/trace.go:171","msg":"trace[1109277109] transaction","detail":"{read_only:false; response_revision:2583; number_of_response:1; }","duration":"148.261089ms","start":"2026-04-17T04:20:25.914655Z","end":"2026-04-17T04:20:26.062916Z","steps":["trace[1109277109] 'process raft request' (duration: 121.768078ms)","trace[1109277109] 'compare' (duration: 26.099872ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T04:20:26.06308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.843508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kube-proxy\" ","response":"range_response_count:1 size:317"} {"level":"info","ts":"2026-04-17T04:20:26.06313Z","caller":"traceutil/trace.go:171","msg":"trace[1334221375] range","detail":"{range_begin:/registry/roles/kube-system/kube-proxy; range_end:; response_count:1; response_revision:2583; }","duration":"117.93757ms","start":"2026-04-17T04:20:25.94518Z","end":"2026-04-17T04:20:26.063118Z","steps":["trace[1334221375] 'agreement among raft nodes before linearized reading' (duration: 117.793056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T04:20:26.063181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.169465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:339"} {"level":"info","ts":"2026-04-17T04:20:26.06326Z","caller":"traceutil/trace.go:171","msg":"trace[1772682887] range","detail":"{range_begin:/registry/roles/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:2583; }","duration":"109.291888ms","start":"2026-04-17T04:20:25.953949Z","end":"2026-04-17T04:20:26.063241Z","steps":["trace[1772682887] 'agreement among raft nodes before linearized reading' (duration: 109.117463ms)"],"step_count":1}