{"level":"warn","ts":"2026-06-30T08:29:35.266056Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T08:29:35.266147Z","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-06-30T08:29:35.266216Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T08:29:35.26623Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-06-30T08:29:35.266251Z","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-06-30T08:29:35.266799Z","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-06-30T08:29:35.266867Z","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-06-30T08:29:35.271971Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.93326ms"} {"level":"info","ts":"2026-06-30T08:29:35.281686Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-06-30T08:29:35.281821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T08:29:35.28185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-06-30T08:29:35.281867Z","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-06-30T08:29:35.281883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-06-30T08:29:35.281919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-06-30T08:29:35.29326Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T08:29:35.298133Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T08:29:35.314408Z","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-06-30T08:29:35.329763Z","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-06-30T08:29:35.330301Z","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-06-30T08:29:35.330424Z","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-06-30T08:29:35.330463Z","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-06-30T08:29:35.33047Z","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-06-30T08:29:35.331468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-06-30T08:29:35.347359Z","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-06-30T08:29:35.348612Z","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-06-30T08:29:35.348733Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-06-30T08:29:35.348768Z","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-06-30T08:29:35.348803Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T08:29:35.348799Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-06-30T08:29:35.582089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T08:29:35.582176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T08:29:35.582202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-06-30T08:29:35.582229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-06-30T08:29:35.582245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-06-30T08:29:35.582266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-06-30T08:29:35.582284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-06-30T08:29:35.585679Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:29:35.586504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T08:29:35.586518Z","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-06-30T08:29:35.58668Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T08:29:35.587156Z","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-06-30T08:29:35.587367Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:29:35.587447Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:29:35.588803Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T08:29:35.588896Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T08:29:35.591172Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T08:29:35.593433Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-06-30T08:29:40.594593Z","caller":"traceutil/trace.go:171","msg":"trace[87257210] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"100.389434ms","start":"2026-06-30T08:29:40.494177Z","end":"2026-06-30T08:29:40.594566Z","steps":["trace[87257210] 'process raft request' (duration: 66.420837ms)","trace[87257210] 'compare' (duration: 33.911636ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:29:51.112594Z","caller":"traceutil/trace.go:171","msg":"trace[1410120790] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"148.492125ms","start":"2026-06-30T08:29:50.964069Z","end":"2026-06-30T08:29:51.112561Z","steps":["trace[1410120790] 'process raft request' (duration: 109.231709ms)","trace[1410120790] 'compare' (duration: 39.107112ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:29:58.187488Z","caller":"traceutil/trace.go:171","msg":"trace[34790832] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:438; }","duration":"347.740356ms","start":"2026-06-30T08:29:57.839719Z","end":"2026-06-30T08:29:58.187459Z","steps":["trace[34790832] 'read index received' (duration: 347.46746ms)","trace[34790832] 'applied index is now lower than readState.Index' (duration: 271.416µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:29:58.187541Z","caller":"traceutil/trace.go:171","msg":"trace[2133633134] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"439.297606ms","start":"2026-06-30T08:29:57.748215Z","end":"2026-06-30T08:29:58.187512Z","steps":["trace[2133633134] 'process raft request' (duration: 439.07474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:29:58.187695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.949721ms","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-06-30T08:29:58.187777Z","caller":"traceutil/trace.go:171","msg":"trace[654792029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:423; }","duration":"348.071645ms","start":"2026-06-30T08:29:57.839689Z","end":"2026-06-30T08:29:58.187761Z","steps":["trace[654792029] 'agreement among raft nodes before linearized reading' (duration: 347.926231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:29:58.187823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:29:57.839673Z","time spent":"348.138616ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T08:29:58.188811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:29:57.748196Z","time spent":"439.413118ms","remote":"127.0.0.1:52190","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-06-30T08:29:58.688856Z","caller":"traceutil/trace.go:171","msg":"trace[1505725126] linearizableReadLoop","detail":"{readStateIndex:441; appliedIndex:439; }","duration":"365.072499ms","start":"2026-06-30T08:29:58.323756Z","end":"2026-06-30T08:29:58.688828Z","steps":["trace[1505725126] 'read index received' (duration: 347.675065ms)","trace[1505725126] 'applied index is now lower than readState.Index' (duration: 17.396074ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:29:58.688947Z","caller":"traceutil/trace.go:171","msg":"trace[26245307] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"496.445507ms","start":"2026-06-30T08:29:58.192469Z","end":"2026-06-30T08:29:58.688915Z","steps":["trace[26245307] 'process raft request' (duration: 496.278793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:29:58.689082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.294654ms","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-06-30T08:29:58.68913Z","caller":"traceutil/trace.go:171","msg":"trace[1867641699] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:425; }","duration":"365.403507ms","start":"2026-06-30T08:29:58.323715Z","end":"2026-06-30T08:29:58.689118Z","steps":["trace[1867641699] 'agreement among raft nodes before linearized reading' (duration: 365.288084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:29:58.689172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:29:58.323693Z","time spent":"365.471178ms","remote":"127.0.0.1:52190","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-06-30T08:29:58.68918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:29:58.192447Z","time spent":"496.58638ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:29:58.688894Z","caller":"traceutil/trace.go:171","msg":"trace[1006546688] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"496.58795ms","start":"2026-06-30T08:29:58.192267Z","end":"2026-06-30T08:29:58.688855Z","steps":["trace[1006546688] 'process raft request' (duration: 479.151746ms)","trace[1006546688] 'compare' (duration: 17.210239ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:29:58.689464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:29:58.192241Z","time spent":"497.131373ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:30:15.221013Z","caller":"traceutil/trace.go:171","msg":"trace[335178833] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"505.457516ms","start":"2026-06-30T08:30:14.71553Z","end":"2026-06-30T08:30:15.220987Z","steps":["trace[335178833] 'process raft request' (duration: 505.338853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:15.221159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.715509Z","time spent":"505.585019ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:30:15.248298Z","caller":"traceutil/trace.go:171","msg":"trace[760905665] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"502.851582ms","start":"2026-06-30T08:30:14.745418Z","end":"2026-06-30T08:30:15.248269Z","steps":["trace[760905665] 'process raft request' (duration: 502.725879ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:15.248379Z","caller":"traceutil/trace.go:171","msg":"trace[703219395] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"521.538847ms","start":"2026-06-30T08:30:14.726829Z","end":"2026-06-30T08:30:15.248367Z","steps":["trace[703219395] 'process raft request' (duration: 521.187308ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:15.248386Z","caller":"traceutil/trace.go:171","msg":"trace[365490473] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"526.475788ms","start":"2026-06-30T08:30:14.721864Z","end":"2026-06-30T08:30:15.24834Z","steps":["trace[365490473] 'process raft request' (duration: 526.028057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:15.248466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.745406Z","time spent":"502.982925ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:15.248476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.726821Z","time spent":"521.587669ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:15.248546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.721848Z","time spent":"526.632991ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:30:15.248586Z","caller":"traceutil/trace.go:171","msg":"trace[290170053] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"504.168545ms","start":"2026-06-30T08:30:14.744408Z","end":"2026-06-30T08:30:15.248577Z","steps":["trace[290170053] 'process raft request' (duration: 503.698963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:15.248633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.744386Z","time spent":"504.221986ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:30:15.248312Z","caller":"traceutil/trace.go:171","msg":"trace[290201532] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"509.595727ms","start":"2026-06-30T08:30:14.738695Z","end":"2026-06-30T08:30:15.248291Z","steps":["trace[290201532] 'process raft request' (duration: 509.374211ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:15.248689Z","caller":"traceutil/trace.go:171","msg":"trace[607748948] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"496.487417ms","start":"2026-06-30T08:30:14.752185Z","end":"2026-06-30T08:30:15.248672Z","steps":["trace[607748948] 'process raft request' (duration: 496.071027ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:15.248633Z","caller":"traceutil/trace.go:171","msg":"trace[75198863] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:545; }","duration":"474.515603ms","start":"2026-06-30T08:30:14.774052Z","end":"2026-06-30T08:30:15.248567Z","steps":["trace[75198863] 'read index received' (duration: 446.920461ms)","trace[75198863] 'applied index is now lower than readState.Index' (duration: 27.594231ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:30:15.24872Z","caller":"traceutil/trace.go:171","msg":"trace[1292701572] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"503.245352ms","start":"2026-06-30T08:30:14.745464Z","end":"2026-06-30T08:30:15.248709Z","steps":["trace[1292701572] 'process raft request' (duration: 502.713659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:15.248733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.752179Z","time spent":"496.533538ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:15.248746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.738678Z","time spent":"510.032957ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:15.248766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.74546Z","time spent":"503.287493ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:30:15.248785Z","caller":"traceutil/trace.go:171","msg":"trace[1478417733] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"489.57436ms","start":"2026-06-30T08:30:14.759199Z","end":"2026-06-30T08:30:15.248774Z","steps":["trace[1478417733] 'process raft request' (duration: 489.105458ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:15.248814Z","caller":"traceutil/trace.go:171","msg":"trace[1015667682] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"501.256053ms","start":"2026-06-30T08:30:14.747548Z","end":"2026-06-30T08:30:15.248804Z","steps":["trace[1015667682] 'process raft request' (duration: 500.665669ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:15.248845Z","caller":"traceutil/trace.go:171","msg":"trace[509793676] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"375.622065ms","start":"2026-06-30T08:30:14.873214Z","end":"2026-06-30T08:30:15.248836Z","steps":["trace[509793676] 'process raft request' (duration: 375.298957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:15.248849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.75917Z","time spent":"489.64208ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:15.248852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.747541Z","time spent":"501.293364ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:15.248883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.873187Z","time spent":"375.678356ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:15.24895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.891312ms","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-06-30T08:30:15.24896Z","caller":"traceutil/trace.go:171","msg":"trace[659292388] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"468.927256ms","start":"2026-06-30T08:30:14.780025Z","end":"2026-06-30T08:30:15.248953Z","steps":["trace[659292388] 'process raft request' (duration: 468.414423ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:15.248991Z","caller":"traceutil/trace.go:171","msg":"trace[214250821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"474.961144ms","start":"2026-06-30T08:30:14.774019Z","end":"2026-06-30T08:30:15.24898Z","steps":["trace[214250821] 'agreement among raft nodes before linearized reading' (duration: 474.853871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:15.249003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.78001Z","time spent":"468.974268ms","remote":"127.0.0.1:51992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:15.249021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.774007Z","time spent":"475.007204ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-30T08:30:15.251603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.594981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:30:15.251675Z","caller":"traceutil/trace.go:171","msg":"trace[14893568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:539; }","duration":"471.673553ms","start":"2026-06-30T08:30:14.779984Z","end":"2026-06-30T08:30:15.251658Z","steps":["trace[14893568] 'agreement among raft nodes before linearized reading' (duration: 471.534639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:15.251714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.779938Z","time spent":"471.768125ms","remote":"127.0.0.1:52190","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-06-30T08:30:15.252282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.241247ms","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-06-30T08:30:15.252322Z","caller":"traceutil/trace.go:171","msg":"trace[2017437470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:539; }","duration":"472.314869ms","start":"2026-06-30T08:30:14.779995Z","end":"2026-06-30T08:30:15.25231Z","steps":["trace[2017437470] 'agreement among raft nodes before linearized reading' (duration: 472.246407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:15.252355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:14.779982Z","time spent":"472.366249ms","remote":"127.0.0.1:52190","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-06-30T08:30:21.573538Z","caller":"traceutil/trace.go:171","msg":"trace[92644121] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"285.843989ms","start":"2026-06-30T08:30:21.287658Z","end":"2026-06-30T08:30:21.573502Z","steps":["trace[92644121] 'process raft request' (duration: 285.690716ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:21.646282Z","caller":"traceutil/trace.go:171","msg":"trace[1009137589] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"351.257202ms","start":"2026-06-30T08:30:21.294995Z","end":"2026-06-30T08:30:21.646252Z","steps":["trace[1009137589] 'process raft request' (duration: 350.997176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:21.646562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:21.294965Z","time spent":"351.397575ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:30:21.64682Z","caller":"traceutil/trace.go:171","msg":"trace[2109958320] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"338.760498ms","start":"2026-06-30T08:30:21.308034Z","end":"2026-06-30T08:30:21.646794Z","steps":["trace[2109958320] 'read index received' (duration: 265.182546ms)","trace[2109958320] 'applied index is now lower than readState.Index' (duration: 73.577172ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:30:21.646976Z","caller":"traceutil/trace.go:171","msg":"trace[2052882260] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"256.616828ms","start":"2026-06-30T08:30:21.390346Z","end":"2026-06-30T08:30:21.646963Z","steps":["trace[2052882260] 'process raft request' (duration: 255.982962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:21.647349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.300491ms","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-06-30T08:30:21.647468Z","caller":"traceutil/trace.go:171","msg":"trace[1726456798] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"339.458784ms","start":"2026-06-30T08:30:21.307986Z","end":"2026-06-30T08:30:21.647445Z","steps":["trace[1726456798] 'agreement among raft nodes before linearized reading' (duration: 339.196318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:21.647473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.336392ms","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-06-30T08:30:21.647536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:21.307964Z","time spent":"339.560087ms","remote":"127.0.0.1:52190","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-06-30T08:30:21.64759Z","caller":"traceutil/trace.go:171","msg":"trace[959546361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"339.483435ms","start":"2026-06-30T08:30:21.308072Z","end":"2026-06-30T08:30:21.647556Z","steps":["trace[959546361] 'agreement among raft nodes before linearized reading' (duration: 339.068935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:21.647352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.600347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ss2nj\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-30T08:30:21.647692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:21.308001Z","time spent":"339.644289ms","remote":"127.0.0.1:52190","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":"info","ts":"2026-06-30T08:30:21.647741Z","caller":"traceutil/trace.go:171","msg":"trace[1631460666] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ss2nj; range_end:; response_count:1; response_revision:636; }","duration":"127.965065ms","start":"2026-06-30T08:30:21.519698Z","end":"2026-06-30T08:30:21.647663Z","steps":["trace[1631460666] 'agreement among raft nodes before linearized reading' (duration: 127.506834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:21.795787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.263011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:30:21.796033Z","caller":"traceutil/trace.go:171","msg":"trace[1467487414] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"143.989466ms","start":"2026-06-30T08:30:21.651997Z","end":"2026-06-30T08:30:21.795986Z","steps":["trace[1467487414] 'process raft request' (duration: 20.217612ms)","trace[1467487414] 'compare' (duration: 123.096318ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:30:21.796108Z","caller":"traceutil/trace.go:171","msg":"trace[1691056212] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"135.177111ms","start":"2026-06-30T08:30:21.66091Z","end":"2026-06-30T08:30:21.796087Z","steps":["trace[1691056212] 'process raft request' (duration: 135.11351ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:21.796371Z","caller":"traceutil/trace.go:171","msg":"trace[1020787937] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"142.440238ms","start":"2026-06-30T08:30:21.65392Z","end":"2026-06-30T08:30:21.79636Z","steps":["trace[1020787937] 'process raft request' (duration: 142.057649ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:21.796665Z","caller":"traceutil/trace.go:171","msg":"trace[204756356] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"144.058768ms","start":"2026-06-30T08:30:21.652568Z","end":"2026-06-30T08:30:21.796627Z","steps":["trace[204756356] 'process raft request' (duration: 143.34723ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:21.825177Z","caller":"traceutil/trace.go:171","msg":"trace[859578562] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"123.298272ms","start":"2026-06-30T08:30:21.701847Z","end":"2026-06-30T08:30:21.825145Z","steps":["trace[859578562] 'process raft request' (duration: 123.167189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:22.236998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.252065ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:30:22.237112Z","caller":"traceutil/trace.go:171","msg":"trace[396117327] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"316.411033ms","start":"2026-06-30T08:30:21.920684Z","end":"2026-06-30T08:30:22.237095Z","steps":["trace[396117327] 'read index received' (duration: 32.951µs)","trace[396117327] 'applied index is now lower than readState.Index' (duration: 316.376712ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:30:22.237354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.665169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:30:22.237394Z","caller":"traceutil/trace.go:171","msg":"trace[772386648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"316.740731ms","start":"2026-06-30T08:30:21.920644Z","end":"2026-06-30T08:30:22.237385Z","steps":["trace[772386648] 'agreement among raft nodes before linearized reading' (duration: 316.497655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:22.23743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:21.920601Z","time spent":"316.821753ms","remote":"127.0.0.1:51936","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-06-30T08:30:22.237517Z","caller":"traceutil/trace.go:171","msg":"trace[987941562] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"395.714854ms","start":"2026-06-30T08:30:21.841748Z","end":"2026-06-30T08:30:22.237462Z","steps":["trace[987941562] 'process raft request' (duration: 56.844374ms)","trace[987941562] 'compare' (duration: 338.06617ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:30:22.237668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:21.841727Z","time spent":"395.866777ms","remote":"127.0.0.1:52116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:23.184914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.012642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-06-30T08:30:23.184472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.155524ms","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-06-30T08:30:23.185038Z","caller":"traceutil/trace.go:171","msg":"trace[1314105440] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"943.397579ms","start":"2026-06-30T08:30:22.241621Z","end":"2026-06-30T08:30:23.185018Z","steps":["trace[1314105440] 'process raft request' (duration: 119.199202ms)","trace[1314105440] 'compare' (duration: 823.815937ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:30:23.185066Z","caller":"traceutil/trace.go:171","msg":"trace[468436505] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:642; }","duration":"635.770169ms","start":"2026-06-30T08:30:22.549255Z","end":"2026-06-30T08:30:23.185025Z","steps":["trace[468436505] 'range keys from in-memory index tree' (duration: 635.123283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:23.185101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:22.241597Z","time spent":"943.48178ms","remote":"127.0.0.1:52016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:30:23.423075Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881964371326798,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T08:30:23.486608Z","caller":"traceutil/trace.go:171","msg":"trace[121437015] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:667; }","duration":"563.620352ms","start":"2026-06-30T08:30:22.922973Z","end":"2026-06-30T08:30:23.486593Z","steps":["trace[121437015] 'read index received' (duration: 542.841886ms)","trace[121437015] 'applied index is now lower than readState.Index' (duration: 20.777726ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:30:23.486613Z","caller":"traceutil/trace.go:171","msg":"trace[1072678195] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.244915299s","start":"2026-06-30T08:30:22.24167Z","end":"2026-06-30T08:30:23.486585Z","steps":["trace[1072678195] 'process raft request' (duration: 1.224198354s)","trace[1072678195] 'compare' (duration: 20.51946ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:30:23.48667Z","caller":"traceutil/trace.go:171","msg":"trace[1930370465] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.243095425s","start":"2026-06-30T08:30:22.243548Z","end":"2026-06-30T08:30:23.486643Z","steps":["trace[1930370465] 'process raft request' (duration: 1.242958842s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:23.486726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:22.241638Z","time spent":"1.245037792s","remote":"127.0.0.1:52016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:30:23.486776Z","caller":"traceutil/trace.go:171","msg":"trace[911598509] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.243102905s","start":"2026-06-30T08:30:22.243624Z","end":"2026-06-30T08:30:23.486727Z","steps":["trace[911598509] 'process raft request' (duration: 1.242930651s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:23.486815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:22.24353Z","time spent":"1.243203207s","remote":"127.0.0.1:52158","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-06-30T08:30:23.486905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.927139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:30:23.486929Z","caller":"traceutil/trace.go:171","msg":"trace[347255591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"563.988811ms","start":"2026-06-30T08:30:22.922934Z","end":"2026-06-30T08:30:23.486922Z","steps":["trace[347255591] 'agreement among raft nodes before linearized reading' (duration: 563.94793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:23.486949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:22.922917Z","time spent":"564.028422ms","remote":"127.0.0.1:51934","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-06-30T08:30:23.486953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:22.24361Z","time spent":"1.243249469s","remote":"127.0.0.1:52116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:30:24.30154Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881964371326805,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T08:30:25.044669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.148717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:30:25.04498Z","caller":"traceutil/trace.go:171","msg":"trace[882958266] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.463981701s","start":"2026-06-30T08:30:23.580975Z","end":"2026-06-30T08:30:25.044956Z","steps":["trace[882958266] 'process raft request' (duration: 894.423174ms)","trace[882958266] 'compare' (duration: 568.788708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:30:25.045103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:23.580963Z","time spent":"1.464067664s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:30:25.205957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.191874ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-06-30T08:30:25.206109Z","caller":"traceutil/trace.go:171","msg":"trace[70052216] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:670; }","duration":"1.405619511s","start":"2026-06-30T08:30:23.800471Z","end":"2026-06-30T08:30:25.20609Z","steps":["trace[70052216] 'read index received' (duration: 674.916051ms)","trace[70052216] 'applied index is now lower than readState.Index' (duration: 730.70167ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:30:25.206331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405852116s","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-06-30T08:30:25.206387Z","caller":"traceutil/trace.go:171","msg":"trace[1196190800] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:647; }","duration":"1.40598154s","start":"2026-06-30T08:30:23.800393Z","end":"2026-06-30T08:30:25.206374Z","steps":["trace[1196190800] 'agreement among raft nodes before linearized reading' (duration: 1.405772945s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:25.206429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:23.800376Z","time spent":"1.406044651s","remote":"127.0.0.1:52190","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-06-30T08:30:25.206421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405710013s","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-06-30T08:30:25.206342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.430618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T08:30:25.206448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405094398s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:30:25.206498Z","caller":"traceutil/trace.go:171","msg":"trace[1113241632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"287.586901ms","start":"2026-06-30T08:30:24.918898Z","end":"2026-06-30T08:30:25.206485Z","steps":["trace[1113241632] 'agreement among raft nodes before linearized reading' (duration: 287.381706ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:25.206496Z","caller":"traceutil/trace.go:171","msg":"trace[67807501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"1.405816935s","start":"2026-06-30T08:30:23.800659Z","end":"2026-06-30T08:30:25.206476Z","steps":["trace[67807501] 'agreement among raft nodes before linearized reading' (duration: 1.40559378s)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:25.20652Z","caller":"traceutil/trace.go:171","msg":"trace[1002076116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"1.40516135s","start":"2026-06-30T08:30:23.801332Z","end":"2026-06-30T08:30:25.206494Z","steps":["trace[1002076116] 'agreement among raft nodes before linearized reading' (duration: 1.404986705s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:25.20655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:23.800651Z","time spent":"1.405890227s","remote":"127.0.0.1:52190","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-06-30T08:30:25.206568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:23.801281Z","time spent":"1.405274902s","remote":"127.0.0.1:52190","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":"info","ts":"2026-06-30T08:30:26.840212Z","caller":"traceutil/trace.go:171","msg":"trace[248191072] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"188.438518ms","start":"2026-06-30T08:30:26.651734Z","end":"2026-06-30T08:30:26.840173Z","steps":["trace[248191072] 'process raft request' (duration: 188.264433ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:27.579129Z","caller":"traceutil/trace.go:171","msg":"trace[1106320209] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"106.709139ms","start":"2026-06-30T08:30:27.472388Z","end":"2026-06-30T08:30:27.579097Z","steps":["trace[1106320209] 'process raft request' (duration: 97.832412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:39.790694Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881964371327096,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T08:30:39.997169Z","caller":"traceutil/trace.go:171","msg":"trace[390793985] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"870.244647ms","start":"2026-06-30T08:30:39.126899Z","end":"2026-06-30T08:30:39.997144Z","steps":["trace[390793985] 'process raft request' (duration: 870.094353ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:39.997399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:39.126883Z","time spent":"870.438311ms","remote":"127.0.0.1:52190","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-06-30T08:30:40.523258Z","caller":"traceutil/trace.go:171","msg":"trace[1498833007] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"1.157245707s","start":"2026-06-30T08:30:39.365964Z","end":"2026-06-30T08:30:40.52321Z","steps":["trace[1498833007] 'process raft request' (duration: 1.157066313s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:40.523401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:39.365937Z","time spent":"1.157392931s","remote":"127.0.0.1:52190","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-06-30T08:30:40.523571Z","caller":"traceutil/trace.go:171","msg":"trace[1493913973] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:822; }","duration":"1.233492305s","start":"2026-06-30T08:30:39.290069Z","end":"2026-06-30T08:30:40.523561Z","steps":["trace[1493913973] 'read index received' (duration: 707.040674ms)","trace[1493913973] 'applied index is now lower than readState.Index' (duration: 526.450691ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:30:40.523924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.232237394s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:30:40.523963Z","caller":"traceutil/trace.go:171","msg":"trace[1487883965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:795; }","duration":"1.232318146s","start":"2026-06-30T08:30:39.291634Z","end":"2026-06-30T08:30:40.523952Z","steps":["trace[1487883965] 'agreement among raft nodes before linearized reading' (duration: 1.232194243s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:40.523986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:39.291611Z","time spent":"1.232369207s","remote":"127.0.0.1:52190","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":"info","ts":"2026-06-30T08:30:40.523906Z","caller":"traceutil/trace.go:171","msg":"trace[760915771] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"883.523824ms","start":"2026-06-30T08:30:39.640335Z","end":"2026-06-30T08:30:40.523859Z","steps":["trace[760915771] 'process raft request' (duration: 882.829737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:40.524094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233926105s","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-06-30T08:30:40.524565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:39.64031Z","time spent":"884.017665ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:30:40.524454Z","caller":"traceutil/trace.go:171","msg":"trace[1557051213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:795; }","duration":"1.234402767s","start":"2026-06-30T08:30:39.290016Z","end":"2026-06-30T08:30:40.524419Z","steps":["trace[1557051213] 'agreement among raft nodes before linearized reading' (duration: 1.233799822s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:40.524122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231322531s","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-06-30T08:30:40.525114Z","caller":"traceutil/trace.go:171","msg":"trace[2040992704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:795; }","duration":"1.232320146s","start":"2026-06-30T08:30:39.292766Z","end":"2026-06-30T08:30:40.525086Z","steps":["trace[2040992704] 'agreement among raft nodes before linearized reading' (duration: 1.231315291s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:40.524069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.705101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T08:30:40.525219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:39.292751Z","time spent":"1.232434308s","remote":"127.0.0.1:52190","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-06-30T08:30:40.525004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:39.289995Z","time spent":"1.234988451s","remote":"127.0.0.1:52190","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-06-30T08:30:40.525276Z","caller":"traceutil/trace.go:171","msg":"trace[696593277] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:795; }","duration":"558.90279ms","start":"2026-06-30T08:30:39.966356Z","end":"2026-06-30T08:30:40.525259Z","steps":["trace[696593277] 'agreement among raft nodes before linearized reading' (duration: 557.692211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:40.525347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:39.966313Z","time spent":"559.009163ms","remote":"127.0.0.1:52286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":26,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-06-30T08:30:54.772501Z","caller":"traceutil/trace.go:171","msg":"trace[1910915312] linearizableReadLoop","detail":"{readStateIndex:973; appliedIndex:972; }","duration":"150.352506ms","start":"2026-06-30T08:30:54.622107Z","end":"2026-06-30T08:30:54.772459Z","steps":["trace[1910915312] 'read index received' (duration: 149.801043ms)","trace[1910915312] 'applied index is now lower than readState.Index' (duration: 549.723µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:30:54.772567Z","caller":"traceutil/trace.go:171","msg":"trace[1583377334] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"153.437591ms","start":"2026-06-30T08:30:54.619088Z","end":"2026-06-30T08:30:54.772525Z","steps":["trace[1583377334] 'process raft request' (duration: 153.055062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:54.773291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.174416ms","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-06-30T08:30:54.773379Z","caller":"traceutil/trace.go:171","msg":"trace[1829897446] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:940; }","duration":"151.32653ms","start":"2026-06-30T08:30:54.622034Z","end":"2026-06-30T08:30:54.77336Z","steps":["trace[1829897446] 'agreement among raft nodes before linearized reading' (duration: 150.580542ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:55.037911Z","caller":"traceutil/trace.go:171","msg":"trace[1736707644] linearizableReadLoop","detail":"{readStateIndex:974; appliedIndex:973; }","duration":"265.26794ms","start":"2026-06-30T08:30:54.772605Z","end":"2026-06-30T08:30:55.037873Z","steps":["trace[1736707644] 'read index received' (duration: 210.724284ms)","trace[1736707644] 'applied index is now lower than readState.Index' (duration: 54.542566ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:30:55.03798Z","caller":"traceutil/trace.go:171","msg":"trace[1324689749] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"414.072239ms","start":"2026-06-30T08:30:54.623857Z","end":"2026-06-30T08:30:55.037929Z","steps":["trace[1324689749] 'process raft request' (duration: 359.45475ms)","trace[1324689749] 'compare' (duration: 54.373103ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:30:55.038151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.143273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T08:30:55.038194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:54.623834Z","time spent":"414.249143ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:30:55.038198Z","caller":"traceutil/trace.go:171","msg":"trace[1361435800] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:942; }","duration":"118.258296ms","start":"2026-06-30T08:30:54.919924Z","end":"2026-06-30T08:30:55.038182Z","steps":["trace[1361435800] 'agreement among raft nodes before linearized reading' (duration: 118.148343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:55.03822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.318554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-ldmjt\" ","response":"range_response_count:1 size:5072"} {"level":"warn","ts":"2026-06-30T08:30:55.038247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.34029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:30:55.03831Z","caller":"traceutil/trace.go:171","msg":"trace[445612577] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-ldmjt; range_end:; response_count:1; response_revision:942; }","duration":"342.451407ms","start":"2026-06-30T08:30:54.695838Z","end":"2026-06-30T08:30:55.038289Z","steps":["trace[445612577] 'agreement among raft nodes before linearized reading' (duration: 342.091279ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:55.038321Z","caller":"traceutil/trace.go:171","msg":"trace[865980671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:942; }","duration":"415.431872ms","start":"2026-06-30T08:30:54.622868Z","end":"2026-06-30T08:30:55.038299Z","steps":["trace[865980671] 'agreement among raft nodes before linearized reading' (duration: 415.173795ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:55.038328Z","caller":"traceutil/trace.go:171","msg":"trace[775189178] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"260.28311ms","start":"2026-06-30T08:30:54.778015Z","end":"2026-06-30T08:30:55.038298Z","steps":["trace[775189178] 'process raft request' (duration: 259.822368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:55.038366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:54.622856Z","time spent":"415.501064ms","remote":"127.0.0.1:52190","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-06-30T08:30:55.038479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:30:54.69582Z","time spent":"342.645842ms","remote":"127.0.0.1:52116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5093,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-ldmjt\" "} {"level":"info","ts":"2026-06-30T08:30:59.259922Z","caller":"traceutil/trace.go:171","msg":"trace[1780681728] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"201.198903ms","start":"2026-06-30T08:30:59.058705Z","end":"2026-06-30T08:30:59.259904Z","steps":["trace[1780681728] 'read index received' (duration: 201.013129ms)","trace[1780681728] 'applied index is now lower than readState.Index' (duration: 184.984µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:30:59.260138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.379827ms","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-06-30T08:30:59.260168Z","caller":"traceutil/trace.go:171","msg":"trace[902015275] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:956; }","duration":"201.50945ms","start":"2026-06-30T08:30:59.058649Z","end":"2026-06-30T08:30:59.260158Z","steps":["trace[902015275] 'agreement among raft nodes before linearized reading' (duration: 201.360687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:30:59.260441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.237251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-30T08:30:59.260494Z","caller":"traceutil/trace.go:171","msg":"trace[774317985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:956; }","duration":"147.336243ms","start":"2026-06-30T08:30:59.113146Z","end":"2026-06-30T08:30:59.260482Z","steps":["trace[774317985] 'agreement among raft nodes before linearized reading' (duration: 147.19827ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:30:59.259997Z","caller":"traceutil/trace.go:171","msg":"trace[87171482] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"203.090489ms","start":"2026-06-30T08:30:59.056886Z","end":"2026-06-30T08:30:59.259976Z","steps":["trace[87171482] 'process raft request' (duration: 202.901654ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:00.238509Z","caller":"traceutil/trace.go:171","msg":"trace[647082728] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"244.387682ms","start":"2026-06-30T08:30:59.994091Z","end":"2026-06-30T08:31:00.238479Z","steps":["trace[647082728] 'process raft request' (duration: 244.165166ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:00.414496Z","caller":"traceutil/trace.go:171","msg":"trace[397849879] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"172.033313ms","start":"2026-06-30T08:31:00.242435Z","end":"2026-06-30T08:31:00.414468Z","steps":["trace[397849879] 'process raft request' (duration: 90.142892ms)","trace[397849879] 'compare' (duration: 81.777078ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:31:01.624528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.834722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:31:01.624646Z","caller":"traceutil/trace.go:171","msg":"trace[555173360] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"316.847424ms","start":"2026-06-30T08:31:01.30778Z","end":"2026-06-30T08:31:01.624627Z","steps":["trace[555173360] 'process raft request' (duration: 69.816497ms)","trace[555173360] 'compare' (duration: 246.714199ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:31:01.624704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:01.307762Z","time spent":"316.916886ms","remote":"127.0.0.1:52190","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-06-30T08:31:02.347055Z","caller":"traceutil/trace.go:171","msg":"trace[1370465204] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"103.510798ms","start":"2026-06-30T08:31:02.24351Z","end":"2026-06-30T08:31:02.347021Z","steps":["trace[1370465204] 'process raft request' (duration: 103.229751ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:02.51091Z","caller":"traceutil/trace.go:171","msg":"trace[1867376226] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"131.808195ms","start":"2026-06-30T08:31:02.379073Z","end":"2026-06-30T08:31:02.510882Z","steps":["trace[1867376226] 'process raft request' (duration: 110.484026ms)","trace[1867376226] 'compare' (duration: 21.048322ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:02.706446Z","caller":"traceutil/trace.go:171","msg":"trace[134476652] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"191.845815ms","start":"2026-06-30T08:31:02.514572Z","end":"2026-06-30T08:31:02.706418Z","steps":["trace[134476652] 'process raft request' (duration: 168.861796ms)","trace[134476652] 'compare' (duration: 22.866606ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:08.528617Z","caller":"traceutil/trace.go:171","msg":"trace[340921472] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"162.745298ms","start":"2026-06-30T08:31:08.365843Z","end":"2026-06-30T08:31:08.528589Z","steps":["trace[340921472] 'process raft request' (duration: 162.560623ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:09.592631Z","caller":"traceutil/trace.go:171","msg":"trace[1021069334] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1025; }","duration":"258.871874ms","start":"2026-06-30T08:31:09.333734Z","end":"2026-06-30T08:31:09.592606Z","steps":["trace[1021069334] 'read index received' (duration: 258.637889ms)","trace[1021069334] 'applied index is now lower than readState.Index' (duration: 232.955µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:09.592731Z","caller":"traceutil/trace.go:171","msg":"trace[744430381] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"288.021364ms","start":"2026-06-30T08:31:09.304682Z","end":"2026-06-30T08:31:09.592703Z","steps":["trace[744430381] 'process raft request' (duration: 287.773708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:09.592827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.07173ms","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-06-30T08:31:09.592864Z","caller":"traceutil/trace.go:171","msg":"trace[1616577097] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:989; }","duration":"259.163722ms","start":"2026-06-30T08:31:09.33369Z","end":"2026-06-30T08:31:09.592853Z","steps":["trace[1616577097] 'agreement among raft nodes before linearized reading' (duration: 259.011489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:10.814788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.328993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:31:10.814884Z","caller":"traceutil/trace.go:171","msg":"trace[901862451] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1026; }","duration":"1.11778489s","start":"2026-06-30T08:31:09.697081Z","end":"2026-06-30T08:31:10.814866Z","steps":["trace[901862451] 'read index received' (duration: 351.235191ms)","trace[901862451] 'applied index is now lower than readState.Index' (duration: 766.548299ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:31:10.815068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118001244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:31:10.815094Z","caller":"traceutil/trace.go:171","msg":"trace[1609178629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:990; }","duration":"1.118069816s","start":"2026-06-30T08:31:09.697015Z","end":"2026-06-30T08:31:10.815085Z","steps":["trace[1609178629] 'agreement among raft nodes before linearized reading' (duration: 1.117893532s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:10.815123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:09.696995Z","time spent":"1.118120208s","remote":"127.0.0.1:52190","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":"info","ts":"2026-06-30T08:31:10.815123Z","caller":"traceutil/trace.go:171","msg":"trace[2000172540] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"1.217977205s","start":"2026-06-30T08:31:09.597112Z","end":"2026-06-30T08:31:10.815089Z","steps":["trace[2000172540] 'process raft request' (duration: 451.260472ms)","trace[2000172540] 'compare' (duration: 765.906453ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:31:10.815317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:09.597084Z","time spent":"1.218110409s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:31:10.819498Z","caller":"traceutil/trace.go:171","msg":"trace[1871531155] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"285.356748ms","start":"2026-06-30T08:31:10.534131Z","end":"2026-06-30T08:31:10.819488Z","steps":["trace[1871531155] 'process raft request' (duration: 285.280136ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:16.980339Z","caller":"traceutil/trace.go:171","msg":"trace[853038928] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1052; }","duration":"133.570308ms","start":"2026-06-30T08:31:16.846743Z","end":"2026-06-30T08:31:16.980314Z","steps":["trace[853038928] 'read index received' (duration: 133.386893ms)","trace[853038928] 'applied index is now lower than readState.Index' (duration: 181.985µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:16.980443Z","caller":"traceutil/trace.go:171","msg":"trace[595036425] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"137.449872ms","start":"2026-06-30T08:31:16.842968Z","end":"2026-06-30T08:31:16.980418Z","steps":["trace[595036425] 'process raft request' (duration: 137.130825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:16.980593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.042641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:31:16.980636Z","caller":"traceutil/trace.go:171","msg":"trace[1897701840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1014; }","duration":"132.144343ms","start":"2026-06-30T08:31:16.848481Z","end":"2026-06-30T08:31:16.980626Z","steps":["trace[1897701840] 'agreement among raft nodes before linearized reading' (duration: 131.98973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:16.98064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.864306ms","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-06-30T08:31:16.980734Z","caller":"traceutil/trace.go:171","msg":"trace[301854074] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1014; }","duration":"134.014289ms","start":"2026-06-30T08:31:16.8467Z","end":"2026-06-30T08:31:16.980714Z","steps":["trace[301854074] 'agreement among raft nodes before linearized reading' (duration: 133.769473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:16.980769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.200377ms","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-06-30T08:31:16.980833Z","caller":"traceutil/trace.go:171","msg":"trace[504477508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1014; }","duration":"128.29739ms","start":"2026-06-30T08:31:16.852518Z","end":"2026-06-30T08:31:16.980815Z","steps":["trace[504477508] 'agreement among raft nodes before linearized reading' (duration: 128.051724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:17.346484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.038606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:31:17.346585Z","caller":"traceutil/trace.go:171","msg":"trace[1585391338] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"361.556211ms","start":"2026-06-30T08:31:16.985013Z","end":"2026-06-30T08:31:17.346569Z","steps":["trace[1585391338] 'process raft request' (duration: 207.373173ms)","trace[1585391338] 'compare' (duration: 153.653216ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:31:17.346627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:16.984996Z","time spent":"361.611952ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:31:17.442851Z","caller":"traceutil/trace.go:171","msg":"trace[1580641610] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"457.788851ms","start":"2026-06-30T08:31:16.985034Z","end":"2026-06-30T08:31:17.442823Z","steps":["trace[1580641610] 'process raft request' (duration: 457.587076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:17.443007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:16.985013Z","time spent":"457.921914ms","remote":"127.0.0.1:52190","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-06-30T08:31:17.443025Z","caller":"traceutil/trace.go:171","msg":"trace[2078627324] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1053; }","duration":"421.94103ms","start":"2026-06-30T08:31:17.021042Z","end":"2026-06-30T08:31:17.442983Z","steps":["trace[2078627324] 'read index received' (duration: 171.274045ms)","trace[2078627324] 'applied index is now lower than readState.Index' (duration: 250.664915ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:17.443145Z","caller":"traceutil/trace.go:171","msg":"trace[1668497009] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"458.055288ms","start":"2026-06-30T08:31:16.985061Z","end":"2026-06-30T08:31:17.443117Z","steps":["trace[1668497009] 'process raft request' (duration: 457.692489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:17.44321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.171166ms","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-06-30T08:31:17.443288Z","caller":"traceutil/trace.go:171","msg":"trace[1672165586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1017; }","duration":"422.293439ms","start":"2026-06-30T08:31:17.020979Z","end":"2026-06-30T08:31:17.443272Z","steps":["trace[1672165586] 'agreement among raft nodes before linearized reading' (duration: 422.101704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:17.443313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:16.985042Z","time spent":"458.17068ms","remote":"127.0.0.1:52190","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-06-30T08:31:17.44333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:17.020946Z","time spent":"422.372741ms","remote":"127.0.0.1:52190","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-06-30T08:31:19.701362Z","caller":"traceutil/trace.go:171","msg":"trace[1375929811] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1062; }","duration":"178.770137ms","start":"2026-06-30T08:31:19.522574Z","end":"2026-06-30T08:31:19.701344Z","steps":["trace[1375929811] 'read index received' (duration: 9.87859ms)","trace[1375929811] 'applied index is now lower than readState.Index' (duration: 168.890827ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:19.70145Z","caller":"traceutil/trace.go:171","msg":"trace[334090917] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"199.06219ms","start":"2026-06-30T08:31:19.502378Z","end":"2026-06-30T08:31:19.70144Z","steps":["trace[334090917] 'process raft request' (duration: 178.399948ms)","trace[334090917] 'compare' (duration: 20.467767ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:31:19.701538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.19773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T08:31:19.701613Z","caller":"traceutil/trace.go:171","msg":"trace[469787966] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1024; }","duration":"140.453366ms","start":"2026-06-30T08:31:19.561142Z","end":"2026-06-30T08:31:19.701595Z","steps":["trace[469787966] 'agreement among raft nodes before linearized reading' (duration: 140.312963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:19.701693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.102425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-30T08:31:19.701753Z","caller":"traceutil/trace.go:171","msg":"trace[408464081] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1024; }","duration":"179.194287ms","start":"2026-06-30T08:31:19.522544Z","end":"2026-06-30T08:31:19.701739Z","steps":["trace[408464081] 'agreement among raft nodes before linearized reading' (duration: 178.992793ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:41.563862Z","caller":"traceutil/trace.go:171","msg":"trace[754996523] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1136; }","duration":"369.244809ms","start":"2026-06-30T08:31:41.19459Z","end":"2026-06-30T08:31:41.563835Z","steps":["trace[754996523] 'read index received' (duration: 369.126336ms)","trace[754996523] 'applied index is now lower than readState.Index' (duration: 117.493µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:41.563997Z","caller":"traceutil/trace.go:171","msg":"trace[727995924] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"505.87979ms","start":"2026-06-30T08:31:41.058106Z","end":"2026-06-30T08:31:41.563986Z","steps":["trace[727995924] 'process raft request' (duration: 505.598644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:41.564099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:41.058082Z","time spent":"505.947482ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:31:41.564295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.695149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T08:31:41.56437Z","caller":"traceutil/trace.go:171","msg":"trace[2107932556] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1093; }","duration":"369.809662ms","start":"2026-06-30T08:31:41.19454Z","end":"2026-06-30T08:31:41.56435Z","steps":["trace[2107932556] 'agreement among raft nodes before linearized reading' (duration: 369.675139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:41.564425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:41.194519Z","time spent":"369.890604ms","remote":"127.0.0.1:52430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":28,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"info","ts":"2026-06-30T08:31:41.698003Z","caller":"traceutil/trace.go:171","msg":"trace[1630988069] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"129.674893ms","start":"2026-06-30T08:31:41.568269Z","end":"2026-06-30T08:31:41.697943Z","steps":["trace[1630988069] 'process raft request' (duration: 129.377456ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:43.930178Z","caller":"traceutil/trace.go:171","msg":"trace[868379691] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"360.220909ms","start":"2026-06-30T08:31:43.569932Z","end":"2026-06-30T08:31:43.930153Z","steps":["trace[868379691] 'process raft request' (duration: 360.090876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:43.930631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:43.569911Z","time spent":"360.64555ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:31:43.937317Z","caller":"traceutil/trace.go:171","msg":"trace[1088308857] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"234.479332ms","start":"2026-06-30T08:31:43.70282Z","end":"2026-06-30T08:31:43.937299Z","steps":["trace[1088308857] 'read index received' (duration: 227.475971ms)","trace[1088308857] 'applied index is now lower than readState.Index' (duration: 7.001961ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:43.93742Z","caller":"traceutil/trace.go:171","msg":"trace[741848127] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"312.457668ms","start":"2026-06-30T08:31:43.624951Z","end":"2026-06-30T08:31:43.937408Z","steps":["trace[741848127] 'process raft request' (duration: 312.266114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:43.937723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.859926ms","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-06-30T08:31:43.937874Z","caller":"traceutil/trace.go:171","msg":"trace[1442846101] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1101; }","duration":"227.038101ms","start":"2026-06-30T08:31:43.710807Z","end":"2026-06-30T08:31:43.937845Z","steps":["trace[1442846101] 'agreement among raft nodes before linearized reading' (duration: 226.690472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:43.938165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:31:43.624935Z","time spent":"312.514629ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:31:43.938451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.595639ms","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-06-30T08:31:43.938562Z","caller":"traceutil/trace.go:171","msg":"trace[1101423944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1101; }","duration":"235.754943ms","start":"2026-06-30T08:31:43.702779Z","end":"2026-06-30T08:31:43.938534Z","steps":["trace[1101423944] 'agreement among raft nodes before linearized reading' (duration: 235.356613ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:58.161355Z","caller":"traceutil/trace.go:171","msg":"trace[1129125077] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"116.593469ms","start":"2026-06-30T08:31:58.044738Z","end":"2026-06-30T08:31:58.161331Z","steps":["trace[1129125077] 'process raft request' (duration: 115.175635ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:58.169272Z","caller":"traceutil/trace.go:171","msg":"trace[1144725936] linearizableReadLoop","detail":"{readStateIndex:1247; appliedIndex:1243; }","duration":"109.943249ms","start":"2026-06-30T08:31:58.059307Z","end":"2026-06-30T08:31:58.169251Z","steps":["trace[1144725936] 'read index received' (duration: 100.533101ms)","trace[1144725936] 'applied index is now lower than readState.Index' (duration: 9.409148ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:31:58.169521Z","caller":"traceutil/trace.go:171","msg":"trace[1140755710] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"124.717796ms","start":"2026-06-30T08:31:58.044785Z","end":"2026-06-30T08:31:58.169503Z","steps":["trace[1140755710] 'process raft request' (duration: 124.271885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:31:58.16955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.228215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T08:31:58.169595Z","caller":"traceutil/trace.go:171","msg":"trace[411412280] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1198; }","duration":"110.39289ms","start":"2026-06-30T08:31:58.059189Z","end":"2026-06-30T08:31:58.169582Z","steps":["trace[411412280] 'agreement among raft nodes before linearized reading' (duration: 110.158764ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:58.169647Z","caller":"traceutil/trace.go:171","msg":"trace[467186883] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"124.782147ms","start":"2026-06-30T08:31:58.044831Z","end":"2026-06-30T08:31:58.169613Z","steps":["trace[467186883] 'process raft request' (duration: 124.344697ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:31:58.169688Z","caller":"traceutil/trace.go:171","msg":"trace[1204524492] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"124.606603ms","start":"2026-06-30T08:31:58.045034Z","end":"2026-06-30T08:31:58.169641Z","steps":["trace[1204524492] 'process raft request' (duration: 124.181043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:02.674774Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881964371328098,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T08:32:02.745198Z","caller":"traceutil/trace.go:171","msg":"trace[872347798] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"693.316798ms","start":"2026-06-30T08:32:02.051855Z","end":"2026-06-30T08:32:02.745171Z","steps":["trace[872347798] 'process raft request' (duration: 693.096102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:02.745351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:02.05183Z","time spent":"693.442351ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:32:02.767328Z","caller":"traceutil/trace.go:171","msg":"trace[1081384835] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"544.342085ms","start":"2026-06-30T08:32:02.222959Z","end":"2026-06-30T08:32:02.767301Z","steps":["trace[1081384835] 'process raft request' (duration: 544.113199ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:02.767332Z","caller":"traceutil/trace.go:171","msg":"trace[1957161202] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1260; }","duration":"593.177666ms","start":"2026-06-30T08:32:02.174041Z","end":"2026-06-30T08:32:02.767219Z","steps":["trace[1957161202] 'read index received' (duration: 570.951778ms)","trace[1957161202] 'applied index is now lower than readState.Index' (duration: 22.224928ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:32:02.76743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:02.222936Z","time spent":"544.440137ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:32:02.76759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.143705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-06-30T08:32:02.767586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.527474ms","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-06-30T08:32:02.767645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.818932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T08:32:02.767643Z","caller":"traceutil/trace.go:171","msg":"trace[1843928431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1212; }","duration":"593.641736ms","start":"2026-06-30T08:32:02.173988Z","end":"2026-06-30T08:32:02.767629Z","steps":["trace[1843928431] 'agreement among raft nodes before linearized reading' (duration: 593.460772ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:02.76766Z","caller":"traceutil/trace.go:171","msg":"trace[1850948148] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1212; }","duration":"581.851612ms","start":"2026-06-30T08:32:02.185805Z","end":"2026-06-30T08:32:02.767656Z","steps":["trace[1850948148] 'agreement among raft nodes before linearized reading' (duration: 581.810271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:02.767675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:02.185796Z","time spent":"581.876513ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T08:32:02.76768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:02.173969Z","time spent":"593.702889ms","remote":"127.0.0.1:52190","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-06-30T08:32:02.767781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.417808ms","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-06-30T08:32:02.767794Z","caller":"traceutil/trace.go:171","msg":"trace[1039956072] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1212; }","duration":"585.448369ms","start":"2026-06-30T08:32:02.182341Z","end":"2026-06-30T08:32:02.76779Z","steps":["trace[1039956072] 'agreement among raft nodes before linearized reading' (duration: 585.411018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:02.767806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:02.182333Z","time spent":"585.46988ms","remote":"127.0.0.1:52190","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":"info","ts":"2026-06-30T08:32:02.767606Z","caller":"traceutil/trace.go:171","msg":"trace[1279213671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1212; }","duration":"586.198557ms","start":"2026-06-30T08:32:02.181403Z","end":"2026-06-30T08:32:02.767601Z","steps":["trace[1279213671] 'agreement among raft nodes before linearized reading' (duration: 586.110265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:02.767853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:02.181381Z","time spent":"586.468774ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":525,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T08:32:02.767823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.249955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-30T08:32:02.767899Z","caller":"traceutil/trace.go:171","msg":"trace[190075016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1212; }","duration":"585.346607ms","start":"2026-06-30T08:32:02.182535Z","end":"2026-06-30T08:32:02.767882Z","steps":["trace[190075016] 'agreement among raft nodes before linearized reading' (duration: 585.161832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:02.767936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:02.182529Z","time spent":"585.399188ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T08:32:02.897672Z","caller":"traceutil/trace.go:171","msg":"trace[1370739930] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"124.709776ms","start":"2026-06-30T08:32:02.772933Z","end":"2026-06-30T08:32:02.897643Z","steps":["trace[1370739930] 'process raft request' (duration: 112.815528ms)","trace[1370739930] 'compare' (duration: 11.763465ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:32:02.901316Z","caller":"traceutil/trace.go:171","msg":"trace[266619885] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"128.313773ms","start":"2026-06-30T08:32:02.772981Z","end":"2026-06-30T08:32:02.901294Z","steps":["trace[266619885] 'process raft request' (duration: 128.161209ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:02.901336Z","caller":"traceutil/trace.go:171","msg":"trace[1455312291] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"127.76478ms","start":"2026-06-30T08:32:02.773556Z","end":"2026-06-30T08:32:02.901321Z","steps":["trace[1455312291] 'process raft request' (duration: 127.671317ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:02.9016Z","caller":"traceutil/trace.go:171","msg":"trace[274535412] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"127.33301ms","start":"2026-06-30T08:32:02.77423Z","end":"2026-06-30T08:32:02.901563Z","steps":["trace[274535412] 'process raft request' (duration: 127.033262ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:02.901628Z","caller":"traceutil/trace.go:171","msg":"trace[714942017] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"126.044909ms","start":"2026-06-30T08:32:02.775555Z","end":"2026-06-30T08:32:02.9016Z","steps":["trace[714942017] 'process raft request' (duration: 125.918205ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:15.125736Z","caller":"traceutil/trace.go:171","msg":"trace[445914983] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"107.466489ms","start":"2026-06-30T08:32:15.018242Z","end":"2026-06-30T08:32:15.125709Z","steps":["trace[445914983] 'process raft request' (duration: 102.273893ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:15.127633Z","caller":"traceutil/trace.go:171","msg":"trace[971824568] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1306; }","duration":"108.923544ms","start":"2026-06-30T08:32:15.018687Z","end":"2026-06-30T08:32:15.12761Z","steps":["trace[971824568] 'read index received' (duration: 101.840263ms)","trace[971824568] 'applied index is now lower than readState.Index' (duration: 7.082241ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:32:15.127659Z","caller":"traceutil/trace.go:171","msg":"trace[1086319899] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"109.081048ms","start":"2026-06-30T08:32:15.018561Z","end":"2026-06-30T08:32:15.127642Z","steps":["trace[1086319899] 'process raft request' (duration: 108.916464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:15.127866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.156521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T08:32:15.1279Z","caller":"traceutil/trace.go:171","msg":"trace[1598671293] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1255; }","duration":"109.234552ms","start":"2026-06-30T08:32:15.018655Z","end":"2026-06-30T08:32:15.12789Z","steps":["trace[1598671293] 'agreement among raft nodes before linearized reading' (duration: 109.090768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:19.028687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:18.613966Z","time spent":"414.711489ms","remote":"127.0.0.1:51966","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-30T08:32:19.983448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.883257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:32:19.983648Z","caller":"traceutil/trace.go:171","msg":"trace[2040539023] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"953.579302ms","start":"2026-06-30T08:32:19.030047Z","end":"2026-06-30T08:32:19.983627Z","steps":["trace[2040539023] 'process raft request' (duration: 953.49412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:19.983712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:19.03003Z","time spent":"953.653034ms","remote":"127.0.0.1:51966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:32:19.983612Z","caller":"traceutil/trace.go:171","msg":"trace[1840260763] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"1.088171297s","start":"2026-06-30T08:32:18.895376Z","end":"2026-06-30T08:32:19.983547Z","steps":["trace[1840260763] 'process raft request' (duration: 352.111966ms)","trace[1840260763] 'compare' (duration: 735.565169ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:32:19.983881Z","caller":"traceutil/trace.go:171","msg":"trace[1231751649] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1336; }","duration":"957.334833ms","start":"2026-06-30T08:32:19.026533Z","end":"2026-06-30T08:32:19.983868Z","steps":["trace[1231751649] 'read index received' (duration: 1.864685ms)","trace[1231751649] 'applied index is now lower than readState.Index' (duration: 955.468898ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:32:19.983904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:18.895351Z","time spent":"1.088428494s","remote":"127.0.0.1:52190","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-06-30T08:32:19.984054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.528637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-30T08:32:19.984084Z","caller":"traceutil/trace.go:171","msg":"trace[80465250] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1285; }","duration":"957.60702ms","start":"2026-06-30T08:32:19.026469Z","end":"2026-06-30T08:32:19.984076Z","steps":["trace[80465250] 'agreement among raft nodes before linearized reading' (duration: 957.483977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:19.98411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:19.026444Z","time spent":"957.65834ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":525,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-30T08:32:19.984235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.924498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-30T08:32:19.984235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.668361ms","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-06-30T08:32:19.984267Z","caller":"traceutil/trace.go:171","msg":"trace[1298893345] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1285; }","duration":"810.00071ms","start":"2026-06-30T08:32:19.174259Z","end":"2026-06-30T08:32:19.984259Z","steps":["trace[1298893345] 'agreement among raft nodes before linearized reading' (duration: 809.911268ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:19.984273Z","caller":"traceutil/trace.go:171","msg":"trace[1130936849] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1285; }","duration":"809.728183ms","start":"2026-06-30T08:32:19.174534Z","end":"2026-06-30T08:32:19.984262Z","steps":["trace[1130936849] 'agreement among raft nodes before linearized reading' (duration: 809.627681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:19.984289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:19.174238Z","time spent":"810.044361ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T08:32:19.984252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.155323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T08:32:19.984303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:19.174522Z","time spent":"809.774634ms","remote":"127.0.0.1:52190","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-06-30T08:32:19.984315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.187619ms","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-06-30T08:32:19.984329Z","caller":"traceutil/trace.go:171","msg":"trace[2047430135] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1285; }","duration":"270.249026ms","start":"2026-06-30T08:32:19.714063Z","end":"2026-06-30T08:32:19.984312Z","steps":["trace[2047430135] 'agreement among raft nodes before linearized reading' (duration: 270.110013ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:19.984366Z","caller":"traceutil/trace.go:171","msg":"trace[952897308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1285; }","duration":"816.279671ms","start":"2026-06-30T08:32:19.168074Z","end":"2026-06-30T08:32:19.984353Z","steps":["trace[952897308] 'agreement among raft nodes before linearized reading' (duration: 816.078337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:19.984399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.069593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-30T08:32:19.984402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:19.168051Z","time spent":"816.345003ms","remote":"127.0.0.1:52190","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":"info","ts":"2026-06-30T08:32:19.984507Z","caller":"traceutil/trace.go:171","msg":"trace[784351860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1285; }","duration":"815.227867ms","start":"2026-06-30T08:32:19.16926Z","end":"2026-06-30T08:32:19.984488Z","steps":["trace[784351860] 'agreement among raft nodes before linearized reading' (duration: 814.926669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:19.984556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:19.169248Z","time spent":"815.297838ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-30T08:32:20.135618Z","caller":"traceutil/trace.go:171","msg":"trace[1128334135] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"146.80725ms","start":"2026-06-30T08:32:19.988783Z","end":"2026-06-30T08:32:20.13559Z","steps":["trace[1128334135] 'process raft request' (duration: 142.934977ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:20.169053Z","caller":"traceutil/trace.go:171","msg":"trace[1208045887] linearizableReadLoop","detail":"{readStateIndex:1342; appliedIndex:1339; }","duration":"179.379418ms","start":"2026-06-30T08:32:19.989649Z","end":"2026-06-30T08:32:20.169028Z","steps":["trace[1208045887] 'read index received' (duration: 142.083236ms)","trace[1208045887] 'applied index is now lower than readState.Index' (duration: 37.295242ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:32:20.169239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.534882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-30T08:32:20.169324Z","caller":"traceutil/trace.go:171","msg":"trace[1761543891] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1290; }","duration":"179.678876ms","start":"2026-06-30T08:32:19.989633Z","end":"2026-06-30T08:32:20.169312Z","steps":["trace[1761543891] 'agreement among raft nodes before linearized reading' (duration: 179.489901ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:20.169489Z","caller":"traceutil/trace.go:171","msg":"trace[1453539635] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"179.938102ms","start":"2026-06-30T08:32:19.989508Z","end":"2026-06-30T08:32:20.169446Z","steps":["trace[1453539635] 'process raft request' (duration: 179.41964ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:20.169612Z","caller":"traceutil/trace.go:171","msg":"trace[1382573186] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"179.232945ms","start":"2026-06-30T08:32:19.990367Z","end":"2026-06-30T08:32:20.1696Z","steps":["trace[1382573186] 'process raft request' (duration: 178.592749ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:20.169725Z","caller":"traceutil/trace.go:171","msg":"trace[438488620] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"178.672961ms","start":"2026-06-30T08:32:19.991036Z","end":"2026-06-30T08:32:20.169709Z","steps":["trace[438488620] 'process raft request' (duration: 177.960144ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:20.169822Z","caller":"traceutil/trace.go:171","msg":"trace[1289360638] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"180.337152ms","start":"2026-06-30T08:32:19.989462Z","end":"2026-06-30T08:32:20.169799Z","steps":["trace[1289360638] 'process raft request' (duration: 179.332697ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:22.20238Z","caller":"traceutil/trace.go:171","msg":"trace[1004320861] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"213.352ms","start":"2026-06-30T08:32:21.989005Z","end":"2026-06-30T08:32:22.202357Z","steps":["trace[1004320861] 'process raft request' (duration: 212.864098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:22.393167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.236447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:32:22.393314Z","caller":"traceutil/trace.go:171","msg":"trace[1029655437] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"187.024492ms","start":"2026-06-30T08:32:22.206262Z","end":"2026-06-30T08:32:22.393286Z","steps":["trace[1029655437] 'process raft request' (duration: 47.483558ms)","trace[1029655437] 'compare' (duration: 139.131334ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:32:22.74759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.436915ms","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-06-30T08:32:22.747746Z","caller":"traceutil/trace.go:171","msg":"trace[584511546] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1292; }","duration":"197.63834ms","start":"2026-06-30T08:32:22.550081Z","end":"2026-06-30T08:32:22.74772Z","steps":["trace[584511546] 'range keys from in-memory index tree' (duration: 197.412034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:22.74776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.218779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:32:22.747971Z","caller":"traceutil/trace.go:171","msg":"trace[1200377823] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"537.675063ms","start":"2026-06-30T08:32:22.210282Z","end":"2026-06-30T08:32:22.747957Z","steps":["trace[1200377823] 'process raft request' (duration: 537.649542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:22.748013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:22.210227Z","time spent":"537.768064ms","remote":"127.0.0.1:52190","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-06-30T08:32:22.748045Z","caller":"traceutil/trace.go:171","msg":"trace[1706127651] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"541.575847ms","start":"2026-06-30T08:32:22.206441Z","end":"2026-06-30T08:32:22.748017Z","steps":["trace[1706127651] 'process raft request' (duration: 423.03025ms)","trace[1706127651] 'compare' (duration: 117.990384ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:32:22.748176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:22.206416Z","time spent":"541.678909ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:32:22.748219Z","caller":"traceutil/trace.go:171","msg":"trace[1972201618] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"541.68874ms","start":"2026-06-30T08:32:22.206526Z","end":"2026-06-30T08:32:22.748214Z","steps":["trace[1972201618] 'process raft request' (duration: 541.386862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:22.748257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:22.206517Z","time spent":"541.71611ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:32:22.7482Z","caller":"traceutil/trace.go:171","msg":"trace[1304339279] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"541.71522ms","start":"2026-06-30T08:32:22.206478Z","end":"2026-06-30T08:32:22.748193Z","steps":["trace[1304339279] 'process raft request' (duration: 541.353341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:22.748376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:22.206461Z","time spent":"541.899784ms","remote":"127.0.0.1:52190","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-06-30T08:32:23.32811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.879263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:32:23.328178Z","caller":"traceutil/trace.go:171","msg":"trace[2140211450] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1296; }","duration":"335.984276ms","start":"2026-06-30T08:32:22.992178Z","end":"2026-06-30T08:32:23.328162Z","steps":["trace[2140211450] 'count revisions from in-memory index tree' (duration: 335.817851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:23.328208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:22.992166Z","time spent":"336.035277ms","remote":"127.0.0.1:52402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":26,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-30T08:32:23.328503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.241383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:32:23.328639Z","caller":"traceutil/trace.go:171","msg":"trace[1448056509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1296; }","duration":"408.397757ms","start":"2026-06-30T08:32:22.920205Z","end":"2026-06-30T08:32:23.328603Z","steps":["trace[1448056509] 'range keys from in-memory index tree' (duration: 408.183962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:23.328714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:22.920188Z","time spent":"408.51322ms","remote":"127.0.0.1:51934","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-06-30T08:32:23.328804Z","caller":"traceutil/trace.go:171","msg":"trace[593964388] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"247.495736ms","start":"2026-06-30T08:32:23.081298Z","end":"2026-06-30T08:32:23.328793Z","steps":["trace[593964388] 'process raft request' (duration: 205.313456ms)","trace[593964388] 'compare' (duration: 41.942084ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:32:23.889627Z","caller":"traceutil/trace.go:171","msg":"trace[129624876] linearizableReadLoop","detail":"{readStateIndex:1352; appliedIndex:1351; }","duration":"395.878644ms","start":"2026-06-30T08:32:23.49373Z","end":"2026-06-30T08:32:23.889609Z","steps":["trace[129624876] 'read index received' (duration: 395.744051ms)","trace[129624876] 'applied index is now lower than readState.Index' (duration: 133.793µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:32:23.889727Z","caller":"traceutil/trace.go:171","msg":"trace[836894724] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"424.340283ms","start":"2026-06-30T08:32:23.465376Z","end":"2026-06-30T08:32:23.889716Z","steps":["trace[836894724] 'process raft request' (duration: 424.115498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:23.889822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:23.465351Z","time spent":"424.400174ms","remote":"127.0.0.1:52016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:32:23.890034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.283464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:32:23.890097Z","caller":"traceutil/trace.go:171","msg":"trace[1299994988] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1298; }","duration":"396.393527ms","start":"2026-06-30T08:32:23.493689Z","end":"2026-06-30T08:32:23.890083Z","steps":["trace[1299994988] 'agreement among raft nodes before linearized reading' (duration: 396.257614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:23.890119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:23.493673Z","time spent":"396.441109ms","remote":"127.0.0.1:52028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-06-30T08:32:32.399009Z","caller":"traceutil/trace.go:171","msg":"trace[1541903611] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"358.595493ms","start":"2026-06-30T08:32:32.040389Z","end":"2026-06-30T08:32:32.398984Z","steps":["trace[1541903611] 'process raft request' (duration: 358.431259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:32.399414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.040373Z","time spent":"358.722336ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:32:32.652394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.448608ms","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-06-30T08:32:32.652535Z","caller":"traceutil/trace.go:171","msg":"trace[1006865812] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1366; }","duration":"102.636382ms","start":"2026-06-30T08:32:32.54988Z","end":"2026-06-30T08:32:32.652516Z","steps":["trace[1006865812] 'range keys from in-memory index tree' (duration: 102.422947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:32.652625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.173448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:32:32.652753Z","caller":"traceutil/trace.go:171","msg":"trace[1425395157] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1422; }","duration":"219.785686ms","start":"2026-06-30T08:32:32.432947Z","end":"2026-06-30T08:32:32.652733Z","steps":["trace[1425395157] 'read index received' (duration: 82.338401ms)","trace[1425395157] 'applied index is now lower than readState.Index' (duration: 137.445385ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:32:32.652939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.98745ms","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-06-30T08:32:32.652989Z","caller":"traceutil/trace.go:171","msg":"trace[366365811] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1367; }","duration":"220.083853ms","start":"2026-06-30T08:32:32.432894Z","end":"2026-06-30T08:32:32.652978Z","steps":["trace[366365811] 'agreement among raft nodes before linearized reading' (duration: 219.908738ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:32:32.652882Z","caller":"traceutil/trace.go:171","msg":"trace[395722290] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"421.611717ms","start":"2026-06-30T08:32:32.231165Z","end":"2026-06-30T08:32:32.652777Z","steps":["trace[395722290] 'process raft request' (duration: 284.192473ms)","trace[395722290] 'compare' (duration: 137.039834ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:32:32.653222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.231134Z","time spent":"421.967505ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:32:33.293001Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920881964371328426,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T08:32:33.729501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.161997ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:32:33.729655Z","caller":"traceutil/trace.go:171","msg":"trace[1807485813] linearizableReadLoop","detail":"{readStateIndex:1424; appliedIndex:1423; }","duration":"936.864907ms","start":"2026-06-30T08:32:32.79276Z","end":"2026-06-30T08:32:33.729624Z","steps":["trace[1807485813] 'read index received' (duration: 756.600877ms)","trace[1807485813] 'applied index is now lower than readState.Index' (duration: 180.26216ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:32:33.729705Z","caller":"traceutil/trace.go:171","msg":"trace[1742756055] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"1.072475376s","start":"2026-06-30T08:32:32.657204Z","end":"2026-06-30T08:32:33.729679Z","steps":["trace[1742756055] 'process raft request' (duration: 892.066973ms)","trace[1742756055] 'compare' (duration: 179.812099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:32:33.729818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.657181Z","time spent":"1.072580029s","remote":"127.0.0.1:52190","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-06-30T08:32:33.72989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.110973ms","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-06-30T08:32:33.729929Z","caller":"traceutil/trace.go:171","msg":"trace[577659538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1368; }","duration":"937.194885ms","start":"2026-06-30T08:32:32.792724Z","end":"2026-06-30T08:32:33.729919Z","steps":["trace[577659538] 'agreement among raft nodes before linearized reading' (duration: 936.99303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.729969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.792707Z","time spent":"937.254026ms","remote":"127.0.0.1:52190","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-06-30T08:32:33.73198Z","caller":"traceutil/trace.go:171","msg":"trace[1933112391] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"201.031432ms","start":"2026-06-30T08:32:33.530925Z","end":"2026-06-30T08:32:33.731957Z","steps":["trace[1933112391] 'process raft request' (duration: 200.901929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.732375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.439974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:32:33.732422Z","caller":"traceutil/trace.go:171","msg":"trace[331997660] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1369; }","duration":"811.525475ms","start":"2026-06-30T08:32:32.920885Z","end":"2026-06-30T08:32:33.73241Z","steps":["trace[331997660] 'agreement among raft nodes before linearized reading' (duration: 811.442193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.732424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.604973ms","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-06-30T08:32:33.732454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.92087Z","time spent":"811.577217ms","remote":"127.0.0.1:51934","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-06-30T08:32:33.732437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.726523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:32:33.732517Z","caller":"traceutil/trace.go:171","msg":"trace[2100299015] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1369; }","duration":"152.853906ms","start":"2026-06-30T08:32:33.57964Z","end":"2026-06-30T08:32:33.732494Z","steps":["trace[2100299015] 'agreement among raft nodes before linearized reading' (duration: 152.728743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.732512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.68244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:32:33.732747Z","caller":"traceutil/trace.go:171","msg":"trace[835290926] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1369; }","duration":"938.953627ms","start":"2026-06-30T08:32:32.793781Z","end":"2026-06-30T08:32:33.732734Z","steps":["trace[835290926] 'agreement among raft nodes before linearized reading' (duration: 938.614769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.732779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.793759Z","time spent":"939.011689ms","remote":"127.0.0.1:52190","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":"info","ts":"2026-06-30T08:32:33.732532Z","caller":"traceutil/trace.go:171","msg":"trace[199609533] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1369; }","duration":"939.673475ms","start":"2026-06-30T08:32:32.792791Z","end":"2026-06-30T08:32:33.732465Z","steps":["trace[199609533] 'agreement among raft nodes before linearized reading' (duration: 939.528601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.732883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.240712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"warn","ts":"2026-06-30T08:32:33.732908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.792786Z","time spent":"940.115045ms","remote":"127.0.0.1:52190","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-06-30T08:32:33.732585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.211179ms","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-06-30T08:32:33.73301Z","caller":"traceutil/trace.go:171","msg":"trace[1298552828] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1369; }","duration":"864.662051ms","start":"2026-06-30T08:32:32.868337Z","end":"2026-06-30T08:32:33.732999Z","steps":["trace[1298552828] 'agreement among raft nodes before linearized reading' (duration: 864.2279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.733032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.868303Z","time spent":"864.722802ms","remote":"127.0.0.1:49948","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-30T08:32:33.732627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.797158ms","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-06-30T08:32:33.733144Z","caller":"traceutil/trace.go:171","msg":"trace[1757307713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1369; }","duration":"940.350941ms","start":"2026-06-30T08:32:32.792784Z","end":"2026-06-30T08:32:33.733135Z","steps":["trace[1757307713] 'agreement among raft nodes before linearized reading' (duration: 939.784087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.733172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:32.792762Z","time spent":"940.402153ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-30T08:32:33.733279Z","caller":"traceutil/trace.go:171","msg":"trace[1555300316] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1369; }","duration":"496.321124ms","start":"2026-06-30T08:32:33.23659Z","end":"2026-06-30T08:32:33.732911Z","steps":["trace[1555300316] 'agreement among raft nodes before linearized reading' (duration: 495.981555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:32:33.733547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:32:33.236566Z","time spent":"496.750353ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-30T08:33:05.090771Z","caller":"traceutil/trace.go:171","msg":"trace[1793733746] linearizableReadLoop","detail":"{readStateIndex:1579; appliedIndex:1578; }","duration":"169.165709ms","start":"2026-06-30T08:33:04.92159Z","end":"2026-06-30T08:33:05.090756Z","steps":["trace[1793733746] 'read index received' (duration: 169.025596ms)","trace[1793733746] 'applied index is now lower than readState.Index' (duration: 139.583µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:33:05.090997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.379124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:33:05.091138Z","caller":"traceutil/trace.go:171","msg":"trace[735258406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1516; }","duration":"169.558139ms","start":"2026-06-30T08:33:04.921561Z","end":"2026-06-30T08:33:05.091119Z","steps":["trace[735258406] 'agreement among raft nodes before linearized reading' (duration: 169.346624ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:33:05.091164Z","caller":"traceutil/trace.go:171","msg":"trace[798906941] transaction","detail":"{read_only:false; response_revision:1516; number_of_response:1; }","duration":"216.50167ms","start":"2026-06-30T08:33:04.874597Z","end":"2026-06-30T08:33:05.091099Z","steps":["trace[798906941] 'process raft request' (duration: 216.06562ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:33:18.1997Z","caller":"traceutil/trace.go:171","msg":"trace[1482731153] linearizableReadLoop","detail":"{readStateIndex:1640; appliedIndex:1638; }","duration":"130.945647ms","start":"2026-06-30T08:33:18.068732Z","end":"2026-06-30T08:33:18.199678Z","steps":["trace[1482731153] 'read index received' (duration: 27.276577ms)","trace[1482731153] 'applied index is now lower than readState.Index' (duration: 103.66827ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:33:18.199727Z","caller":"traceutil/trace.go:171","msg":"trace[322225216] transaction","detail":"{read_only:false; response_revision:1575; number_of_response:1; }","duration":"132.230909ms","start":"2026-06-30T08:33:18.067469Z","end":"2026-06-30T08:33:18.199699Z","steps":["trace[322225216] 'process raft request' (duration: 60.821427ms)","trace[322225216] 'compare' (duration: 71.290759ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:33:18.199956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.821544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-30T08:33:18.199964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.207103ms","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-06-30T08:33:18.200023Z","caller":"traceutil/trace.go:171","msg":"trace[1032725326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1575; }","duration":"130.895777ms","start":"2026-06-30T08:33:18.069101Z","end":"2026-06-30T08:33:18.199997Z","steps":["trace[1032725326] 'agreement among raft nodes before linearized reading' (duration: 130.716812ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:33:18.200038Z","caller":"traceutil/trace.go:171","msg":"trace[1481461530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1575; }","duration":"131.301836ms","start":"2026-06-30T08:33:18.068717Z","end":"2026-06-30T08:33:18.200019Z","steps":["trace[1481461530] 'agreement among raft nodes before linearized reading' (duration: 131.079831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:33:26.271458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.003601ms","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-06-30T08:33:26.271521Z","caller":"traceutil/trace.go:171","msg":"trace[2007674262] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1611; }","duration":"129.089603ms","start":"2026-06-30T08:33:26.142418Z","end":"2026-06-30T08:33:26.271507Z","steps":["trace[2007674262] 'range keys from in-memory index tree' (duration: 128.924479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:33:27.556448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.201561ms","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":"info","ts":"2026-06-30T08:33:27.556588Z","caller":"traceutil/trace.go:171","msg":"trace[1482471359] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1618; }","duration":"140.387846ms","start":"2026-06-30T08:33:27.416185Z","end":"2026-06-30T08:33:27.556573Z","steps":["trace[1482471359] 'count revisions from in-memory index tree' (duration: 140.111149ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:34:01.152905Z","caller":"traceutil/trace.go:171","msg":"trace[393573200] transaction","detail":"{read_only:false; response_revision:1773; number_of_response:1; }","duration":"118.453288ms","start":"2026-06-30T08:34:01.03443Z","end":"2026-06-30T08:34:01.152884Z","steps":["trace[393573200] 'process raft request' (duration: 118.327455ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:34:02.717454Z","caller":"traceutil/trace.go:171","msg":"trace[860589171] linearizableReadLoop","detail":"{readStateIndex:1851; appliedIndex:1850; }","duration":"115.23673ms","start":"2026-06-30T08:34:02.602186Z","end":"2026-06-30T08:34:02.717422Z","steps":["trace[860589171] 'read index received' (duration: 115.059646ms)","trace[860589171] 'applied index is now lower than readState.Index' (duration: 175.464µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:34:02.7176Z","caller":"traceutil/trace.go:171","msg":"trace[1827236696] transaction","detail":"{read_only:false; response_revision:1777; number_of_response:1; }","duration":"122.073755ms","start":"2026-06-30T08:34:02.595467Z","end":"2026-06-30T08:34:02.717541Z","steps":["trace[1827236696] 'process raft request' (duration: 121.778178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:34:02.717797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.572088ms","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-06-30T08:34:02.717889Z","caller":"traceutil/trace.go:171","msg":"trace[1723381893] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1777; }","duration":"115.677561ms","start":"2026-06-30T08:34:02.602166Z","end":"2026-06-30T08:34:02.717843Z","steps":["trace[1723381893] 'agreement among raft nodes before linearized reading' (duration: 115.360404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:34:03.032511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.419446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:34:03.032651Z","caller":"traceutil/trace.go:171","msg":"trace[1256402026] linearizableReadLoop","detail":"{readStateIndex:1852; appliedIndex:1851; }","duration":"295.672504ms","start":"2026-06-30T08:34:02.736943Z","end":"2026-06-30T08:34:03.032615Z","steps":["trace[1256402026] 'read index received' (duration: 136.178976ms)","trace[1256402026] 'applied index is now lower than readState.Index' (duration: 159.491948ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:34:03.032702Z","caller":"traceutil/trace.go:171","msg":"trace[1226856381] transaction","detail":"{read_only:false; response_revision:1778; number_of_response:1; }","duration":"310.911031ms","start":"2026-06-30T08:34:02.721734Z","end":"2026-06-30T08:34:03.032645Z","steps":["trace[1226856381] 'process raft request' (duration: 151.253609ms)","trace[1226856381] 'compare' (duration: 159.282683ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:34:03.032932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.982641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:34:03.03301Z","caller":"traceutil/trace.go:171","msg":"trace[1365695448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1778; }","duration":"296.112584ms","start":"2026-06-30T08:34:02.736879Z","end":"2026-06-30T08:34:03.032991Z","steps":["trace[1365695448] 'agreement among raft nodes before linearized reading' (duration: 295.857568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:34:03.033009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.343981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:34:03.033067Z","caller":"traceutil/trace.go:171","msg":"trace[1850600668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1778; }","duration":"112.448153ms","start":"2026-06-30T08:34:02.920605Z","end":"2026-06-30T08:34:03.033053Z","steps":["trace[1850600668] 'agreement among raft nodes before linearized reading' (duration: 112.355101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:34:03.03303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:34:02.721695Z","time spent":"311.202458ms","remote":"127.0.0.1:52190","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-06-30T08:34:03.033184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.284105ms","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-06-30T08:34:03.033339Z","caller":"traceutil/trace.go:171","msg":"trace[1074299435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1778; }","duration":"259.449429ms","start":"2026-06-30T08:34:02.773824Z","end":"2026-06-30T08:34:03.033274Z","steps":["trace[1074299435] 'agreement among raft nodes before linearized reading' (duration: 259.077901ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:34:08.57735Z","caller":"traceutil/trace.go:171","msg":"trace[779441126] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"120.927568ms","start":"2026-06-30T08:34:08.456398Z","end":"2026-06-30T08:34:08.577326Z","steps":["trace[779441126] 'process raft request' (duration: 120.796205ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:34:09.233212Z","caller":"traceutil/trace.go:171","msg":"trace[739032927] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"121.02972ms","start":"2026-06-30T08:34:09.112153Z","end":"2026-06-30T08:34:09.233182Z","steps":["trace[739032927] 'process raft request' (duration: 120.835175ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:34:09.252479Z","caller":"traceutil/trace.go:171","msg":"trace[1703388063] linearizableReadLoop","detail":"{readStateIndex:1884; appliedIndex:1882; }","duration":"135.046758ms","start":"2026-06-30T08:34:09.11741Z","end":"2026-06-30T08:34:09.252457Z","steps":["trace[1703388063] 'read index received' (duration: 115.562978ms)","trace[1703388063] 'applied index is now lower than readState.Index' (duration: 19.48266ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:34:09.252737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.306094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-30T08:34:09.252813Z","caller":"traceutil/trace.go:171","msg":"trace[645213863] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1808; }","duration":"135.424537ms","start":"2026-06-30T08:34:09.117368Z","end":"2026-06-30T08:34:09.252792Z","steps":["trace[645213863] 'agreement among raft nodes before linearized reading' (duration: 135.201272ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:34:09.253104Z","caller":"traceutil/trace.go:171","msg":"trace[656702338] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"139.520896ms","start":"2026-06-30T08:34:09.113566Z","end":"2026-06-30T08:34:09.253087Z","steps":["trace[656702338] 'process raft request' (duration: 138.775819ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:34:37.176662Z","caller":"traceutil/trace.go:171","msg":"trace[1998702663] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"123.184102ms","start":"2026-06-30T08:34:37.053452Z","end":"2026-06-30T08:34:37.176636Z","steps":["trace[1998702663] 'process raft request' (duration: 123.004777ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:35:06.294229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.550274ms","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-06-30T08:35:06.294297Z","caller":"traceutil/trace.go:171","msg":"trace[1258056174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2066; }","duration":"357.672397ms","start":"2026-06-30T08:35:05.936609Z","end":"2026-06-30T08:35:06.294282Z","steps":["trace[1258056174] 'range keys from in-memory index tree' (duration: 357.38846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:35:06.294322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:35:05.936579Z","time spent":"357.737388ms","remote":"127.0.0.1:52190","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-06-30T08:35:06.294434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.614625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T08:35:06.294434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.710514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-30T08:35:06.294555Z","caller":"traceutil/trace.go:171","msg":"trace[676250144] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2066; }","duration":"208.882628ms","start":"2026-06-30T08:35:06.085651Z","end":"2026-06-30T08:35:06.294533Z","steps":["trace[676250144] 'range keys from in-memory index tree' (duration: 208.502929ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:35:06.294564Z","caller":"traceutil/trace.go:171","msg":"trace[1135701098] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2066; }","duration":"374.766409ms","start":"2026-06-30T08:35:05.919749Z","end":"2026-06-30T08:35:06.294515Z","steps":["trace[1135701098] 'range keys from in-memory index tree' (duration: 374.550684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:35:06.294651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:35:05.919732Z","time spent":"374.909592ms","remote":"127.0.0.1:51934","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-06-30T08:35:12.658197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.409405ms","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-06-30T08:35:12.658333Z","caller":"traceutil/trace.go:171","msg":"trace[2095770114] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2098; }","duration":"108.551538ms","start":"2026-06-30T08:35:12.549757Z","end":"2026-06-30T08:35:12.658309Z","steps":["trace[2095770114] 'range keys from in-memory index tree' (duration: 108.380174ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:35:17.660301Z","caller":"traceutil/trace.go:171","msg":"trace[1082728753] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"108.739762ms","start":"2026-06-30T08:35:17.551539Z","end":"2026-06-30T08:35:17.660278Z","steps":["trace[1082728753] 'process raft request' (duration: 108.63823ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:35:20.652Z","caller":"traceutil/trace.go:171","msg":"trace[350643212] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"134.996977ms","start":"2026-06-30T08:35:20.516977Z","end":"2026-06-30T08:35:20.651974Z","steps":["trace[350643212] 'process raft request' (duration: 134.827592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:35:51.218239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.241695ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:35:51.218342Z","caller":"traceutil/trace.go:171","msg":"trace[1748957840] transaction","detail":"{read_only:false; response_revision:2273; number_of_response:1; }","duration":"312.072997ms","start":"2026-06-30T08:35:50.906258Z","end":"2026-06-30T08:35:51.218331Z","steps":["trace[1748957840] 'process raft request' (duration: 95.678108ms)","trace[1748957840] 'compare' (duration: 216.109392ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:35:51.218374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:35:50.906242Z","time spent":"312.117708ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:35:51.218613Z","caller":"traceutil/trace.go:171","msg":"trace[1587341781] transaction","detail":"{read_only:false; response_revision:2274; number_of_response:1; }","duration":"311.693948ms","start":"2026-06-30T08:35:50.906908Z","end":"2026-06-30T08:35:51.218602Z","steps":["trace[1587341781] 'process raft request' (duration: 311.402481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:35:51.218659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:35:50.906885Z","time spent":"311.7523ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:35:52.29492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.095982ms","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-06-30T08:35:52.295017Z","caller":"traceutil/trace.go:171","msg":"trace[2046512150] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2277; }","duration":"182.249326ms","start":"2026-06-30T08:35:52.112749Z","end":"2026-06-30T08:35:52.294999Z","steps":["trace[2046512150] 'range keys from in-memory index tree' (duration: 181.866376ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:03.558833Z","caller":"traceutil/trace.go:171","msg":"trace[103213620] transaction","detail":"{read_only:false; response_revision:2328; number_of_response:1; }","duration":"224.076792ms","start":"2026-06-30T08:36:03.334735Z","end":"2026-06-30T08:36:03.558812Z","steps":["trace[103213620] 'process raft request' (duration: 223.950469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:03.692038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.703252ms","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-06-30T08:36:03.692143Z","caller":"traceutil/trace.go:171","msg":"trace[1745601537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2328; }","duration":"117.847755ms","start":"2026-06-30T08:36:03.57427Z","end":"2026-06-30T08:36:03.692118Z","steps":["trace[1745601537] 'range keys from in-memory index tree' (duration: 117.487547ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:05.88894Z","caller":"traceutil/trace.go:171","msg":"trace[662200601] transaction","detail":"{read_only:false; response_revision:2338; number_of_response:1; }","duration":"154.797749ms","start":"2026-06-30T08:36:05.734122Z","end":"2026-06-30T08:36:05.88892Z","steps":["trace[662200601] 'process raft request' (duration: 154.370389ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:09.654422Z","caller":"traceutil/trace.go:171","msg":"trace[149603710] transaction","detail":"{read_only:false; response_revision:2355; number_of_response:1; }","duration":"105.881457ms","start":"2026-06-30T08:36:09.548512Z","end":"2026-06-30T08:36:09.654393Z","steps":["trace[149603710] 'process raft request' (duration: 50.631272ms)","trace[149603710] 'compare' (duration: 55.074021ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:36:10.063264Z","caller":"traceutil/trace.go:171","msg":"trace[1441430395] transaction","detail":"{read_only:false; response_revision:2358; number_of_response:1; }","duration":"115.154481ms","start":"2026-06-30T08:36:09.948068Z","end":"2026-06-30T08:36:10.063223Z","steps":["trace[1441430395] 'process raft request' (duration: 88.640811ms)","trace[1441430395] 'compare' (duration: 26.320356ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:36:20.885612Z","caller":"traceutil/trace.go:171","msg":"trace[1839360000] transaction","detail":"{read_only:false; response_revision:2408; number_of_response:1; }","duration":"143.470235ms","start":"2026-06-30T08:36:20.742099Z","end":"2026-06-30T08:36:20.885569Z","steps":["trace[1839360000] 'process raft request' (duration: 135.489182ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:23.071685Z","caller":"traceutil/trace.go:171","msg":"trace[1227284160] transaction","detail":"{read_only:false; response_revision:2435; number_of_response:1; }","duration":"102.759583ms","start":"2026-06-30T08:36:22.968897Z","end":"2026-06-30T08:36:23.071656Z","steps":["trace[1227284160] 'process raft request' (duration: 38.641044ms)","trace[1227284160] 'compare' (duration: 63.991076ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:36:23.412682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.417888ms","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-06-30T08:36:23.412763Z","caller":"traceutil/trace.go:171","msg":"trace[648691406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2435; }","duration":"103.544501ms","start":"2026-06-30T08:36:23.309197Z","end":"2026-06-30T08:36:23.412741Z","steps":["trace[648691406] 'range keys from in-memory index tree' (duration: 103.248323ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:30.201059Z","caller":"traceutil/trace.go:171","msg":"trace[416168362] transaction","detail":"{read_only:false; response_revision:2467; number_of_response:1; }","duration":"102.591848ms","start":"2026-06-30T08:36:30.098433Z","end":"2026-06-30T08:36:30.201024Z","steps":["trace[416168362] 'process raft request' (duration: 102.231719ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:30.388267Z","caller":"traceutil/trace.go:171","msg":"trace[1522066420] transaction","detail":"{read_only:false; response_revision:2469; number_of_response:1; }","duration":"101.174994ms","start":"2026-06-30T08:36:30.287064Z","end":"2026-06-30T08:36:30.388239Z","steps":["trace[1522066420] 'process raft request' (duration: 77.364779ms)","trace[1522066420] 'compare' (duration: 23.493697ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:36:30.564484Z","caller":"traceutil/trace.go:171","msg":"trace[1200436630] transaction","detail":"{read_only:false; response_revision:2470; number_of_response:1; }","duration":"146.276053ms","start":"2026-06-30T08:36:30.418182Z","end":"2026-06-30T08:36:30.564458Z","steps":["trace[1200436630] 'process raft request' (duration: 143.284701ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:34.319463Z","caller":"traceutil/trace.go:171","msg":"trace[1443958572] transaction","detail":"{read_only:false; response_revision:2486; number_of_response:1; }","duration":"646.585307ms","start":"2026-06-30T08:36:33.672852Z","end":"2026-06-30T08:36:34.319437Z","steps":["trace[1443958572] 'process raft request' (duration: 646.418333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:34.319611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:36:33.672822Z","time spent":"646.71512ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:36:34.650981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.282157ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-06-30T08:36:34.651113Z","caller":"traceutil/trace.go:171","msg":"trace[2108299743] linearizableReadLoop","detail":"{readStateIndex:2592; appliedIndex:2590; }","duration":"731.495556ms","start":"2026-06-30T08:36:33.919595Z","end":"2026-06-30T08:36:34.65109Z","steps":["trace[2108299743] 'read index received' (duration: 399.657662ms)","trace[2108299743] 'applied index is now lower than readState.Index' (duration: 331.836154ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:36:34.651268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.6206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:36:34.651358Z","caller":"traceutil/trace.go:171","msg":"trace[1392540433] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2486; }","duration":"731.784833ms","start":"2026-06-30T08:36:33.919553Z","end":"2026-06-30T08:36:34.651338Z","steps":["trace[1392540433] 'agreement among raft nodes before linearized reading' (duration: 731.589639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:34.65141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:36:33.919535Z","time spent":"731.867176ms","remote":"127.0.0.1:51934","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-06-30T08:36:34.65143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.794147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T08:36:34.651494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.538831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-30T08:36:34.651619Z","caller":"traceutil/trace.go:171","msg":"trace[2038170384] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2486; }","duration":"149.989852ms","start":"2026-06-30T08:36:34.501554Z","end":"2026-06-30T08:36:34.651544Z","steps":["trace[2038170384] 'agreement among raft nodes before linearized reading' (duration: 149.736606ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:34.651685Z","caller":"traceutil/trace.go:171","msg":"trace[1465304545] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2486; }","duration":"650.661225ms","start":"2026-06-30T08:36:34.000894Z","end":"2026-06-30T08:36:34.651555Z","steps":["trace[1465304545] 'agreement among raft nodes before linearized reading' (duration: 650.332917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:34.651721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.88677ms","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-06-30T08:36:34.651842Z","caller":"traceutil/trace.go:171","msg":"trace[260269596] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2486; }","duration":"232.071675ms","start":"2026-06-30T08:36:34.419753Z","end":"2026-06-30T08:36:34.651824Z","steps":["trace[260269596] 'agreement among raft nodes before linearized reading' (duration: 231.623744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:34.65197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:36:34.000873Z","time spent":"650.947331ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-30T08:36:36.833636Z","caller":"traceutil/trace.go:171","msg":"trace[519791848] transaction","detail":"{read_only:false; response_revision:2498; number_of_response:1; }","duration":"110.97442ms","start":"2026-06-30T08:36:36.722638Z","end":"2026-06-30T08:36:36.833612Z","steps":["trace[519791848] 'process raft request' (duration: 110.836187ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:36.875407Z","caller":"traceutil/trace.go:171","msg":"trace[1331125797] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"152.288948ms","start":"2026-06-30T08:36:36.723088Z","end":"2026-06-30T08:36:36.875377Z","steps":["trace[1331125797] 'process raft request' (duration: 151.843728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:40.61801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.507426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:36:40.618129Z","caller":"traceutil/trace.go:171","msg":"trace[1968648445] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"193.122725ms","start":"2026-06-30T08:36:40.424985Z","end":"2026-06-30T08:36:40.618108Z","steps":["trace[1968648445] 'process raft request' (duration: 66.428375ms)","trace[1968648445] 'compare' (duration: 126.383442ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:36:41.103219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.553835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:36:41.103451Z","caller":"traceutil/trace.go:171","msg":"trace[982514894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2522; }","duration":"169.832752ms","start":"2026-06-30T08:36:40.933585Z","end":"2026-06-30T08:36:41.103418Z","steps":["trace[982514894] 'range keys from in-memory index tree' (duration: 169.492894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:41.103554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.588595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:36:41.10367Z","caller":"traceutil/trace.go:171","msg":"trace[1080079900] linearizableReadLoop","detail":"{readStateIndex:2630; appliedIndex:2629; }","duration":"162.966716ms","start":"2026-06-30T08:36:40.940682Z","end":"2026-06-30T08:36:41.103648Z","steps":["trace[1080079900] 'read index received' (duration: 56.117045ms)","trace[1080079900] 'applied index is now lower than readState.Index' (duration: 106.847991ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:36:41.103716Z","caller":"traceutil/trace.go:171","msg":"trace[27299186] transaction","detail":"{read_only:false; response_revision:2523; number_of_response:1; }","duration":"167.424144ms","start":"2026-06-30T08:36:40.936264Z","end":"2026-06-30T08:36:41.103688Z","steps":["trace[27299186] 'process raft request' (duration: 60.590393ms)","trace[27299186] 'compare' (duration: 106.123144ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:36:41.103876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.182391ms","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-06-30T08:36:41.103937Z","caller":"traceutil/trace.go:171","msg":"trace[27438438] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2523; }","duration":"163.258112ms","start":"2026-06-30T08:36:40.940665Z","end":"2026-06-30T08:36:41.103923Z","steps":["trace[27438438] 'agreement among raft nodes before linearized reading' (duration: 163.043557ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:41.316616Z","caller":"traceutil/trace.go:171","msg":"trace[1653213873] linearizableReadLoop","detail":"{readStateIndex:2631; appliedIndex:2630; }","duration":"198.689919ms","start":"2026-06-30T08:36:41.117899Z","end":"2026-06-30T08:36:41.316589Z","steps":["trace[1653213873] 'read index received' (duration: 198.590007ms)","trace[1653213873] 'applied index is now lower than readState.Index' (duration: 98.132µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:36:41.316686Z","caller":"traceutil/trace.go:171","msg":"trace[2021048987] transaction","detail":"{read_only:false; response_revision:2524; number_of_response:1; }","duration":"208.619649ms","start":"2026-06-30T08:36:41.108033Z","end":"2026-06-30T08:36:41.316653Z","steps":["trace[2021048987] 'process raft request' (duration: 208.383783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:41.316885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.978796ms","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-06-30T08:36:41.316944Z","caller":"traceutil/trace.go:171","msg":"trace[860838441] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2524; }","duration":"199.108849ms","start":"2026-06-30T08:36:41.117822Z","end":"2026-06-30T08:36:41.316931Z","steps":["trace[860838441] 'agreement among raft nodes before linearized reading' (duration: 198.886144ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:41.477868Z","caller":"traceutil/trace.go:171","msg":"trace[1613172702] transaction","detail":"{read_only:false; response_revision:2526; number_of_response:1; }","duration":"154.317207ms","start":"2026-06-30T08:36:41.323529Z","end":"2026-06-30T08:36:41.477846Z","steps":["trace[1613172702] 'process raft request' (duration: 154.267426ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:41.478136Z","caller":"traceutil/trace.go:171","msg":"trace[153151870] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"253.172125ms","start":"2026-06-30T08:36:41.224936Z","end":"2026-06-30T08:36:41.478108Z","steps":["trace[153151870] 'process raft request' (duration: 168.386677ms)","trace[153151870] 'compare' (duration: 84.362008ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:36:42.991795Z","caller":"traceutil/trace.go:171","msg":"trace[1804779205] transaction","detail":"{read_only:false; response_revision:2532; number_of_response:1; }","duration":"100.588239ms","start":"2026-06-30T08:36:42.891181Z","end":"2026-06-30T08:36:42.991769Z","steps":["trace[1804779205] 'process raft request' (duration: 100.388725ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:36:44.38731Z","caller":"traceutil/trace.go:171","msg":"trace[313495568] linearizableReadLoop","detail":"{readStateIndex:2645; appliedIndex:2644; }","duration":"463.146226ms","start":"2026-06-30T08:36:43.924139Z","end":"2026-06-30T08:36:44.387285Z","steps":["trace[313495568] 'read index received' (duration: 407.902531ms)","trace[313495568] 'applied index is now lower than readState.Index' (duration: 55.242275ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:36:44.387462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.30777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:36:44.387502Z","caller":"traceutil/trace.go:171","msg":"trace[1509222059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2537; }","duration":"463.410303ms","start":"2026-06-30T08:36:43.924081Z","end":"2026-06-30T08:36:44.387491Z","steps":["trace[1509222059] 'agreement among raft nodes before linearized reading' (duration: 463.31743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:36:44.387544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:36:43.92405Z","time spent":"463.486555ms","remote":"127.0.0.1:51934","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-06-30T08:37:00.626259Z","caller":"traceutil/trace.go:171","msg":"trace[1965934837] transaction","detail":"{read_only:false; response_revision:2618; number_of_response:1; }","duration":"113.127172ms","start":"2026-06-30T08:37:00.51311Z","end":"2026-06-30T08:37:00.626238Z","steps":["trace[1965934837] 'process raft request' (duration: 112.898837ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:37:05.739216Z","caller":"traceutil/trace.go:171","msg":"trace[583063119] transaction","detail":"{read_only:false; response_revision:2642; number_of_response:1; }","duration":"106.906022ms","start":"2026-06-30T08:37:05.632279Z","end":"2026-06-30T08:37:05.739185Z","steps":["trace[583063119] 'process raft request' (duration: 106.684817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:12.674615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.14614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-06-30T08:37:12.674685Z","caller":"traceutil/trace.go:171","msg":"trace[1500227197] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:2675; }","duration":"131.250223ms","start":"2026-06-30T08:37:12.543418Z","end":"2026-06-30T08:37:12.674668Z","steps":["trace[1500227197] 'range keys from in-memory index tree' (duration: 131.062079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:12.674545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.752747ms","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-06-30T08:37:12.675348Z","caller":"traceutil/trace.go:171","msg":"trace[1202611901] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2675; }","duration":"125.573666ms","start":"2026-06-30T08:37:12.54976Z","end":"2026-06-30T08:37:12.675333Z","steps":["trace[1202611901] 'range keys from in-memory index tree' (duration: 124.736386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:15.572287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.815211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-30T08:37:15.572375Z","caller":"traceutil/trace.go:171","msg":"trace[424502401] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:1; response_revision:2683; }","duration":"357.944584ms","start":"2026-06-30T08:37:15.214412Z","end":"2026-06-30T08:37:15.572357Z","steps":["trace[424502401] 'range keys from in-memory index tree' (duration: 357.694238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:15.572417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:37:15.214396Z","time spent":"358.012056ms","remote":"127.0.0.1:52124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":228,"request content":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" "} {"level":"warn","ts":"2026-06-30T08:37:15.572431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.450247ms","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-06-30T08:37:15.572476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.301992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-30T08:37:15.572504Z","caller":"traceutil/trace.go:171","msg":"trace[368569384] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2683; }","duration":"284.55508ms","start":"2026-06-30T08:37:15.287933Z","end":"2026-06-30T08:37:15.572488Z","steps":["trace[368569384] 'range keys from in-memory index tree' (duration: 284.321544ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:37:15.572542Z","caller":"traceutil/trace.go:171","msg":"trace[2087588623] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2683; }","duration":"262.412435ms","start":"2026-06-30T08:37:15.310113Z","end":"2026-06-30T08:37:15.572526Z","steps":["trace[2087588623] 'range keys from in-memory index tree' (duration: 262.156168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:15.572552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.08225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-30T08:37:15.572606Z","caller":"traceutil/trace.go:171","msg":"trace[1969472945] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2683; }","duration":"349.165371ms","start":"2026-06-30T08:37:15.223425Z","end":"2026-06-30T08:37:15.57259Z","steps":["trace[1969472945] 'range keys from in-memory index tree' (duration: 348.921506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:15.57264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:37:15.223408Z","time spent":"349.223293ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-30T08:37:15.572777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.337896ms","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-06-30T08:37:15.572827Z","caller":"traceutil/trace.go:171","msg":"trace[1747103515] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2683; }","duration":"167.400978ms","start":"2026-06-30T08:37:15.405405Z","end":"2026-06-30T08:37:15.572806Z","steps":["trace[1747103515] 'range keys from in-memory index tree' (duration: 167.232653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:15.57311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.595693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-30T08:37:15.573162Z","caller":"traceutil/trace.go:171","msg":"trace[576455955] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:1; response_revision:2683; }","duration":"421.684405ms","start":"2026-06-30T08:37:15.151465Z","end":"2026-06-30T08:37:15.57315Z","steps":["trace[576455955] 'range keys from in-memory index tree' (duration: 421.491461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:15.573197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:37:15.151448Z","time spent":"421.742227ms","remote":"127.0.0.1:52124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":235,"request content":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" "} {"level":"info","ts":"2026-06-30T08:37:18.043608Z","caller":"traceutil/trace.go:171","msg":"trace[1029307085] linearizableReadLoop","detail":"{readStateIndex:2812; appliedIndex:2811; }","duration":"140.280291ms","start":"2026-06-30T08:37:17.903302Z","end":"2026-06-30T08:37:18.043582Z","steps":["trace[1029307085] 'read index received' (duration: 140.125507ms)","trace[1029307085] 'applied index is now lower than readState.Index' (duration: 153.944µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:37:18.043691Z","caller":"traceutil/trace.go:171","msg":"trace[804601075] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"166.67851ms","start":"2026-06-30T08:37:17.876979Z","end":"2026-06-30T08:37:18.043657Z","steps":["trace[804601075] 'process raft request' (duration: 166.466365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:18.043754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.429825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T08:37:18.043812Z","caller":"traceutil/trace.go:171","msg":"trace[325370509] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2698; }","duration":"140.530967ms","start":"2026-06-30T08:37:17.903268Z","end":"2026-06-30T08:37:18.043799Z","steps":["trace[325370509] 'agreement among raft nodes before linearized reading' (duration: 140.410834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:18.043912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.50561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:37:18.043993Z","caller":"traceutil/trace.go:171","msg":"trace[683131941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2698; }","duration":"124.617342ms","start":"2026-06-30T08:37:17.919355Z","end":"2026-06-30T08:37:18.043973Z","steps":["trace[683131941] 'agreement among raft nodes before linearized reading' (duration: 124.488159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:18.044082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.817288ms","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-06-30T08:37:18.044132Z","caller":"traceutil/trace.go:171","msg":"trace[1614939042] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2698; }","duration":"124.91263ms","start":"2026-06-30T08:37:17.919204Z","end":"2026-06-30T08:37:18.044117Z","steps":["trace[1614939042] 'agreement among raft nodes before linearized reading' (duration: 124.559131ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:37:20.694102Z","caller":"traceutil/trace.go:171","msg":"trace[1156799016] transaction","detail":"{read_only:false; response_revision:2709; number_of_response:1; }","duration":"101.183826ms","start":"2026-06-30T08:37:20.592891Z","end":"2026-06-30T08:37:20.694074Z","steps":["trace[1156799016] 'process raft request' (duration: 100.94302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:37:20.886532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.089886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-2n7kz\" ","response":"range_response_count:1 size:13721"} {"level":"info","ts":"2026-06-30T08:37:20.88662Z","caller":"traceutil/trace.go:171","msg":"trace[2043279739] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-2n7kz; range_end:; response_count:1; response_revision:2709; }","duration":"111.24943ms","start":"2026-06-30T08:37:20.775346Z","end":"2026-06-30T08:37:20.886595Z","steps":["trace[2043279739] 'range keys from in-memory index tree' (duration: 110.825649ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:37:20.994487Z","caller":"traceutil/trace.go:171","msg":"trace[787377168] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"102.889098ms","start":"2026-06-30T08:37:20.891546Z","end":"2026-06-30T08:37:20.994435Z","steps":["trace[787377168] 'process raft request' (duration: 102.617481ms)"],"step_count":1}