{"level":"warn","ts":"2026-05-19T02:58:41.292021Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T02:58:41.292106Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.177:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.177:2380","--initial-cluster=instance=https://199.19.213.177:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.177:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.177:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-19T02:58:41.292163Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T02:58:41.292186Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.177:2380"]} {"level":"info","ts":"2026-05-19T02:58:41.292205Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-19T02:58:41.292865Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.177:2379"]} {"level":"info","ts":"2026-05-19T02:58:41.292946Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.177:2380"],"listen-peer-urls":["https://199.19.213.177:2380"],"advertise-client-urls":["https://199.19.213.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.177:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-19T02:58:41.298783Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.608807ms"} {"level":"info","ts":"2026-05-19T02:58:41.308175Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f577bc5ae95d61e1","cluster-id":"735860b212d0f0b6"} {"level":"info","ts":"2026-05-19T02:58:41.308253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T02:58:41.308277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became follower at term 0"} {"level":"info","ts":"2026-05-19T02:58:41.308294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f577bc5ae95d61e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T02:58:41.308309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became follower at term 1"} {"level":"info","ts":"2026-05-19T02:58:41.308352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 switched to configuration voters=(17687813160169202145)"} {"level":"warn","ts":"2026-05-19T02:58:41.315077Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T02:58:41.316879Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T02:58:41.317901Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-19T02:58:41.320707Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f577bc5ae95d61e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T02:58:41.321186Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T02:58:41.321244Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T02:58:41.321256Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-19T02:58:41.321215Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f577bc5ae95d61e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T02:58:41.321907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 switched to configuration voters=(17687813160169202145)"} {"level":"info","ts":"2026-05-19T02:58:41.323765Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"735860b212d0f0b6","local-member-id":"f577bc5ae95d61e1","added-peer-id":"f577bc5ae95d61e1","added-peer-peer-urls":["https://199.19.213.177:2380"]} {"level":"info","ts":"2026-05-19T02:58:41.329643Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-19T02:58:41.329838Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.177:2380"} {"level":"info","ts":"2026-05-19T02:58:41.329854Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.177:2380"} {"level":"info","ts":"2026-05-19T02:58:41.329952Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f577bc5ae95d61e1","initial-advertise-peer-urls":["https://199.19.213.177:2380"],"listen-peer-urls":["https://199.19.213.177:2380"],"advertise-client-urls":["https://199.19.213.177:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.177:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T02:58:41.329987Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T02:58:41.909091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T02:58:41.909155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T02:58:41.909203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 received MsgPreVoteResp from f577bc5ae95d61e1 at term 1"} {"level":"info","ts":"2026-05-19T02:58:41.909222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became candidate at term 2"} {"level":"info","ts":"2026-05-19T02:58:41.9094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 received MsgVoteResp from f577bc5ae95d61e1 at term 2"} {"level":"info","ts":"2026-05-19T02:58:41.909432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f577bc5ae95d61e1 became leader at term 2"} {"level":"info","ts":"2026-05-19T02:58:41.909516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f577bc5ae95d61e1 elected leader f577bc5ae95d61e1 at term 2"} {"level":"info","ts":"2026-05-19T02:58:41.911423Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f577bc5ae95d61e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.177:2379]}","request-path":"/0/members/f577bc5ae95d61e1/attributes","cluster-id":"735860b212d0f0b6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T02:58:41.911453Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T02:58:41.911644Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T02:58:41.911714Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T02:58:41.912272Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T02:58:41.912356Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T02:58:41.913119Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"735860b212d0f0b6","local-member-id":"f577bc5ae95d61e1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T02:58:41.913335Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T02:58:41.913482Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T02:58:41.913727Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T02:58:41.914284Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.177:2379"} {"level":"info","ts":"2026-05-19T02:59:10.84423Z","caller":"traceutil/trace.go:171","msg":"trace[364145748] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"127.033808ms","start":"2026-05-19T02:59:10.717141Z","end":"2026-05-19T02:59:10.844175Z","steps":["trace[364145748] 'process raft request' (duration: 122.716064ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:59:10.849681Z","caller":"traceutil/trace.go:171","msg":"trace[1245923264] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"118.529361ms","start":"2026-05-19T02:59:10.731129Z","end":"2026-05-19T02:59:10.849658Z","steps":["trace[1245923264] 'process raft request' (duration: 118.012918ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:59:11.059724Z","caller":"traceutil/trace.go:171","msg":"trace[376534614] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"147.322171ms","start":"2026-05-19T02:59:10.912379Z","end":"2026-05-19T02:59:11.059701Z","steps":["trace[376534614] 'process raft request' (duration: 145.482657ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:59:11.061652Z","caller":"traceutil/trace.go:171","msg":"trace[624163307] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"117.156918ms","start":"2026-05-19T02:59:10.944481Z","end":"2026-05-19T02:59:11.061638Z","steps":["trace[624163307] 'process raft request' (duration: 117.035975ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:59:11.948455Z","caller":"traceutil/trace.go:171","msg":"trace[2087111609] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"203.837156ms","start":"2026-05-19T02:59:11.744589Z","end":"2026-05-19T02:59:11.948426Z","steps":["trace[2087111609] 'process raft request' (duration: 203.430505ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:59:12.178373Z","caller":"traceutil/trace.go:171","msg":"trace[1167112245] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"410.246014ms","start":"2026-05-19T02:59:11.768095Z","end":"2026-05-19T02:59:12.178341Z","steps":["trace[1167112245] 'read index received' (duration: 179.859962ms)","trace[1167112245] 'applied index is now lower than readState.Index' (duration: 230.384742ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:59:12.17845Z","caller":"traceutil/trace.go:171","msg":"trace[544255934] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"413.808981ms","start":"2026-05-19T02:59:11.764598Z","end":"2026-05-19T02:59:12.178407Z","steps":["trace[544255934] 'process raft request' (duration: 413.409241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:59:12.178733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.581622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-05-19T02:59:12.178873Z","caller":"traceutil/trace.go:171","msg":"trace[407854543] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:586; }","duration":"410.783227ms","start":"2026-05-19T02:59:11.768067Z","end":"2026-05-19T02:59:12.178851Z","steps":["trace[407854543] 'agreement among raft nodes before linearized reading' (duration: 410.371087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:59:12.178952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:59:11.768053Z","time spent":"410.886169ms","remote":"127.0.0.1:51336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":65459,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-05-19T02:59:12.179024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:59:11.764566Z","time spent":"413.966845ms","remote":"127.0.0.1:51336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T02:59:12.181945Z","caller":"traceutil/trace.go:171","msg":"trace[1639081007] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"192.221804ms","start":"2026-05-19T02:59:11.989708Z","end":"2026-05-19T02:59:12.18193Z","steps":["trace[1639081007] 'process raft request' (duration: 192.133732ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:59:17.638517Z","caller":"traceutil/trace.go:171","msg":"trace[13960418] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"286.828154ms","start":"2026-05-19T02:59:17.351646Z","end":"2026-05-19T02:59:17.638474Z","steps":["trace[13960418] 'process raft request' (duration: 286.559827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:59:18.42617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.508924ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T02:59:18.426281Z","caller":"traceutil/trace.go:171","msg":"trace[930442209] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:642; }","duration":"928.091404ms","start":"2026-05-19T02:59:17.498169Z","end":"2026-05-19T02:59:18.426261Z","steps":["trace[930442209] 'read index received' (duration: 140.127407ms)","trace[930442209] 'applied index is now lower than readState.Index' (duration: 787.962567ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T02:59:18.426628Z","caller":"traceutil/trace.go:171","msg":"trace[1319532450] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.058631928s","start":"2026-05-19T02:59:17.367958Z","end":"2026-05-19T02:59:18.42659Z","steps":["trace[1319532450] 'process raft request' (duration: 688.445769ms)","trace[1319532450] 'compare' (duration: 369.089393ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T02:59:18.426656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.475183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T02:59:18.426753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.149525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T02:59:18.426759Z","caller":"traceutil/trace.go:171","msg":"trace[996009611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"928.629957ms","start":"2026-05-19T02:59:17.498106Z","end":"2026-05-19T02:59:18.426736Z","steps":["trace[996009611] 'agreement among raft nodes before linearized reading' (duration: 928.447492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:59:18.42679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:59:17.367915Z","time spent":"1.058780202s","remote":"127.0.0.1:51396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T02:59:18.426822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:59:17.498083Z","time spent":"928.730669ms","remote":"127.0.0.1:51298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T02:59:18.426833Z","caller":"traceutil/trace.go:171","msg":"trace[657966208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"833.254688ms","start":"2026-05-19T02:59:17.593549Z","end":"2026-05-19T02:59:18.426804Z","steps":["trace[657966208] 'agreement among raft nodes before linearized reading' (duration: 833.030913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:59:18.426884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:59:17.593533Z","time spent":"833.33992ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T02:59:18.42715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.40481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-19T02:59:18.427134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"782.292869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rwhvd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-19T02:59:18.427193Z","caller":"traceutil/trace.go:171","msg":"trace[1607450458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"791.538793ms","start":"2026-05-19T02:59:17.635641Z","end":"2026-05-19T02:59:18.42718Z","steps":["trace[1607450458] 'agreement among raft nodes before linearized reading' (duration: 791.4215ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T02:59:18.427211Z","caller":"traceutil/trace.go:171","msg":"trace[366857720] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rwhvd; range_end:; response_count:1; response_revision:620; }","duration":"782.411461ms","start":"2026-05-19T02:59:17.644781Z","end":"2026-05-19T02:59:18.427192Z","steps":["trace[366857720] 'agreement among raft nodes before linearized reading' (duration: 782.122555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:59:18.42723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:59:17.635581Z","time spent":"791.639706ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T02:59:18.427254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:59:17.64477Z","time spent":"782.476633ms","remote":"127.0.0.1:51500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-rwhvd\" "} {"level":"warn","ts":"2026-05-19T02:59:18.427389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.368213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T02:59:18.427451Z","caller":"traceutil/trace.go:171","msg":"trace[1609229423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"822.454445ms","start":"2026-05-19T02:59:17.604985Z","end":"2026-05-19T02:59:18.427439Z","steps":["trace[1609229423] 'agreement among raft nodes before linearized reading' (duration: 822.204799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T02:59:18.427801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T02:59:17.604973Z","time spent":"822.813885ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T02:59:20.066544Z","caller":"traceutil/trace.go:171","msg":"trace[1372320570] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"134.781037ms","start":"2026-05-19T02:59:19.931725Z","end":"2026-05-19T02:59:20.066506Z","steps":["trace[1372320570] 'process raft request' (duration: 134.655353ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:08.186067Z","caller":"traceutil/trace.go:171","msg":"trace[1675323548] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"131.705107ms","start":"2026-05-19T03:00:08.054343Z","end":"2026-05-19T03:00:08.186048Z","steps":["trace[1675323548] 'process raft request' (duration: 131.580444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:08.525182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.15468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T03:00:08.525306Z","caller":"traceutil/trace.go:171","msg":"trace[1053896047] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"252.473338ms","start":"2026-05-19T03:00:08.272811Z","end":"2026-05-19T03:00:08.525284Z","steps":["trace[1053896047] 'process raft request' (duration: 122.132244ms)","trace[1053896047] 'compare' (duration: 130.005096ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:00:08.532715Z","caller":"traceutil/trace.go:171","msg":"trace[1450669839] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"121.987091ms","start":"2026-05-19T03:00:08.410692Z","end":"2026-05-19T03:00:08.532679Z","steps":["trace[1450669839] 'process raft request' (duration: 121.698784ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:12.821031Z","caller":"traceutil/trace.go:171","msg":"trace[1538675005] linearizableReadLoop","detail":"{readStateIndex:1048; appliedIndex:1047; }","duration":"210.486305ms","start":"2026-05-19T03:00:12.610517Z","end":"2026-05-19T03:00:12.821003Z","steps":["trace[1538675005] 'read index received' (duration: 210.26464ms)","trace[1538675005] 'applied index is now lower than readState.Index' (duration: 220.465µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:00:12.821082Z","caller":"traceutil/trace.go:171","msg":"trace[1788903020] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"280.379187ms","start":"2026-05-19T03:00:12.540674Z","end":"2026-05-19T03:00:12.821053Z","steps":["trace[1788903020] 'process raft request' (duration: 280.169922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:12.821246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.717361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T03:00:12.821297Z","caller":"traceutil/trace.go:171","msg":"trace[1333498637] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1011; }","duration":"210.784413ms","start":"2026-05-19T03:00:12.610501Z","end":"2026-05-19T03:00:12.821285Z","steps":["trace[1333498637] 'agreement among raft nodes before linearized reading' (duration: 210.638819ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:32.999549Z","caller":"traceutil/trace.go:171","msg":"trace[835085165] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"106.75996ms","start":"2026-05-19T03:00:32.892766Z","end":"2026-05-19T03:00:32.999526Z","steps":["trace[835085165] 'process raft request' (duration: 106.415781ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:33.352613Z","caller":"traceutil/trace.go:171","msg":"trace[180431847] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"348.851305ms","start":"2026-05-19T03:00:33.003678Z","end":"2026-05-19T03:00:33.352529Z","steps":["trace[180431847] 'process raft request' (duration: 312.371966ms)","trace[180431847] 'compare' (duration: 35.721431ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T03:00:33.353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:33.003628Z","time spent":"349.149692ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:00:33.401232Z","caller":"traceutil/trace.go:171","msg":"trace[1757528263] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"397.09335ms","start":"2026-05-19T03:00:33.004111Z","end":"2026-05-19T03:00:33.401204Z","steps":["trace[1757528263] 'process raft request' (duration: 396.853604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:33.401395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:33.004086Z","time spent":"397.235383ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:00:33.402289Z","caller":"traceutil/trace.go:171","msg":"trace[217496412] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1118; }","duration":"263.147168ms","start":"2026-05-19T03:00:33.138532Z","end":"2026-05-19T03:00:33.401679Z","steps":["trace[217496412] 'read index received' (duration: 177.530643ms)","trace[217496412] 'applied index is now lower than readState.Index' (duration: 85.615465ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:00:33.401673Z","caller":"traceutil/trace.go:171","msg":"trace[182547243] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"397.354516ms","start":"2026-05-19T03:00:33.004294Z","end":"2026-05-19T03:00:33.401648Z","steps":["trace[182547243] 'process raft request' (duration: 396.804303ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:33.402592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:33.004285Z","time spent":"398.248938ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:00:33.402606Z","caller":"traceutil/trace.go:171","msg":"trace[645195181] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"398.230128ms","start":"2026-05-19T03:00:33.004357Z","end":"2026-05-19T03:00:33.402587Z","steps":["trace[645195181] 'process raft request' (duration: 397.06459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:33.402837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:33.004335Z","time spent":"398.403582ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:00:33.405205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.640833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:00:33.405332Z","caller":"traceutil/trace.go:171","msg":"trace[495380724] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1081; }","duration":"266.767406ms","start":"2026-05-19T03:00:33.138526Z","end":"2026-05-19T03:00:33.405293Z","steps":["trace[495380724] 'agreement among raft nodes before linearized reading' (duration: 263.877035ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:34.934968Z","caller":"traceutil/trace.go:171","msg":"trace[516277575] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"570.425251ms","start":"2026-05-19T03:00:34.364518Z","end":"2026-05-19T03:00:34.934943Z","steps":["trace[516277575] 'process raft request' (duration: 570.243156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:34.935103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:34.364494Z","time spent":"570.541544ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:00:35.344439Z","caller":"traceutil/trace.go:171","msg":"trace[208456864] linearizableReadLoop","detail":"{readStateIndex:1125; appliedIndex:1124; }","duration":"110.882509ms","start":"2026-05-19T03:00:35.233531Z","end":"2026-05-19T03:00:35.344414Z","steps":["trace[208456864] 'read index received' (duration: 15.399644ms)","trace[208456864] 'applied index is now lower than readState.Index' (duration: 95.481145ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T03:00:35.344575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.022992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:00:35.344615Z","caller":"traceutil/trace.go:171","msg":"trace[1991973865] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1083; }","duration":"111.125025ms","start":"2026-05-19T03:00:35.233478Z","end":"2026-05-19T03:00:35.344603Z","steps":["trace[1991973865] 'agreement among raft nodes before linearized reading' (duration: 111.029973ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:35.594141Z","caller":"traceutil/trace.go:171","msg":"trace[321750663] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"180.67554ms","start":"2026-05-19T03:00:35.41343Z","end":"2026-05-19T03:00:35.594106Z","steps":["trace[321750663] 'process raft request' (duration: 180.555237ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:35.594137Z","caller":"traceutil/trace.go:171","msg":"trace[998606300] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"181.025178ms","start":"2026-05-19T03:00:35.413051Z","end":"2026-05-19T03:00:35.594076Z","steps":["trace[998606300] 'process raft request' (duration: 180.795162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:47.949868Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7053092481299654134,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T03:00:48.097614Z","caller":"traceutil/trace.go:171","msg":"trace[1306349423] linearizableReadLoop","detail":"{readStateIndex:1223; appliedIndex:1222; }","duration":"648.436651ms","start":"2026-05-19T03:00:47.449159Z","end":"2026-05-19T03:00:48.097596Z","steps":["trace[1306349423] 'read index received' (duration: 648.211925ms)","trace[1306349423] 'applied index is now lower than readState.Index' (duration: 224.126µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:00:48.097944Z","caller":"traceutil/trace.go:171","msg":"trace[1688479309] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"668.493249ms","start":"2026-05-19T03:00:47.42944Z","end":"2026-05-19T03:00:48.097933Z","steps":["trace[1688479309] 'process raft request' (duration: 668.045008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:48.098022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:47.429417Z","time spent":"668.5474ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:00:48.098177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.020275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:00:48.098201Z","caller":"traceutil/trace.go:171","msg":"trace[856749353] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1177; }","duration":"649.066866ms","start":"2026-05-19T03:00:47.449126Z","end":"2026-05-19T03:00:48.098193Z","steps":["trace[856749353] 'agreement among raft nodes before linearized reading' (duration: 649.027735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:48.098255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:47.449112Z","time spent":"649.136238ms","remote":"127.0.0.1:46794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-19T03:00:48.098452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.37179ms","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-05-19T03:00:48.098518Z","caller":"traceutil/trace.go:171","msg":"trace[2095926481] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1177; }","duration":"630.498823ms","start":"2026-05-19T03:00:47.468002Z","end":"2026-05-19T03:00:48.098501Z","steps":["trace[2095926481] 'agreement among raft nodes before linearized reading' (duration: 630.309018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:48.098596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:47.467992Z","time spent":"630.595586ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T03:00:48.098667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.530644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T03:00:48.098695Z","caller":"traceutil/trace.go:171","msg":"trace[926912329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1177; }","duration":"453.590255ms","start":"2026-05-19T03:00:47.645099Z","end":"2026-05-19T03:00:48.098689Z","steps":["trace[926912329] 'agreement among raft nodes before linearized reading' (duration: 453.501083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:48.098713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:47.645082Z","time spent":"453.627797ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T03:00:48.098829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.292847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T03:00:48.09887Z","caller":"traceutil/trace.go:171","msg":"trace[1092268405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1177; }","duration":"462.362379ms","start":"2026-05-19T03:00:47.636495Z","end":"2026-05-19T03:00:48.098857Z","steps":["trace[1092268405] 'agreement among raft nodes before linearized reading' (duration: 462.261947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:48.098878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.995936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:00:48.098916Z","caller":"traceutil/trace.go:171","msg":"trace[1343874681] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1177; }","duration":"314.063137ms","start":"2026-05-19T03:00:47.784845Z","end":"2026-05-19T03:00:48.098908Z","steps":["trace[1343874681] 'agreement among raft nodes before linearized reading' (duration: 314.011626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:48.098923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:47.63648Z","time spent":"462.43496ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T03:00:48.098936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:47.784816Z","time spent":"314.113649ms","remote":"127.0.0.1:46742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-19T03:00:48.099093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.715321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:00:48.099119Z","caller":"traceutil/trace.go:171","msg":"trace[261215981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1177; }","duration":"603.764771ms","start":"2026-05-19T03:00:47.495346Z","end":"2026-05-19T03:00:48.099111Z","steps":["trace[261215981] 'agreement among raft nodes before linearized reading' (duration: 603.72308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:00:48.099147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:00:47.495335Z","time spent":"603.806553ms","remote":"127.0.0.1:51296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T03:00:48.24096Z","caller":"traceutil/trace.go:171","msg":"trace[2070870075] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"137.938758ms","start":"2026-05-19T03:00:48.102989Z","end":"2026-05-19T03:00:48.240928Z","steps":["trace[2070870075] 'process raft request' (duration: 137.148629ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:48.243236Z","caller":"traceutil/trace.go:171","msg":"trace[1988918733] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1223; }","duration":"134.595038ms","start":"2026-05-19T03:00:48.108611Z","end":"2026-05-19T03:00:48.243206Z","steps":["trace[1988918733] 'read index received' (duration: 131.545044ms)","trace[1988918733] 'applied index is now lower than readState.Index' (duration: 3.048694ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T03:00:48.243389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.750872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:00:48.24343Z","caller":"traceutil/trace.go:171","msg":"trace[1853164832] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1180; }","duration":"134.827863ms","start":"2026-05-19T03:00:48.108591Z","end":"2026-05-19T03:00:48.243419Z","steps":["trace[1853164832] 'agreement among raft nodes before linearized reading' (duration: 134.71743ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:48.243479Z","caller":"traceutil/trace.go:171","msg":"trace[1806921710] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"139.525018ms","start":"2026-05-19T03:00:48.103934Z","end":"2026-05-19T03:00:48.243459Z","steps":["trace[1806921710] 'process raft request' (duration: 139.215111ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:48.24347Z","caller":"traceutil/trace.go:171","msg":"trace[2062247172] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"139.530248ms","start":"2026-05-19T03:00:48.103879Z","end":"2026-05-19T03:00:48.243409Z","steps":["trace[2062247172] 'process raft request' (duration: 139.125328ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:54.437872Z","caller":"traceutil/trace.go:171","msg":"trace[568627194] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"146.833115ms","start":"2026-05-19T03:00:54.291014Z","end":"2026-05-19T03:00:54.437847Z","steps":["trace[568627194] 'process raft request' (duration: 146.681512ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:54.439128Z","caller":"traceutil/trace.go:171","msg":"trace[927399530] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"145.053832ms","start":"2026-05-19T03:00:54.294059Z","end":"2026-05-19T03:00:54.439113Z","steps":["trace[927399530] 'process raft request' (duration: 145.027451ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:54.439197Z","caller":"traceutil/trace.go:171","msg":"trace[1486239778] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"147.255135ms","start":"2026-05-19T03:00:54.291918Z","end":"2026-05-19T03:00:54.439174Z","steps":["trace[1486239778] 'process raft request' (duration: 147.096651ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:59.276104Z","caller":"traceutil/trace.go:171","msg":"trace[1642193389] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"188.481377ms","start":"2026-05-19T03:00:59.087598Z","end":"2026-05-19T03:00:59.27608Z","steps":["trace[1642193389] 'process raft request' (duration: 188.339093ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:00:59.370973Z","caller":"traceutil/trace.go:171","msg":"trace[1508970086] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"199.446235ms","start":"2026-05-19T03:00:59.171498Z","end":"2026-05-19T03:00:59.370944Z","steps":["trace[1508970086] 'process raft request' (duration: 199.209139ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:04.192014Z","caller":"traceutil/trace.go:171","msg":"trace[208293614] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"109.432739ms","start":"2026-05-19T03:01:04.082557Z","end":"2026-05-19T03:01:04.19199Z","steps":["trace[208293614] 'process raft request' (duration: 109.224444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:04.76775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.88435ms","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-05-19T03:01:04.767756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.962013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-19T03:01:04.767807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.171749ms","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-05-19T03:01:04.767823Z","caller":"traceutil/trace.go:171","msg":"trace[868345434] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1249; }","duration":"292.009482ms","start":"2026-05-19T03:01:04.475796Z","end":"2026-05-19T03:01:04.767806Z","steps":["trace[868345434] 'range keys from in-memory index tree' (duration: 291.692995ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:04.767839Z","caller":"traceutil/trace.go:171","msg":"trace[255101392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1249; }","duration":"288.095446ms","start":"2026-05-19T03:01:04.479723Z","end":"2026-05-19T03:01:04.767818Z","steps":["trace[255101392] 'range keys from in-memory index tree' (duration: 287.706606ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:04.767858Z","caller":"traceutil/trace.go:171","msg":"trace[582744482] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1249; }","duration":"277.226511ms","start":"2026-05-19T03:01:04.490618Z","end":"2026-05-19T03:01:04.767844Z","steps":["trace[582744482] 'range keys from in-memory index tree' (duration: 277.046156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:04.767961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.526863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:01:04.767993Z","caller":"traceutil/trace.go:171","msg":"trace[995209378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1249; }","duration":"271.595585ms","start":"2026-05-19T03:01:04.49639Z","end":"2026-05-19T03:01:04.767985Z","steps":["trace[995209378] 'range keys from in-memory index tree' (duration: 271.45117ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:05.174986Z","caller":"traceutil/trace.go:171","msg":"trace[1939071644] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"401.988396ms","start":"2026-05-19T03:01:04.772968Z","end":"2026-05-19T03:01:05.174956Z","steps":["trace[1939071644] 'process raft request' (duration: 401.805511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:05.175144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:04.772949Z","time spent":"402.112078ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:01:05.220825Z","caller":"traceutil/trace.go:171","msg":"trace[1016956417] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"447.802472ms","start":"2026-05-19T03:01:04.773006Z","end":"2026-05-19T03:01:05.220809Z","steps":["trace[1016956417] 'process raft request' (duration: 447.675959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:05.220945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:04.772985Z","time spent":"447.900345ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:01:05.221066Z","caller":"traceutil/trace.go:171","msg":"trace[419774229] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1298; }","duration":"163.199181ms","start":"2026-05-19T03:01:05.057826Z","end":"2026-05-19T03:01:05.221025Z","steps":["trace[419774229] 'read index received' (duration: 116.915322ms)","trace[419774229] 'applied index is now lower than readState.Index' (duration: 46.281939ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:01:05.221131Z","caller":"traceutil/trace.go:171","msg":"trace[632446532] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"447.525095ms","start":"2026-05-19T03:01:04.773599Z","end":"2026-05-19T03:01:05.221125Z","steps":["trace[632446532] 'process raft request' (duration: 447.186167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:05.221163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:04.773588Z","time spent":"447.560296ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:01:05.221413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.521618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.177\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-19T03:01:05.221475Z","caller":"traceutil/trace.go:171","msg":"trace[1770434902] range","detail":"{range_begin:/registry/masterleases/199.19.213.177; range_end:; response_count:1; response_revision:1252; }","duration":"163.677212ms","start":"2026-05-19T03:01:05.057781Z","end":"2026-05-19T03:01:05.221458Z","steps":["trace[1770434902] 'agreement among raft nodes before linearized reading' (duration: 163.368195ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:06.409779Z","caller":"traceutil/trace.go:171","msg":"trace[2096884721] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"136.035558ms","start":"2026-05-19T03:01:06.273729Z","end":"2026-05-19T03:01:06.409764Z","steps":["trace[2096884721] 'process raft request' (duration: 135.625787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:06.794719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.594878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:01:06.794793Z","caller":"traceutil/trace.go:171","msg":"trace[1994360330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1256; }","duration":"299.70797ms","start":"2026-05-19T03:01:06.495072Z","end":"2026-05-19T03:01:06.79478Z","steps":["trace[1994360330] 'range keys from in-memory index tree' (duration: 299.519345ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:07.444041Z","caller":"traceutil/trace.go:171","msg":"trace[2122548116] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1307; }","duration":"263.405345ms","start":"2026-05-19T03:01:07.180615Z","end":"2026-05-19T03:01:07.44402Z","steps":["trace[2122548116] 'read index received' (duration: 263.291872ms)","trace[2122548116] 'applied index is now lower than readState.Index' (duration: 112.163µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:01:07.444093Z","caller":"traceutil/trace.go:171","msg":"trace[2125177483] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"276.416733ms","start":"2026-05-19T03:01:07.167644Z","end":"2026-05-19T03:01:07.444061Z","steps":["trace[2125177483] 'process raft request' (duration: 276.257969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:07.444287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.651511ms","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-05-19T03:01:07.444316Z","caller":"traceutil/trace.go:171","msg":"trace[186766564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1258; }","duration":"263.726983ms","start":"2026-05-19T03:01:07.180581Z","end":"2026-05-19T03:01:07.444308Z","steps":["trace[186766564] 'agreement among raft nodes before linearized reading' (duration: 263.577149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:07.44458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.497653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-19T03:01:07.444608Z","caller":"traceutil/trace.go:171","msg":"trace[1834407914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1258; }","duration":"219.76798ms","start":"2026-05-19T03:01:07.224832Z","end":"2026-05-19T03:01:07.4446Z","steps":["trace[1834407914] 'agreement among raft nodes before linearized reading' (duration: 219.677308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:07.444772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.314829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T03:01:07.444791Z","caller":"traceutil/trace.go:171","msg":"trace[1445660491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1258; }","duration":"219.3527ms","start":"2026-05-19T03:01:07.225433Z","end":"2026-05-19T03:01:07.444785Z","steps":["trace[1445660491] 'agreement among raft nodes before linearized reading' (duration: 219.277439ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:07.848341Z","caller":"traceutil/trace.go:171","msg":"trace[947041251] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"399.157786ms","start":"2026-05-19T03:01:07.449161Z","end":"2026-05-19T03:01:07.848319Z","steps":["trace[947041251] 'process raft request' (duration: 344.312779ms)","trace[947041251] 'compare' (duration: 54.630892ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T03:01:07.848444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:07.449146Z","time spent":"399.243908ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:01:08.253095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.465101ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T03:01:08.253336Z","caller":"traceutil/trace.go:171","msg":"trace[606395984] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"804.056102ms","start":"2026-05-19T03:01:07.449265Z","end":"2026-05-19T03:01:08.253321Z","steps":["trace[606395984] 'process raft request' (duration: 803.947649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:08.253381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:07.449245Z","time spent":"804.117574ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:01:08.253493Z","caller":"traceutil/trace.go:171","msg":"trace[181293416] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"804.184305ms","start":"2026-05-19T03:01:07.449258Z","end":"2026-05-19T03:01:08.253442Z","steps":["trace[181293416] 'process raft request' (duration: 630.289493ms)","trace[181293416] 'compare' (duration: 172.964429ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:01:08.25365Z","caller":"traceutil/trace.go:171","msg":"trace[710708993] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"804.349299ms","start":"2026-05-19T03:01:07.449294Z","end":"2026-05-19T03:01:08.253643Z","steps":["trace[710708993] 'process raft request' (duration: 804.00207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:08.253651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:07.449252Z","time spent":"804.317278ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:01:08.253691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:07.449289Z","time spent":"804.38124ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:01:08.253672Z","caller":"traceutil/trace.go:171","msg":"trace[642738323] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"802.912165ms","start":"2026-05-19T03:01:07.450734Z","end":"2026-05-19T03:01:08.253646Z","steps":["trace[642738323] 'process raft request' (duration: 802.824693ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:08.253646Z","caller":"traceutil/trace.go:171","msg":"trace[1376615336] linearizableReadLoop","detail":"{readStateIndex:1313; appliedIndex:1308; }","duration":"758.245365ms","start":"2026-05-19T03:01:07.495378Z","end":"2026-05-19T03:01:08.253623Z","steps":["trace[1376615336] 'read index received' (duration: 298.001629ms)","trace[1376615336] 'applied index is now lower than readState.Index' (duration: 460.242796ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T03:01:08.253739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.356088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:01:08.253777Z","caller":"traceutil/trace.go:171","msg":"trace[1057781138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1263; }","duration":"758.418629ms","start":"2026-05-19T03:01:07.495347Z","end":"2026-05-19T03:01:08.253766Z","steps":["trace[1057781138] 'agreement among raft nodes before linearized reading' (duration: 758.334897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:08.253806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:07.495334Z","time spent":"758.466451ms","remote":"127.0.0.1:51296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-19T03:01:08.253815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:07.450722Z","time spent":"803.011137ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:01:08.253847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.671888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:01:08.253882Z","caller":"traceutil/trace.go:171","msg":"trace[473406364] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1263; }","duration":"688.741189ms","start":"2026-05-19T03:01:07.56513Z","end":"2026-05-19T03:01:08.253872Z","steps":["trace[473406364] 'agreement among raft nodes before linearized reading' (duration: 688.673008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:08.253906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:07.565113Z","time spent":"688.787581ms","remote":"127.0.0.1:46858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-05-19T03:01:08.253954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.283573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T03:01:08.254018Z","caller":"traceutil/trace.go:171","msg":"trace[21200156] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1263; }","duration":"525.402826ms","start":"2026-05-19T03:01:07.728579Z","end":"2026-05-19T03:01:08.253982Z","steps":["trace[21200156] 'agreement among raft nodes before linearized reading' (duration: 525.281803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:08.254052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:07.728565Z","time spent":"525.477267ms","remote":"127.0.0.1:51794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-05-19T03:01:08.814707Z","caller":"traceutil/trace.go:171","msg":"trace[352305724] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1314; }","duration":"128.230568ms","start":"2026-05-19T03:01:08.686423Z","end":"2026-05-19T03:01:08.814653Z","steps":["trace[352305724] 'read index received' (duration: 42.804635ms)","trace[352305724] 'applied index is now lower than readState.Index' (duration: 85.424463ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:01:08.815131Z","caller":"traceutil/trace.go:171","msg":"trace[1431254372] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"208.954546ms","start":"2026-05-19T03:01:08.606157Z","end":"2026-05-19T03:01:08.815112Z","steps":["trace[1431254372] 'process raft request' (duration: 123.039651ms)","trace[1431254372] 'compare' (duration: 85.095595ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T03:01:08.816419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.93872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:01:08.816535Z","caller":"traceutil/trace.go:171","msg":"trace[1118653126] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1265; }","duration":"130.054013ms","start":"2026-05-19T03:01:08.686413Z","end":"2026-05-19T03:01:08.816467Z","steps":["trace[1118653126] 'agreement among raft nodes before linearized reading' (duration: 128.391432ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:18.7917Z","caller":"traceutil/trace.go:171","msg":"trace[1303327781] linearizableReadLoop","detail":"{readStateIndex:1390; appliedIndex:1389; }","duration":"499.043172ms","start":"2026-05-19T03:01:18.2926Z","end":"2026-05-19T03:01:18.791644Z","steps":["trace[1303327781] 'read index received' (duration: 498.870038ms)","trace[1303327781] 'applied index is now lower than readState.Index' (duration: 171.474µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:01:18.791913Z","caller":"traceutil/trace.go:171","msg":"trace[1628178982] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"503.286336ms","start":"2026-05-19T03:01:18.288614Z","end":"2026-05-19T03:01:18.7919Z","steps":["trace[1628178982] 'process raft request' (duration: 502.861875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:18.792135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.288586Z","time spent":"503.436699ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:01:18.792261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.439257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T03:01:18.792272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.531216ms","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-05-19T03:01:18.792361Z","caller":"traceutil/trace.go:171","msg":"trace[1602255816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1338; }","duration":"295.55974ms","start":"2026-05-19T03:01:18.496781Z","end":"2026-05-19T03:01:18.792341Z","steps":["trace[1602255816] 'agreement among raft nodes before linearized reading' (duration: 295.379586ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:18.792379Z","caller":"traceutil/trace.go:171","msg":"trace[1140708524] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1338; }","duration":"497.71731ms","start":"2026-05-19T03:01:18.294638Z","end":"2026-05-19T03:01:18.792355Z","steps":["trace[1140708524] 'agreement among raft nodes before linearized reading' (duration: 497.445404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:18.792435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.29462Z","time spent":"497.805892ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T03:01:18.792561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.724337ms","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-05-19T03:01:18.792628Z","caller":"traceutil/trace.go:171","msg":"trace[1103280750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1338; }","duration":"494.819239ms","start":"2026-05-19T03:01:18.297796Z","end":"2026-05-19T03:01:18.792615Z","steps":["trace[1103280750] 'agreement among raft nodes before linearized reading' (duration: 494.516872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:18.792657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.064377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T03:01:18.792695Z","caller":"traceutil/trace.go:171","msg":"trace[430269125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1338; }","duration":"500.154649ms","start":"2026-05-19T03:01:18.292531Z","end":"2026-05-19T03:01:18.792686Z","steps":["trace[430269125] 'agreement among raft nodes before linearized reading' (duration: 500.053267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:18.792723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.292511Z","time spent":"500.205571ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T03:01:18.792739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.297781Z","time spent":"494.894531ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T03:01:18.79253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.00799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T03:01:18.793443Z","caller":"traceutil/trace.go:171","msg":"trace[1523897319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1338; }","duration":"107.970243ms","start":"2026-05-19T03:01:18.685458Z","end":"2026-05-19T03:01:18.793428Z","steps":["trace[1523897319] 'agreement among raft nodes before linearized reading' (duration: 106.628231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:19.504024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.554687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T03:01:19.504229Z","caller":"traceutil/trace.go:171","msg":"trace[66986851] transaction","detail":"{read_only:false; response_revision:1340; number_of_response:1; }","duration":"706.125323ms","start":"2026-05-19T03:01:18.798087Z","end":"2026-05-19T03:01:19.504212Z","steps":["trace[66986851] 'process raft request' (duration: 706.048241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:19.504288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.798064Z","time spent":"706.200855ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:01:19.504641Z","caller":"traceutil/trace.go:171","msg":"trace[1054621656] linearizableReadLoop","detail":"{readStateIndex:1394; appliedIndex:1390; }","duration":"657.449776ms","start":"2026-05-19T03:01:18.847167Z","end":"2026-05-19T03:01:19.504617Z","steps":["trace[1054621656] 'read index received' (duration: 63.225322ms)","trace[1054621656] 'applied index is now lower than readState.Index' (duration: 594.222754ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:01:19.504703Z","caller":"traceutil/trace.go:171","msg":"trace[1483936550] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"706.515342ms","start":"2026-05-19T03:01:18.798163Z","end":"2026-05-19T03:01:19.504678Z","steps":["trace[1483936550] 'process raft request' (duration: 706.01907ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:19.504794Z","caller":"traceutil/trace.go:171","msg":"trace[162327076] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"706.526153ms","start":"2026-05-19T03:01:18.798254Z","end":"2026-05-19T03:01:19.50478Z","steps":["trace[162327076] 'process raft request' (duration: 706.153154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:19.504807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.798157Z","time spent":"706.598654ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T03:01:19.504674Z","caller":"traceutil/trace.go:171","msg":"trace[1472053443] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"707.140627ms","start":"2026-05-19T03:01:18.797505Z","end":"2026-05-19T03:01:19.504646Z","steps":["trace[1472053443] 'process raft request' (duration: 112.868573ms)","trace[1472053443] 'compare' (duration: 593.068895ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T03:01:19.504975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.071431ms","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-05-19T03:01:19.505006Z","caller":"traceutil/trace.go:171","msg":"trace[1730590739] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1342; }","duration":"551.141393ms","start":"2026-05-19T03:01:18.953854Z","end":"2026-05-19T03:01:19.504995Z","steps":["trace[1730590739] 'agreement among raft nodes before linearized reading' (duration: 550.973549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:19.504976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.798248Z","time spent":"706.585824ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:01:19.505053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.953826Z","time spent":"551.220045ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-05-19T03:01:19.505028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.840436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-19T03:01:19.505108Z","caller":"traceutil/trace.go:171","msg":"trace[2113026981] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1342; }","duration":"657.964018ms","start":"2026-05-19T03:01:18.847123Z","end":"2026-05-19T03:01:19.505087Z","steps":["trace[2113026981] 'agreement among raft nodes before linearized reading' (duration: 657.693352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:01:19.505162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.847099Z","time spent":"658.053941ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-19T03:01:19.505133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:01:18.797474Z","time spent":"707.454005ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:01:19.50523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.061214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T03:01:19.505463Z","caller":"traceutil/trace.go:171","msg":"trace[1893967417] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1342; }","duration":"110.32408ms","start":"2026-05-19T03:01:19.395111Z","end":"2026-05-19T03:01:19.505435Z","steps":["trace[1893967417] 'agreement among raft nodes before linearized reading' (duration: 110.052304ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:25.686996Z","caller":"traceutil/trace.go:171","msg":"trace[802338123] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"149.319962ms","start":"2026-05-19T03:01:25.537657Z","end":"2026-05-19T03:01:25.686977Z","steps":["trace[802338123] 'process raft request' (duration: 149.280041ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:25.687161Z","caller":"traceutil/trace.go:171","msg":"trace[1469270205] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"151.198898ms","start":"2026-05-19T03:01:25.535947Z","end":"2026-05-19T03:01:25.687146Z","steps":["trace[1469270205] 'process raft request' (duration: 150.385258ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:01:25.687162Z","caller":"traceutil/trace.go:171","msg":"trace[1934352599] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"150.738107ms","start":"2026-05-19T03:01:25.536405Z","end":"2026-05-19T03:01:25.687143Z","steps":["trace[1934352599] 'process raft request' (duration: 150.481901ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:02:05.694153Z","caller":"traceutil/trace.go:171","msg":"trace[850737276] linearizableReadLoop","detail":"{readStateIndex:1614; appliedIndex:1613; }","duration":"197.333347ms","start":"2026-05-19T03:02:05.496799Z","end":"2026-05-19T03:02:05.694132Z","steps":["trace[850737276] 'read index received' (duration: 197.192793ms)","trace[850737276] 'applied index is now lower than readState.Index' (duration: 139.644µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:02:05.694238Z","caller":"traceutil/trace.go:171","msg":"trace[1627516111] transaction","detail":"{read_only:false; response_revision:1552; number_of_response:1; }","duration":"451.080631ms","start":"2026-05-19T03:02:05.243135Z","end":"2026-05-19T03:02:05.694216Z","steps":["trace[1627516111] 'process raft request' (duration: 450.868036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:05.694273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.459091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:02:05.694329Z","caller":"traceutil/trace.go:171","msg":"trace[320779291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1552; }","duration":"197.561292ms","start":"2026-05-19T03:02:05.496758Z","end":"2026-05-19T03:02:05.69432Z","steps":["trace[320779291] 'agreement among raft nodes before linearized reading' (duration: 197.46854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:05.694371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:02:05.243121Z","time spent":"451.181843ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:02:06.023639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.738986ms","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-05-19T03:02:06.023752Z","caller":"traceutil/trace.go:171","msg":"trace[1171510681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1552; }","duration":"133.90639ms","start":"2026-05-19T03:02:05.889828Z","end":"2026-05-19T03:02:06.023734Z","steps":["trace[1171510681] 'range keys from in-memory index tree' (duration: 133.465978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:06.023918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.305389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-19T03:02:06.02398Z","caller":"traceutil/trace.go:171","msg":"trace[1654048022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1552; }","duration":"136.418551ms","start":"2026-05-19T03:02:05.887546Z","end":"2026-05-19T03:02:06.023964Z","steps":["trace[1654048022] 'range keys from in-memory index tree' (duration: 136.134674ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:06.023982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.861634ms","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-05-19T03:02:06.024024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.134927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T03:02:06.024062Z","caller":"traceutil/trace.go:171","msg":"trace[981592481] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1552; }","duration":"110.995227ms","start":"2026-05-19T03:02:05.913047Z","end":"2026-05-19T03:02:06.024042Z","steps":["trace[981592481] 'range keys from in-memory index tree' (duration: 110.636008ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:02:06.024119Z","caller":"traceutil/trace.go:171","msg":"trace[1994329659] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1552; }","duration":"196.26883ms","start":"2026-05-19T03:02:05.827824Z","end":"2026-05-19T03:02:06.024093Z","steps":["trace[1994329659] 'range keys from in-memory index tree' (duration: 195.920372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:06.7199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.628782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-19T03:02:06.719983Z","caller":"traceutil/trace.go:171","msg":"trace[1681015581] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1558; }","duration":"214.755524ms","start":"2026-05-19T03:02:06.505208Z","end":"2026-05-19T03:02:06.719964Z","steps":["trace[1681015581] 'range keys from in-memory index tree' (duration: 214.397086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:06.72008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.916081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T03:02:06.720167Z","caller":"traceutil/trace.go:171","msg":"trace[1105807196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1558; }","duration":"222.037334ms","start":"2026-05-19T03:02:06.498106Z","end":"2026-05-19T03:02:06.720143Z","steps":["trace[1105807196] 'range keys from in-memory index tree' (duration: 221.841779ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T03:02:07.040603Z","caller":"traceutil/trace.go:171","msg":"trace[1516914162] linearizableReadLoop","detail":"{readStateIndex:1621; appliedIndex:1620; }","duration":"153.375808ms","start":"2026-05-19T03:02:06.887211Z","end":"2026-05-19T03:02:07.040586Z","steps":["trace[1516914162] 'read index received' (duration: 153.314556ms)","trace[1516914162] 'applied index is now lower than readState.Index' (duration: 60.592µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:02:07.040655Z","caller":"traceutil/trace.go:171","msg":"trace[790181589] transaction","detail":"{read_only:false; response_revision:1559; number_of_response:1; }","duration":"315.845328ms","start":"2026-05-19T03:02:06.724792Z","end":"2026-05-19T03:02:07.040637Z","steps":["trace[790181589] 'process raft request' (duration: 315.696764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:07.040709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.495671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T03:02:07.040728Z","caller":"traceutil/trace.go:171","msg":"trace[332422164] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1559; }","duration":"153.533912ms","start":"2026-05-19T03:02:06.887188Z","end":"2026-05-19T03:02:07.040722Z","steps":["trace[332422164] 'agreement among raft nodes before linearized reading' (duration: 153.475571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:07.040758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:02:06.724781Z","time spent":"315.91723ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:02:07.040796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.83796ms","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-05-19T03:02:07.040875Z","caller":"traceutil/trace.go:171","msg":"trace[2002067641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1559; }","duration":"116.968153ms","start":"2026-05-19T03:02:06.923885Z","end":"2026-05-19T03:02:07.040853Z","steps":["trace[2002067641] 'agreement among raft nodes before linearized reading' (duration: 116.82577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:07.728317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.720044ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T03:02:07.728423Z","caller":"traceutil/trace.go:171","msg":"trace[552596196] linearizableReadLoop","detail":"{readStateIndex:1622; appliedIndex:1621; }","duration":"646.89819ms","start":"2026-05-19T03:02:07.081509Z","end":"2026-05-19T03:02:07.728407Z","steps":["trace[552596196] 'read index received' (duration: 442.961531ms)","trace[552596196] 'applied index is now lower than readState.Index' (duration: 203.935579ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T03:02:07.728475Z","caller":"traceutil/trace.go:171","msg":"trace[2010508335] transaction","detail":"{read_only:false; response_revision:1560; number_of_response:1; }","duration":"672.061009ms","start":"2026-05-19T03:02:07.05638Z","end":"2026-05-19T03:02:07.728441Z","steps":["trace[2010508335] 'process raft request' (duration: 468.14323ms)","trace[2010508335] 'compare' (duration: 203.579281ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T03:02:07.728645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:02:07.056358Z","time spent":"672.196293ms","remote":"127.0.0.1:51574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T03:02:07.728515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.012623ms","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-05-19T03:02:07.728887Z","caller":"traceutil/trace.go:171","msg":"trace[920114459] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1560; }","duration":"647.371732ms","start":"2026-05-19T03:02:07.08149Z","end":"2026-05-19T03:02:07.728862Z","steps":["trace[920114459] 'agreement among raft nodes before linearized reading' (duration: 646.991663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T03:02:07.729262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T03:02:07.08143Z","time spent":"647.776402ms","remote":"127.0.0.1:46746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "}