{"level":"warn","ts":"2026-05-30T05:17:51.971238Z","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-30T05:17:51.971386Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-30T05:17:51.971494Z","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-30T05:17:51.971514Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-30T05:17:51.971551Z","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-30T05:17:51.977236Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-05-30T05:17:51.977478Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-30T05:17:51.996229Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"16.481072ms"} {"level":"info","ts":"2026-05-30T05:17:52.018964Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-05-30T05:17:52.019117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T05:17:52.019146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-05-30T05:17:52.019157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T05:17:52.019169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-05-30T05:17:52.019214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-05-30T05:17:52.042269Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T05:17:52.050239Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T05:17:52.053502Z","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-30T05:17:52.063896Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T05:17:52.064662Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T05:17:52.064754Z","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-30T05:17:52.068023Z","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-30T05:17:52.068072Z","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-30T05:17:52.068689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-05-30T05:17:52.070632Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-30T05:17:52.072107Z","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-30T05:17:52.07233Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-30T05:17:52.072434Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-30T05:17:52.072581Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T05:17:52.072624Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T05:17:52.219885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T05:17:52.219953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T05:17:52.219997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-05-30T05:17:52.22002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-05-30T05:17:52.220032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-30T05:17:52.22005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-05-30T05:17:52.220069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-30T05:17:52.221118Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T05:17:52.221247Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T05:17:52.221323Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T05:17:52.221151Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:17:52.221726Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T05:17:52.222231Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T05:17:52.223182Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:17:52.223397Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:17:52.223487Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:17:52.229159Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T05:17:52.231915Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"warn","ts":"2026-05-30T05:18:16.955823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.942213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-05-30T05:18:16.956326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.347724ms","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-30T05:18:16.956441Z","caller":"traceutil/trace.go:171","msg":"trace[61662953] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"645.573952ms","start":"2026-05-30T05:18:16.310519Z","end":"2026-05-30T05:18:16.956092Z","steps":["trace[61662953] 'process raft request' (duration: 431.76914ms)","trace[61662953] 'compare' (duration: 212.797418ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:16.956535Z","caller":"traceutil/trace.go:171","msg":"trace[354828292] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:398; }","duration":"299.20655ms","start":"2026-05-30T05:18:16.656964Z","end":"2026-05-30T05:18:16.95617Z","steps":["trace[354828292] 'read index received' (duration: 85.345126ms)","trace[354828292] 'applied index is now lower than readState.Index' (duration: 213.860394ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:16.956755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:16.310496Z","time spent":"646.181527ms","remote":"127.0.0.1:51640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:16.956584Z","caller":"traceutil/trace.go:171","msg":"trace[1346490583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:388; }","duration":"299.431306ms","start":"2026-05-30T05:18:16.65693Z","end":"2026-05-30T05:18:16.956361Z","steps":["trace[1346490583] 'agreement among raft nodes before linearized reading' (duration: 299.24434ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:16.956611Z","caller":"traceutil/trace.go:171","msg":"trace[1421182712] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"641.034872ms","start":"2026-05-30T05:18:16.315334Z","end":"2026-05-30T05:18:16.956369Z","steps":["trace[1421182712] 'process raft request' (duration: 640.614561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:16.957079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.908947ms","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-30T05:18:16.957053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:16.656913Z","time spent":"300.03559ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-30T05:18:16.957159Z","caller":"traceutil/trace.go:171","msg":"trace[311003792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:388; }","duration":"300.042691ms","start":"2026-05-30T05:18:16.65709Z","end":"2026-05-30T05:18:16.957133Z","steps":["trace[311003792] 'agreement among raft nodes before linearized reading' (duration: 299.855796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:16.957211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:16.657056Z","time spent":"300.147342ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T05:18:16.957163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:16.315308Z","time spent":"641.77505ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:17.384541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.41254ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:17.384674Z","caller":"traceutil/trace.go:171","msg":"trace[19134904] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:400; }","duration":"420.101414ms","start":"2026-05-30T05:18:16.964551Z","end":"2026-05-30T05:18:17.384652Z","steps":["trace[19134904] 'read index received' (duration: 80.174479ms)","trace[19134904] 'applied index is now lower than readState.Index' (duration: 339.925355ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:17.384707Z","caller":"traceutil/trace.go:171","msg":"trace[150071888] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"420.698459ms","start":"2026-05-30T05:18:16.963983Z","end":"2026-05-30T05:18:17.384681Z","steps":["trace[150071888] 'process raft request' (duration: 219.033042ms)","trace[150071888] 'compare' (duration: 201.227676ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:17.384798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.246118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-05-30T05:18:17.384808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:16.963935Z","time spent":"420.825731ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:17.384825Z","caller":"traceutil/trace.go:171","msg":"trace[450804979] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:390; }","duration":"420.294979ms","start":"2026-05-30T05:18:16.964521Z","end":"2026-05-30T05:18:17.384816Z","steps":["trace[450804979] 'agreement among raft nodes before linearized reading' (duration: 420.225547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:17.384856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:16.964506Z","time spent":"420.34369ms","remote":"127.0.0.1:51884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-05-30T05:18:17.385046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.222591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"info","ts":"2026-05-30T05:18:17.385201Z","caller":"traceutil/trace.go:171","msg":"trace[1202871085] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:390; }","duration":"403.447718ms","start":"2026-05-30T05:18:16.981717Z","end":"2026-05-30T05:18:17.385165Z","steps":["trace[1202871085] 'agreement among raft nodes before linearized reading' (duration: 403.15116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:17.385279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:16.981704Z","time spent":"403.558ms","remote":"127.0.0.1:52094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4078,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-05-30T05:18:17.385369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.625796ms","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-30T05:18:17.385523Z","caller":"traceutil/trace.go:171","msg":"trace[86202326] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:390; }","duration":"396.021276ms","start":"2026-05-30T05:18:16.989466Z","end":"2026-05-30T05:18:17.385487Z","steps":["trace[86202326] 'agreement among raft nodes before linearized reading' (duration: 395.526073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:17.385588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.516145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:17.385666Z","caller":"traceutil/trace.go:171","msg":"trace[431574011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:390; }","duration":"376.16412ms","start":"2026-05-30T05:18:17.009479Z","end":"2026-05-30T05:18:17.385643Z","steps":["trace[431574011] 'agreement among raft nodes before linearized reading' (duration: 375.494353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:17.385713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:17.009438Z","time spent":"376.262253ms","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:18:17.385621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:16.989456Z","time spent":"396.147268ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-30T05:18:17.576915Z","caller":"traceutil/trace.go:171","msg":"trace[2117294641] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"179.327121ms","start":"2026-05-30T05:18:17.397565Z","end":"2026-05-30T05:18:17.576892Z","steps":["trace[2117294641] 'process raft request' (duration: 179.243459ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:17.576938Z","caller":"traceutil/trace.go:171","msg":"trace[345938030] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"185.81344ms","start":"2026-05-30T05:18:17.391068Z","end":"2026-05-30T05:18:17.576882Z","steps":["trace[345938030] 'process raft request' (duration: 115.574884ms)","trace[345938030] 'compare' (duration: 69.98154ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:17.730646Z","caller":"traceutil/trace.go:171","msg":"trace[286647222] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"101.702886ms","start":"2026-05-30T05:18:17.628914Z","end":"2026-05-30T05:18:17.730617Z","steps":["trace[286647222] 'process raft request' (duration: 101.624733ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:17.730756Z","caller":"traceutil/trace.go:171","msg":"trace[1721751617] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"103.93978ms","start":"2026-05-30T05:18:17.626742Z","end":"2026-05-30T05:18:17.730682Z","steps":["trace[1721751617] 'process raft request' (duration: 64.585339ms)","trace[1721751617] 'compare' (duration: 38.699835ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:18.021472Z","caller":"traceutil/trace.go:171","msg":"trace[2040015799] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"208.681378ms","start":"2026-05-30T05:18:17.812734Z","end":"2026-05-30T05:18:18.021416Z","steps":["trace[2040015799] 'process raft request' (duration: 119.09009ms)","trace[2040015799] 'compare' (duration: 89.359103ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:18.021479Z","caller":"traceutil/trace.go:171","msg":"trace[1709460075] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:413; }","duration":"205.299315ms","start":"2026-05-30T05:18:17.816142Z","end":"2026-05-30T05:18:18.021442Z","steps":["trace[1709460075] 'read index received' (duration: 115.624565ms)","trace[1709460075] 'applied index is now lower than readState.Index' (duration: 89.67293ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:18.021712Z","caller":"traceutil/trace.go:171","msg":"trace[2047342199] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"205.431469ms","start":"2026-05-30T05:18:17.816241Z","end":"2026-05-30T05:18:18.021673Z","steps":["trace[2047342199] 'process raft request' (duration: 205.137501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:18.021783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.595694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-t9x4t\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-05-30T05:18:18.021855Z","caller":"traceutil/trace.go:171","msg":"trace[910019166] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-t9x4t; range_end:; response_count:1; response_revision:403; }","duration":"205.704706ms","start":"2026-05-30T05:18:17.816132Z","end":"2026-05-30T05:18:18.021837Z","steps":["trace[910019166] 'agreement among raft nodes before linearized reading' (duration: 205.382827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:18.021881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.900647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-05-30T05:18:18.021924Z","caller":"traceutil/trace.go:171","msg":"trace[1480520578] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:403; }","duration":"202.999579ms","start":"2026-05-30T05:18:17.818913Z","end":"2026-05-30T05:18:18.021912Z","steps":["trace[1480520578] 'agreement among raft nodes before linearized reading' (duration: 202.872456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:18.022315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.575839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-05-30T05:18:18.022373Z","caller":"traceutil/trace.go:171","msg":"trace[452810332] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:403; }","duration":"202.664641ms","start":"2026-05-30T05:18:17.819693Z","end":"2026-05-30T05:18:18.022358Z","steps":["trace[452810332] 'agreement among raft nodes before linearized reading' (duration: 202.457366ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.115587Z","caller":"traceutil/trace.go:171","msg":"trace[2098673938] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"182.487048ms","start":"2026-05-30T05:18:32.933072Z","end":"2026-05-30T05:18:33.115559Z","steps":["trace[2098673938] 'process raft request' (duration: 182.365376ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.124268Z","caller":"traceutil/trace.go:171","msg":"trace[1027934025] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"188.779312ms","start":"2026-05-30T05:18:32.935471Z","end":"2026-05-30T05:18:33.124251Z","steps":["trace[1027934025] 'process raft request' (duration: 187.988313ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.124472Z","caller":"traceutil/trace.go:171","msg":"trace[588414543] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"183.877292ms","start":"2026-05-30T05:18:32.940588Z","end":"2026-05-30T05:18:33.124465Z","steps":["trace[588414543] 'process raft request' (duration: 182.95277ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.124592Z","caller":"traceutil/trace.go:171","msg":"trace[124907317] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"101.726766ms","start":"2026-05-30T05:18:33.022855Z","end":"2026-05-30T05:18:33.124581Z","steps":["trace[124907317] 'process raft request' (duration: 100.863965ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.12462Z","caller":"traceutil/trace.go:171","msg":"trace[515677396] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"180.052839ms","start":"2026-05-30T05:18:32.944562Z","end":"2026-05-30T05:18:33.124614Z","steps":["trace[515677396] 'process raft request' (duration: 179.008383ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.124637Z","caller":"traceutil/trace.go:171","msg":"trace[186986992] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"151.829849ms","start":"2026-05-30T05:18:32.972802Z","end":"2026-05-30T05:18:33.124632Z","steps":["trace[186986992] 'process raft request' (duration: 150.797314ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.124655Z","caller":"traceutil/trace.go:171","msg":"trace[1301960716] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"142.81719ms","start":"2026-05-30T05:18:32.981834Z","end":"2026-05-30T05:18:33.124651Z","steps":["trace[1301960716] 'process raft request' (duration: 141.799435ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.124674Z","caller":"traceutil/trace.go:171","msg":"trace[1928045877] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"142.781858ms","start":"2026-05-30T05:18:32.981887Z","end":"2026-05-30T05:18:33.124669Z","steps":["trace[1928045877] 'process raft request' (duration: 141.772093ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:33.124692Z","caller":"traceutil/trace.go:171","msg":"trace[2084715958] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"126.155892ms","start":"2026-05-30T05:18:32.998531Z","end":"2026-05-30T05:18:33.124687Z","steps":["trace[2084715958] 'process raft request' (duration: 125.157537ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:38.49611Z","caller":"traceutil/trace.go:171","msg":"trace[1923109621] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"486.452024ms","start":"2026-05-30T05:18:38.009622Z","end":"2026-05-30T05:18:38.496074Z","steps":["trace[1923109621] 'read index received' (duration: 478.301445ms)","trace[1923109621] 'applied index is now lower than readState.Index' (duration: 8.148699ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:38.496162Z","caller":"traceutil/trace.go:171","msg":"trace[352171117] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"509.828705ms","start":"2026-05-30T05:18:37.986291Z","end":"2026-05-30T05:18:38.496119Z","steps":["trace[352171117] 'process raft request' (duration: 502.21578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:38.496404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:37.986267Z","time spent":"510.01728ms","remote":"127.0.0.1:51706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:38.503173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.525397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:38.503274Z","caller":"traceutil/trace.go:171","msg":"trace[398478916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"493.698992ms","start":"2026-05-30T05:18:38.009551Z","end":"2026-05-30T05:18:38.50325Z","steps":["trace[398478916] 'agreement among raft nodes before linearized reading' (duration: 486.665611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:38.503324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:38.009511Z","time spent":"493.804223ms","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-30T05:18:39.739675Z","caller":"traceutil/trace.go:171","msg":"trace[1652029419] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"141.020436ms","start":"2026-05-30T05:18:39.598616Z","end":"2026-05-30T05:18:39.739637Z","steps":["trace[1652029419] 'read index received' (duration: 139.60327ms)","trace[1652029419] 'applied index is now lower than readState.Index' (duration: 1.415626ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:39.739755Z","caller":"traceutil/trace.go:171","msg":"trace[1425591641] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"242.326631ms","start":"2026-05-30T05:18:39.497383Z","end":"2026-05-30T05:18:39.73971Z","steps":["trace[1425591641] 'process raft request' (duration: 241.257015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:39.74012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.476517ms","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-30T05:18:39.740541Z","caller":"traceutil/trace.go:171","msg":"trace[824013795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"141.977058ms","start":"2026-05-30T05:18:39.598545Z","end":"2026-05-30T05:18:39.740522Z","steps":["trace[824013795] 'agreement among raft nodes before linearized reading' (duration: 141.235981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:40.261475Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938291830277019648,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T05:18:40.628086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.970473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:40.628394Z","caller":"traceutil/trace.go:171","msg":"trace[522603151] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:617; }","duration":"866.94046ms","start":"2026-05-30T05:18:39.761425Z","end":"2026-05-30T05:18:40.628366Z","steps":["trace[522603151] 'read index received' (duration: 601.583497ms)","trace[522603151] 'applied index is now lower than readState.Index' (duration: 265.355993ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:40.628363Z","caller":"traceutil/trace.go:171","msg":"trace[1258859244] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"882.316395ms","start":"2026-05-30T05:18:39.745974Z","end":"2026-05-30T05:18:40.62829Z","steps":["trace[1258859244] 'process raft request' (duration: 617.014024ms)","trace[1258859244] 'compare' (duration: 264.268416ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:40.628619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:39.745939Z","time spent":"882.539752ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:40.62868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.254348ms","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-30T05:18:40.628579Z","caller":"traceutil/trace.go:171","msg":"trace[1329499650] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"825.62009ms","start":"2026-05-30T05:18:39.802892Z","end":"2026-05-30T05:18:40.628512Z","steps":["trace[1329499650] 'process raft request' (duration: 825.393824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:40.628729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.579448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:40.628842Z","caller":"traceutil/trace.go:171","msg":"trace[1368559473] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"619.777672ms","start":"2026-05-30T05:18:40.009025Z","end":"2026-05-30T05:18:40.628802Z","steps":["trace[1368559473] 'agreement among raft nodes before linearized reading' (duration: 619.583868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:40.628906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:40.00899Z","time spent":"619.906114ms","remote":"127.0.0.1:51622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:18:40.629029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:39.802863Z","time spent":"825.980819ms","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T05:18:40.628726Z","caller":"traceutil/trace.go:171","msg":"trace[1286176621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"867.35331ms","start":"2026-05-30T05:18:39.76136Z","end":"2026-05-30T05:18:40.628714Z","steps":["trace[1286176621] 'agreement among raft nodes before linearized reading' (duration: 867.140555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:40.629408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:39.761322Z","time spent":"868.059977ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:18:40.630031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.224489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kf7mw\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-30T05:18:40.630144Z","caller":"traceutil/trace.go:171","msg":"trace[1795870177] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kf7mw; range_end:; response_count:1; response_revision:597; }","duration":"696.408674ms","start":"2026-05-30T05:18:39.933709Z","end":"2026-05-30T05:18:40.630118Z","steps":["trace[1795870177] 'agreement among raft nodes before linearized reading' (duration: 694.856967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:40.630233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:39.933676Z","time spent":"696.546658ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-kf7mw\" "} {"level":"warn","ts":"2026-05-30T05:18:42.262895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.997462ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:42.263025Z","caller":"traceutil/trace.go:171","msg":"trace[1137121574] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:598; }","duration":"251.139815ms","start":"2026-05-30T05:18:42.011866Z","end":"2026-05-30T05:18:42.263006Z","steps":["trace[1137121574] 'range keys from in-memory index tree' (duration: 250.979082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:42.263255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.516454969s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:42.263446Z","caller":"traceutil/trace.go:171","msg":"trace[1030871429] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"1.25372715s","start":"2026-05-30T05:18:41.009696Z","end":"2026-05-30T05:18:42.263423Z","steps":["trace[1030871429] 'read index received' (duration: 81.942µs)","trace[1030871429] 'applied index is now lower than readState.Index' (duration: 1.253643178s)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:42.263486Z","caller":"traceutil/trace.go:171","msg":"trace[362481372] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.616503843s","start":"2026-05-30T05:18:40.646949Z","end":"2026-05-30T05:18:42.263453Z","steps":["trace[362481372] 'process raft request' (duration: 99.715286ms)","trace[362481372] 'compare' (duration: 1.516222874s)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:42.263589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253904324s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:42.263623Z","caller":"traceutil/trace.go:171","msg":"trace[161981691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"1.254003227s","start":"2026-05-30T05:18:41.00961Z","end":"2026-05-30T05:18:42.263613Z","steps":["trace[161981691] 'agreement among raft nodes before linearized reading' (duration: 1.253921535s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:42.263628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:40.646914Z","time spent":"1.616616156s","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:18:42.263655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:41.009574Z","time spent":"1.254073258s","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T05:18:42.513379Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.388993435s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T05:18:42.51504Z","caller":"traceutil/trace.go:171","msg":"trace[952508995] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"1.39208376s","start":"2026-05-30T05:18:41.12292Z","end":"2026-05-30T05:18:42.515004Z","steps":["trace[952508995] 'process raft request' (duration: 1.391172138s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:42.51532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:41.122882Z","time spent":"1.392302695s","remote":"127.0.0.1:51706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:42.536622Z","caller":"traceutil/trace.go:171","msg":"trace[1335991988] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"273.091512ms","start":"2026-05-30T05:18:42.263475Z","end":"2026-05-30T05:18:42.536567Z","steps":["trace[1335991988] 'read index received' (duration: 250.185993ms)","trace[1335991988] 'applied index is now lower than readState.Index' (duration: 22.904009ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:42.536846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.344697902s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-30T05:18:42.536878Z","caller":"traceutil/trace.go:171","msg":"trace[1170679265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"1.344816535s","start":"2026-05-30T05:18:41.192051Z","end":"2026-05-30T05:18:42.536868Z","steps":["trace[1170679265] 'agreement among raft nodes before linearized reading' (duration: 1.344677541s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:42.536906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:41.192014Z","time spent":"1.344887756s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T05:18:42.537084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.346287432s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-30T05:18:42.537106Z","caller":"traceutil/trace.go:171","msg":"trace[1882180305] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"1.346363253s","start":"2026-05-30T05:18:41.190737Z","end":"2026-05-30T05:18:42.5371Z","steps":["trace[1882180305] 'agreement among raft nodes before linearized reading' (duration: 1.346311602s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:42.53712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:41.190706Z","time spent":"1.346409784s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-30T05:18:42.537204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.237867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:42.537224Z","caller":"traceutil/trace.go:171","msg":"trace[1606309010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"271.314669ms","start":"2026-05-30T05:18:42.265905Z","end":"2026-05-30T05:18:42.537219Z","steps":["trace[1606309010] 'agreement among raft nodes before linearized reading' (duration: 271.282408ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:44.270464Z","caller":"traceutil/trace.go:171","msg":"trace[1612465377] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"182.938629ms","start":"2026-05-30T05:18:44.087489Z","end":"2026-05-30T05:18:44.270428Z","steps":["trace[1612465377] 'process raft request' (duration: 182.57992ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:54.720795Z","caller":"traceutil/trace.go:171","msg":"trace[773030518] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"112.22849ms","start":"2026-05-30T05:18:54.608539Z","end":"2026-05-30T05:18:54.720767Z","steps":["trace[773030518] 'process raft request' (duration: 112.076925ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:54.722412Z","caller":"traceutil/trace.go:171","msg":"trace[1428678821] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"113.645247ms","start":"2026-05-30T05:18:54.608719Z","end":"2026-05-30T05:18:54.722364Z","steps":["trace[1428678821] 'process raft request' (duration: 113.327388ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:58.549298Z","caller":"traceutil/trace.go:171","msg":"trace[601219216] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"596.323433ms","start":"2026-05-30T05:18:57.95292Z","end":"2026-05-30T05:18:58.549243Z","steps":["trace[601219216] 'process raft request' (duration: 596.079326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:58.549592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:57.9529Z","time spent":"596.534078ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:18:58.554056Z","caller":"traceutil/trace.go:171","msg":"trace[1466515537] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"471.752379ms","start":"2026-05-30T05:18:58.082283Z","end":"2026-05-30T05:18:58.554035Z","steps":["trace[1466515537] 'process raft request' (duration: 471.469522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:58.554162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:58.082246Z","time spent":"471.863891ms","remote":"127.0.0.1:51844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:35.25618Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938291830277020516,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T05:19:35.505664Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.219891137s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T05:19:35.506029Z","caller":"traceutil/trace.go:171","msg":"trace[289175119] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1017; }","duration":"749.914493ms","start":"2026-05-30T05:19:34.756091Z","end":"2026-05-30T05:19:35.506006Z","steps":["trace[289175119] 'read index received' (duration: 749.75832ms)","trace[289175119] 'applied index is now lower than readState.Index' (duration: 155.493µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:19:35.506085Z","caller":"traceutil/trace.go:171","msg":"trace[1090162027] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"1.220446181s","start":"2026-05-30T05:19:34.285591Z","end":"2026-05-30T05:19:35.506038Z","steps":["trace[1090162027] 'process raft request' (duration: 1.220267007s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:35.506314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:34.28556Z","time spent":"1.220645596s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:35.506386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.144585ms","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-30T05:19:35.506417Z","caller":"traceutil/trace.go:171","msg":"trace[97282648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:982; }","duration":"562.195497ms","start":"2026-05-30T05:19:34.944213Z","end":"2026-05-30T05:19:35.506409Z","steps":["trace[97282648] 'agreement among raft nodes before linearized reading' (duration: 562.131345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:35.506321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.437009ms","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-30T05:19:35.506453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:34.944202Z","time spent":"562.240357ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T05:19:35.506464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.348615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:19:35.506507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.600123ms","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-30T05:19:35.506549Z","caller":"traceutil/trace.go:171","msg":"trace[1296484755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:982; }","duration":"498.460838ms","start":"2026-05-30T05:19:35.008073Z","end":"2026-05-30T05:19:35.506534Z","steps":["trace[1296484755] 'agreement among raft nodes before linearized reading' (duration: 498.337175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:35.506577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:35.008062Z","time spent":"498.510879ms","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-30T05:19:35.50657Z","caller":"traceutil/trace.go:171","msg":"trace[1820808639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:982; }","duration":"565.675735ms","start":"2026-05-30T05:19:34.940875Z","end":"2026-05-30T05:19:35.506551Z","steps":["trace[1820808639] 'agreement among raft nodes before linearized reading' (duration: 565.47325ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:35.506546Z","caller":"traceutil/trace.go:171","msg":"trace[599063339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:982; }","duration":"565.696636ms","start":"2026-05-30T05:19:34.940793Z","end":"2026-05-30T05:19:35.50649Z","steps":["trace[599063339] 'agreement among raft nodes before linearized reading' (duration: 565.409148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:35.506621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:34.940869Z","time spent":"565.740806ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:19:35.506722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:34.940768Z","time spent":"565.89209ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-30T05:19:35.507035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.429292ms","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-30T05:19:35.507075Z","caller":"traceutil/trace.go:171","msg":"trace[787944848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:982; }","duration":"562.487463ms","start":"2026-05-30T05:19:34.944579Z","end":"2026-05-30T05:19:35.507067Z","steps":["trace[787944848] 'agreement among raft nodes before linearized reading' (duration: 561.745025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:35.507097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:34.944568Z","time spent":"562.524545ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T05:19:35.507257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.168235ms","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-30T05:19:35.507289Z","caller":"traceutil/trace.go:171","msg":"trace[1136314523] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:982; }","duration":"751.255827ms","start":"2026-05-30T05:19:34.756026Z","end":"2026-05-30T05:19:35.507282Z","steps":["trace[1136314523] 'agreement among raft nodes before linearized reading' (duration: 751.150925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:35.507308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:34.756002Z","time spent":"751.301358ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-30T05:19:36.042853Z","caller":"traceutil/trace.go:171","msg":"trace[1183325098] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"528.250354ms","start":"2026-05-30T05:19:35.514564Z","end":"2026-05-30T05:19:36.042814Z","steps":["trace[1183325098] 'process raft request' (duration: 528.071709ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:36.042857Z","caller":"traceutil/trace.go:171","msg":"trace[907659933] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"528.717626ms","start":"2026-05-30T05:19:35.514082Z","end":"2026-05-30T05:19:36.0428Z","steps":["trace[907659933] 'process raft request' (duration: 520.740133ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:36.043053Z","caller":"traceutil/trace.go:171","msg":"trace[1932849974] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"528.364977ms","start":"2026-05-30T05:19:35.514665Z","end":"2026-05-30T05:19:36.04303Z","steps":["trace[1932849974] 'process raft request' (duration: 528.10446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:36.043119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:35.514544Z","time spent":"528.439819ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:36.043198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:35.514643Z","time spent":"528.47544ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:19:36.043171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:35.514042Z","time spent":"528.969182ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:19:36.043458Z","caller":"traceutil/trace.go:171","msg":"trace[1120891582] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"528.770988ms","start":"2026-05-30T05:19:35.514668Z","end":"2026-05-30T05:19:36.043439Z","steps":["trace[1120891582] 'process raft request' (duration: 528.241315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:36.043524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:35.514625Z","time spent":"528.8638ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:19:36.043985Z","caller":"traceutil/trace.go:171","msg":"trace[730869978] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"527.008033ms","start":"2026-05-30T05:19:35.516965Z","end":"2026-05-30T05:19:36.043973Z","steps":["trace[730869978] 'process raft request' (duration: 526.422468ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:36.044047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:35.516957Z","time spent":"527.056825ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:02.162469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.682693ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-05-30T05:20:02.162505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.801935ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:02.162615Z","caller":"traceutil/trace.go:171","msg":"trace[887054228] linearizableReadLoop","detail":"{readStateIndex:1110; appliedIndex:1109; }","duration":"572.641157ms","start":"2026-05-30T05:20:01.589946Z","end":"2026-05-30T05:20:02.162587Z","steps":["trace[887054228] 'read index received' (duration: 203.905663ms)","trace[887054228] 'applied index is now lower than readState.Index' (duration: 368.733584ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:02.162661Z","caller":"traceutil/trace.go:171","msg":"trace[365155289] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1068; }","duration":"150.98883ms","start":"2026-05-30T05:20:02.011649Z","end":"2026-05-30T05:20:02.162638Z","steps":["trace[365155289] 'range keys from in-memory index tree' (duration: 150.775074ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:02.16278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.824372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T05:20:02.162825Z","caller":"traceutil/trace.go:171","msg":"trace[1075503772] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1068; }","duration":"572.885653ms","start":"2026-05-30T05:20:01.589928Z","end":"2026-05-30T05:20:02.162814Z","steps":["trace[1075503772] 'agreement among raft nodes before linearized reading' (duration: 572.776571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:02.162866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:01.589851Z","time spent":"573.005086ms","remote":"127.0.0.1:52046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-05-30T05:20:02.200437Z","caller":"traceutil/trace.go:171","msg":"trace[297523790] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"603.698621ms","start":"2026-05-30T05:20:01.596705Z","end":"2026-05-30T05:20:02.200404Z","steps":["trace[297523790] 'process raft request' (duration: 603.448486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:02.200584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.288223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:20:02.20065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:01.596677Z","time spent":"603.858615ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:02.200673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.891955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:02.200692Z","caller":"traceutil/trace.go:171","msg":"trace[1414935990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1069; }","duration":"191.467188ms","start":"2026-05-30T05:20:02.009196Z","end":"2026-05-30T05:20:02.200663Z","steps":["trace[1414935990] 'agreement among raft nodes before linearized reading' (duration: 191.279383ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:02.200816Z","caller":"traceutil/trace.go:171","msg":"trace[482094538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1069; }","duration":"512.981527ms","start":"2026-05-30T05:20:01.687755Z","end":"2026-05-30T05:20:02.200736Z","steps":["trace[482094538] 'agreement among raft nodes before linearized reading' (duration: 512.844904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:02.200951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:01.6877Z","time spent":"513.241185ms","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-30T05:20:06.475173Z","caller":"traceutil/trace.go:171","msg":"trace[1291083592] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"135.985791ms","start":"2026-05-30T05:20:06.339143Z","end":"2026-05-30T05:20:06.475128Z","steps":["trace[1291083592] 'process raft request' (duration: 135.844726ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:06.475186Z","caller":"traceutil/trace.go:171","msg":"trace[480458692] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"135.55345ms","start":"2026-05-30T05:20:06.339599Z","end":"2026-05-30T05:20:06.475152Z","steps":["trace[480458692] 'process raft request' (duration: 135.429526ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:06.475294Z","caller":"traceutil/trace.go:171","msg":"trace[1621177071] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"136.796311ms","start":"2026-05-30T05:20:06.338461Z","end":"2026-05-30T05:20:06.475257Z","steps":["trace[1621177071] 'process raft request' (duration: 136.190755ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:06.475435Z","caller":"traceutil/trace.go:171","msg":"trace[155562825] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"136.909973ms","start":"2026-05-30T05:20:06.338509Z","end":"2026-05-30T05:20:06.475419Z","steps":["trace[155562825] 'process raft request' (duration: 136.430561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:24.923011Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938291830277021009,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-30T05:20:24.931981Z","caller":"traceutil/trace.go:171","msg":"trace[758391537] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"548.921803ms","start":"2026-05-30T05:20:24.383023Z","end":"2026-05-30T05:20:24.931944Z","steps":["trace[758391537] 'process raft request' (duration: 548.632506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:24.932158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:24.382984Z","time spent":"549.076687ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:20:24.932281Z","caller":"traceutil/trace.go:171","msg":"trace[225346340] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1239; }","duration":"509.582254ms","start":"2026-05-30T05:20:24.422619Z","end":"2026-05-30T05:20:24.932201Z","steps":["trace[225346340] 'read index received' (duration: 508.923338ms)","trace[225346340] 'applied index is now lower than readState.Index' (duration: 656.986µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:20:24.932491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.840761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:24.932527Z","caller":"traceutil/trace.go:171","msg":"trace[1866245350] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1192; }","duration":"509.964813ms","start":"2026-05-30T05:20:24.422551Z","end":"2026-05-30T05:20:24.932516Z","steps":["trace[1866245350] 'agreement among raft nodes before linearized reading' (duration: 509.860281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:24.932566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:24.422522Z","time spent":"510.034815ms","remote":"127.0.0.1:51914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:20:24.932729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.604786ms","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-30T05:20:24.932772Z","caller":"traceutil/trace.go:171","msg":"trace[1285831367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1192; }","duration":"423.693508ms","start":"2026-05-30T05:20:24.509067Z","end":"2026-05-30T05:20:24.93276Z","steps":["trace[1285831367] 'agreement among raft nodes before linearized reading' (duration: 423.513404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:24.932805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:24.509047Z","time spent":"423.752309ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T05:20:24.932985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.454322ms","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-30T05:20:24.933013Z","caller":"traceutil/trace.go:171","msg":"trace[628865420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1192; }","duration":"326.498793ms","start":"2026-05-30T05:20:24.606506Z","end":"2026-05-30T05:20:24.933004Z","steps":["trace[628865420] 'agreement among raft nodes before linearized reading' (duration: 326.417731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:24.933053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:24.60645Z","time spent":"326.595895ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:20:24.933272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.80472ms","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-30T05:20:24.933491Z","caller":"traceutil/trace.go:171","msg":"trace[1080166450] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1192; }","duration":"327.047197ms","start":"2026-05-30T05:20:24.60638Z","end":"2026-05-30T05:20:24.933427Z","steps":["trace[1080166450] 'agreement among raft nodes before linearized reading' (duration: 326.670987ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:24.933531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:24.60635Z","time spent":"327.16963ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T05:20:24.933529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.371416ms","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-30T05:20:24.933639Z","caller":"traceutil/trace.go:171","msg":"trace[649003818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1192; }","duration":"327.57485ms","start":"2026-05-30T05:20:24.606037Z","end":"2026-05-30T05:20:24.933612Z","steps":["trace[649003818] 'agreement among raft nodes before linearized reading' (duration: 327.136929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:24.933699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:24.606011Z","time spent":"327.675243ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T05:20:24.933812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.333144ms","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-30T05:20:24.933902Z","caller":"traceutil/trace.go:171","msg":"trace[842372028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1192; }","duration":"327.515097ms","start":"2026-05-30T05:20:24.606363Z","end":"2026-05-30T05:20:24.933878Z","steps":["trace[842372028] 'agreement among raft nodes before linearized reading' (duration: 326.580504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:24.933954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:24.606328Z","time spent":"327.61499ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-30T05:20:25.063669Z","caller":"traceutil/trace.go:171","msg":"trace[1946267038] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"125.794839ms","start":"2026-05-30T05:20:24.937817Z","end":"2026-05-30T05:20:25.063611Z","steps":["trace[1946267038] 'process raft request' (duration: 82.074823ms)","trace[1946267038] 'compare' (duration: 43.45708ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:25.130218Z","caller":"traceutil/trace.go:171","msg":"trace[1600851200] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"191.674242ms","start":"2026-05-30T05:20:24.938516Z","end":"2026-05-30T05:20:25.13019Z","steps":["trace[1600851200] 'process raft request' (duration: 191.58146ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:25.130232Z","caller":"traceutil/trace.go:171","msg":"trace[1751925348] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"192.370629ms","start":"2026-05-30T05:20:24.937838Z","end":"2026-05-30T05:20:25.130209Z","steps":["trace[1751925348] 'process raft request' (duration: 192.119253ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:25.130586Z","caller":"traceutil/trace.go:171","msg":"trace[2135555827] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"191.703784ms","start":"2026-05-30T05:20:24.938818Z","end":"2026-05-30T05:20:25.130522Z","steps":["trace[2135555827] 'process raft request' (duration: 191.317453ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:25.130651Z","caller":"traceutil/trace.go:171","msg":"trace[334169783] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1240; }","duration":"121.794191ms","start":"2026-05-30T05:20:25.008832Z","end":"2026-05-30T05:20:25.130627Z","steps":["trace[334169783] 'read index received' (duration: 11.067193ms)","trace[334169783] 'applied index is now lower than readState.Index' (duration: 110.725588ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:25.130692Z","caller":"traceutil/trace.go:171","msg":"trace[459690041] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"191.743923ms","start":"2026-05-30T05:20:24.938939Z","end":"2026-05-30T05:20:25.130682Z","steps":["trace[459690041] 'process raft request' (duration: 191.474076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:25.130781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.931654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:25.130815Z","caller":"traceutil/trace.go:171","msg":"trace[248499347] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1197; }","duration":"122.047327ms","start":"2026-05-30T05:20:25.008756Z","end":"2026-05-30T05:20:25.130804Z","steps":["trace[248499347] 'agreement among raft nodes before linearized reading' (duration: 121.957225ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:37.22269Z","caller":"traceutil/trace.go:171","msg":"trace[790494480] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"100.399803ms","start":"2026-05-30T05:20:37.122269Z","end":"2026-05-30T05:20:37.222669Z","steps":["trace[790494480] 'process raft request' (duration: 100.147077ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:38.293657Z","caller":"traceutil/trace.go:171","msg":"trace[203060530] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"258.217761ms","start":"2026-05-30T05:20:38.035422Z","end":"2026-05-30T05:20:38.29364Z","steps":["trace[203060530] 'process raft request' (duration: 258.089618ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:39.246373Z","caller":"traceutil/trace.go:171","msg":"trace[538707910] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"236.299172ms","start":"2026-05-30T05:20:39.010029Z","end":"2026-05-30T05:20:39.246328Z","steps":["trace[538707910] 'read index received' (duration: 236.041076ms)","trace[538707910] 'applied index is now lower than readState.Index' (duration: 257.306µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:39.246499Z","caller":"traceutil/trace.go:171","msg":"trace[1716963286] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"264.65314ms","start":"2026-05-30T05:20:38.981832Z","end":"2026-05-30T05:20:39.246485Z","steps":["trace[1716963286] 'process raft request' (duration: 264.362453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.246709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.662201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:39.246763Z","caller":"traceutil/trace.go:171","msg":"trace[380757807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1239; }","duration":"236.754602ms","start":"2026-05-30T05:20:39.009994Z","end":"2026-05-30T05:20:39.246749Z","steps":["trace[380757807] 'agreement among raft nodes before linearized reading' (duration: 236.66353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.246999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.980476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:39.247109Z","caller":"traceutil/trace.go:171","msg":"trace[524480962] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1239; }","duration":"146.13432ms","start":"2026-05-30T05:20:39.100951Z","end":"2026-05-30T05:20:39.247085Z","steps":["trace[524480962] 'agreement among raft nodes before linearized reading' (duration: 145.959935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.757639Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938291830277021139,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-30T05:20:39.781766Z","caller":"traceutil/trace.go:171","msg":"trace[1159831654] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"528.749545ms","start":"2026-05-30T05:20:39.252976Z","end":"2026-05-30T05:20:39.781726Z","steps":["trace[1159831654] 'process raft request' (duration: 528.616982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.781901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.25296Z","time spent":"528.864109ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:20:39.784307Z","caller":"traceutil/trace.go:171","msg":"trace[1803236395] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1290; }","duration":"527.010733ms","start":"2026-05-30T05:20:39.257279Z","end":"2026-05-30T05:20:39.78429Z","steps":["trace[1803236395] 'read index received' (duration: 524.284315ms)","trace[1803236395] 'applied index is now lower than readState.Index' (duration: 2.725528ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:39.78448Z","caller":"traceutil/trace.go:171","msg":"trace[984218537] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"531.456092ms","start":"2026-05-30T05:20:39.253012Z","end":"2026-05-30T05:20:39.784468Z","steps":["trace[984218537] 'process raft request' (duration: 531.197066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.784554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.252999Z","time spent":"531.513493ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:39.784722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.442124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-30T05:20:39.784758Z","caller":"traceutil/trace.go:171","msg":"trace[1731699474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1241; }","duration":"527.503165ms","start":"2026-05-30T05:20:39.257246Z","end":"2026-05-30T05:20:39.784749Z","steps":["trace[1731699474] 'agreement among raft nodes before linearized reading' (duration: 527.386162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.784785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.257225Z","time spent":"527.553997ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T05:20:39.784905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.43035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-30T05:20:39.784935Z","caller":"traceutil/trace.go:171","msg":"trace[876715622] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1241; }","duration":"522.474452ms","start":"2026-05-30T05:20:39.262453Z","end":"2026-05-30T05:20:39.784928Z","steps":["trace[876715622] 'agreement among raft nodes before linearized reading' (duration: 522.40155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.78496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.262441Z","time spent":"522.513572ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T05:20:39.785204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.54636ms","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-30T05:20:39.785409Z","caller":"traceutil/trace.go:171","msg":"trace[563378647] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1241; }","duration":"433.818636ms","start":"2026-05-30T05:20:39.351565Z","end":"2026-05-30T05:20:39.785384Z","steps":["trace[563378647] 'agreement among raft nodes before linearized reading' (duration: 433.5345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.785542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.351549Z","time spent":"433.973512ms","remote":"127.0.0.1:44716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:20:39.785428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.17786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-30T05:20:39.785581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.501565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:39.785688Z","caller":"traceutil/trace.go:171","msg":"trace[2049640845] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1241; }","duration":"230.431217ms","start":"2026-05-30T05:20:39.555239Z","end":"2026-05-30T05:20:39.785671Z","steps":["trace[2049640845] 'agreement among raft nodes before linearized reading' (duration: 230.15103ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:39.785747Z","caller":"traceutil/trace.go:171","msg":"trace[1010480161] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1241; }","duration":"225.753852ms","start":"2026-05-30T05:20:39.559964Z","end":"2026-05-30T05:20:39.785718Z","steps":["trace[1010480161] 'agreement among raft nodes before linearized reading' (duration: 225.309081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.785298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.754836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T05:20:39.785858Z","caller":"traceutil/trace.go:171","msg":"trace[624889814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1241; }","duration":"516.33744ms","start":"2026-05-30T05:20:39.269511Z","end":"2026-05-30T05:20:39.785848Z","steps":["trace[624889814] 'agreement among raft nodes before linearized reading' (duration: 515.692464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:39.785893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.269501Z","time spent":"516.382021ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T05:20:40.369277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.036191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:20:40.369725Z","caller":"traceutil/trace.go:171","msg":"trace[529916060] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"580.09887ms","start":"2026-05-30T05:20:39.789588Z","end":"2026-05-30T05:20:40.369687Z","steps":["trace[529916060] 'process raft request' (duration: 469.491585ms)","trace[529916060] 'compare' (duration: 109.439057ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:40.369789Z","caller":"traceutil/trace.go:171","msg":"trace[2071417467] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"578.367278ms","start":"2026-05-30T05:20:39.79136Z","end":"2026-05-30T05:20:40.369727Z","steps":["trace[2071417467] 'process raft request' (duration: 578.303487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:40.369895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.791352Z","time spent":"578.499771ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:40.369937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.789571Z","time spent":"580.259275ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:20:40.370076Z","caller":"traceutil/trace.go:171","msg":"trace[1068898565] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"579.211968ms","start":"2026-05-30T05:20:39.790826Z","end":"2026-05-30T05:20:40.370038Z","steps":["trace[1068898565] 'process raft request' (duration: 578.704256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:40.370312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:39.7908Z","time spent":"579.363233ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:41.591372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.759007ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-30T05:20:41.591904Z","caller":"traceutil/trace.go:171","msg":"trace[1442296631] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"251.368803ms","start":"2026-05-30T05:20:41.340484Z","end":"2026-05-30T05:20:41.591853Z","steps":["trace[1442296631] 'process raft request' (duration: 251.162477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:41.592031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.331713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:41.592083Z","caller":"traceutil/trace.go:171","msg":"trace[1772669628] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1247; }","duration":"232.457267ms","start":"2026-05-30T05:20:41.35961Z","end":"2026-05-30T05:20:41.592067Z","steps":["trace[1772669628] 'agreement among raft nodes before linearized reading' (duration: 232.312934ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:41.591878Z","caller":"traceutil/trace.go:171","msg":"trace[659146550] linearizableReadLoop","detail":"{readStateIndex:1299; appliedIndex:1297; }","duration":"232.150279ms","start":"2026-05-30T05:20:41.359674Z","end":"2026-05-30T05:20:41.591824Z","steps":["trace[659146550] 'read index received' (duration: 60.725106ms)","trace[659146550] 'applied index is now lower than readState.Index' (duration: 171.423033ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:20:42.131596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.063437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-30T05:20:42.131924Z","caller":"traceutil/trace.go:171","msg":"trace[1418440983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1247; }","duration":"342.457987ms","start":"2026-05-30T05:20:41.789445Z","end":"2026-05-30T05:20:42.131903Z","steps":["trace[1418440983] 'range keys from in-memory index tree' (duration: 341.850772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:42.131675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.94886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-30T05:20:42.132021Z","caller":"traceutil/trace.go:171","msg":"trace[2000310539] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1247; }","duration":"341.36064ms","start":"2026-05-30T05:20:41.790644Z","end":"2026-05-30T05:20:42.132004Z","steps":["trace[2000310539] 'range keys from in-memory index tree' (duration: 340.765726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:42.132038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:41.789418Z","time spent":"342.6066ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T05:20:42.132069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:41.790611Z","time spent":"341.443392ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-30T05:20:42.131726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.276663ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:42.13248Z","caller":"traceutil/trace.go:171","msg":"trace[300769587] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1247; }","duration":"121.031982ms","start":"2026-05-30T05:20:42.011433Z","end":"2026-05-30T05:20:42.132465Z","steps":["trace[300769587] 'range keys from in-memory index tree' (duration: 120.263443ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:42.392162Z","caller":"traceutil/trace.go:171","msg":"trace[2054022729] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"256.234053ms","start":"2026-05-30T05:20:42.135904Z","end":"2026-05-30T05:20:42.392138Z","steps":["trace[2054022729] 'process raft request' (duration: 256.065619ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:42.487862Z","caller":"traceutil/trace.go:171","msg":"trace[1397341755] linearizableReadLoop","detail":"{readStateIndex:1301; appliedIndex:1299; }","duration":"257.878383ms","start":"2026-05-30T05:20:42.229958Z","end":"2026-05-30T05:20:42.487836Z","steps":["trace[1397341755] 'read index received' (duration: 161.93634ms)","trace[1397341755] 'applied index is now lower than readState.Index' (duration: 95.940793ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:42.488024Z","caller":"traceutil/trace.go:171","msg":"trace[496199331] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"351.609773ms","start":"2026-05-30T05:20:42.136383Z","end":"2026-05-30T05:20:42.487993Z","steps":["trace[496199331] 'process raft request' (duration: 307.928336ms)","trace[496199331] 'compare' (duration: 43.42227ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:20:42.488091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.107059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:42.488127Z","caller":"traceutil/trace.go:171","msg":"trace[37451234] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1249; }","duration":"258.211691ms","start":"2026-05-30T05:20:42.229905Z","end":"2026-05-30T05:20:42.488116Z","steps":["trace[37451234] 'agreement among raft nodes before linearized reading' (duration: 258.092068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:42.488195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:42.136337Z","time spent":"351.748716ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:42.48847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.430049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-30T05:20:42.488505Z","caller":"traceutil/trace.go:171","msg":"trace[1944040677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1249; }","duration":"114.503951ms","start":"2026-05-30T05:20:42.373988Z","end":"2026-05-30T05:20:42.488492Z","steps":["trace[1944040677] 'agreement among raft nodes before linearized reading' (duration: 114.356707ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:42.488627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.6405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-30T05:20:42.488658Z","caller":"traceutil/trace.go:171","msg":"trace[596486054] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1249; }","duration":"113.715172ms","start":"2026-05-30T05:20:42.374934Z","end":"2026-05-30T05:20:42.488649Z","steps":["trace[596486054] 'agreement among raft nodes before linearized reading' (duration: 113.597359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:42.488786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.222304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T05:20:42.488874Z","caller":"traceutil/trace.go:171","msg":"trace[532012790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1249; }","duration":"114.374578ms","start":"2026-05-30T05:20:42.374478Z","end":"2026-05-30T05:20:42.488853Z","steps":["trace[532012790] 'agreement among raft nodes before linearized reading' (duration: 114.124631ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:43.045993Z","caller":"traceutil/trace.go:171","msg":"trace[442283432] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"189.790935ms","start":"2026-05-30T05:20:42.855679Z","end":"2026-05-30T05:20:43.045469Z","steps":["trace[442283432] 'process raft request' (duration: 189.536329ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:43.685812Z","caller":"traceutil/trace.go:171","msg":"trace[1146372818] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"330.378569ms","start":"2026-05-30T05:20:43.355379Z","end":"2026-05-30T05:20:43.685757Z","steps":["trace[1146372818] 'process raft request' (duration: 330.115863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:43.686049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:43.35535Z","time spent":"330.596893ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:20:47.871919Z","caller":"traceutil/trace.go:171","msg":"trace[810532944] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"126.112847ms","start":"2026-05-30T05:20:47.745772Z","end":"2026-05-30T05:20:47.871885Z","steps":["trace[810532944] 'process raft request' (duration: 87.074245ms)","trace[810532944] 'compare' (duration: 38.891888ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:47.871963Z","caller":"traceutil/trace.go:171","msg":"trace[2116301419] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"113.305561ms","start":"2026-05-30T05:20:47.75863Z","end":"2026-05-30T05:20:47.871935Z","steps":["trace[2116301419] 'process raft request' (duration: 113.230309ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:47.872066Z","caller":"traceutil/trace.go:171","msg":"trace[303039280] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1349; }","duration":"113.565207ms","start":"2026-05-30T05:20:47.758474Z","end":"2026-05-30T05:20:47.872039Z","steps":["trace[303039280] 'read index received' (duration: 74.382253ms)","trace[303039280] 'applied index is now lower than readState.Index' (duration: 39.181424ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:20:47.872225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.741432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-30T05:20:47.872246Z","caller":"traceutil/trace.go:171","msg":"trace[1847266728] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1298; }","duration":"113.804955ms","start":"2026-05-30T05:20:47.758436Z","end":"2026-05-30T05:20:47.872241Z","steps":["trace[1847266728] 'agreement among raft nodes before linearized reading' (duration: 113.703922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:48.110212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.368688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:48.110295Z","caller":"traceutil/trace.go:171","msg":"trace[741544244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1299; }","duration":"101.505611ms","start":"2026-05-30T05:20:48.008776Z","end":"2026-05-30T05:20:48.110282Z","steps":["trace[741544244] 'range keys from in-memory index tree' (duration: 101.287255ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:55.113629Z","caller":"traceutil/trace.go:171","msg":"trace[1217216516] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"534.950938ms","start":"2026-05-30T05:20:54.578647Z","end":"2026-05-30T05:20:55.113598Z","steps":["trace[1217216516] 'process raft request' (duration: 534.740043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:55.113828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:54.57863Z","time spent":"535.089502ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:56.630418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.165408651s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:20:56.630576Z","caller":"traceutil/trace.go:171","msg":"trace[828682908] linearizableReadLoop","detail":"{readStateIndex:1406; appliedIndex:1404; }","duration":"1.93540978s","start":"2026-05-30T05:20:54.695138Z","end":"2026-05-30T05:20:56.630547Z","steps":["trace[828682908] 'read index received' (duration: 418.333866ms)","trace[828682908] 'applied index is now lower than readState.Index' (duration: 1.517073284s)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:56.630645Z","caller":"traceutil/trace.go:171","msg":"trace[1070931541] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"2.05110146s","start":"2026-05-30T05:20:54.579508Z","end":"2026-05-30T05:20:56.630609Z","steps":["trace[1070931541] 'process raft request' (duration: 884.743145ms)","trace[1070931541] 'compare' (duration: 1.164820787s)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:20:56.630824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:54.579489Z","time spent":"2.051231142s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:56.630898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.935755268s","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-30T05:20:56.630953Z","caller":"traceutil/trace.go:171","msg":"trace[502008433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1352; }","duration":"1.93585901s","start":"2026-05-30T05:20:54.695077Z","end":"2026-05-30T05:20:56.630936Z","steps":["trace[502008433] 'agreement among raft nodes before linearized reading' (duration: 1.935588544s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:56.631003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:54.69506Z","time spent":"1.935930732s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T05:20:57.009631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000410751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-30T05:20:57.009729Z","caller":"traceutil/trace.go:171","msg":"trace[1112528284] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000560145s","start":"2026-05-30T05:20:55.009146Z","end":"2026-05-30T05:20:57.009706Z","steps":["trace[1112528284] 'agreement among raft nodes before linearized reading' (duration: 2.000438902s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.00978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:55.009128Z","time spent":"2.000642426s","remote":"127.0.0.1:51624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/30 05:20:57 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-30T05:20:57.131721Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10938291830277021348,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T05:20:57.144995Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.156407719s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T05:20:57.146072Z","caller":"traceutil/trace.go:171","msg":"trace[1011303764] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"1.157598138s","start":"2026-05-30T05:20:55.988446Z","end":"2026-05-30T05:20:57.146044Z","steps":["trace[1011303764] 'process raft request' (duration: 1.157311201s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.146459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:55.988419Z","time spent":"1.157816883s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:20:57.155885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004007754s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.157\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-30T05:20:57.155928Z","caller":"traceutil/trace.go:171","msg":"trace[304882707] range","detail":"{range_begin:/registry/masterleases/199.204.45.157; range_end:; response_count:1; response_revision:1354; }","duration":"1.004094007s","start":"2026-05-30T05:20:56.151824Z","end":"2026-05-30T05:20:57.155918Z","steps":["trace[304882707] 'agreement among raft nodes before linearized reading' (duration: 1.003930572s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.15592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.39695421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T05:20:57.155998Z","caller":"traceutil/trace.go:171","msg":"trace[1428555780] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1354; }","duration":"2.397094843s","start":"2026-05-30T05:20:54.758888Z","end":"2026-05-30T05:20:57.155983Z","steps":["trace[1428555780] 'agreement among raft nodes before linearized reading' (duration: 2.396899478s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.155956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.399240937s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-30T05:20:57.156056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:54.758869Z","time spent":"2.397175295s","remote":"127.0.0.1:51972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-05-30T05:20:57.156084Z","caller":"traceutil/trace.go:171","msg":"trace[1816675344] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1354; }","duration":"2.399456472s","start":"2026-05-30T05:20:54.756598Z","end":"2026-05-30T05:20:57.156054Z","steps":["trace[1816675344] 'agreement among raft nodes before linearized reading' (duration: 2.399228966s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.156106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.906962ms","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-30T05:20:57.15615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.490475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-05-30T05:20:57.156198Z","caller":"traceutil/trace.go:171","msg":"trace[677636235] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1354; }","duration":"691.597177ms","start":"2026-05-30T05:20:56.464591Z","end":"2026-05-30T05:20:57.156189Z","steps":["trace[677636235] 'agreement among raft nodes before linearized reading' (duration: 691.506755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.156174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.642601076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:20:57.156227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:56.464514Z","time spent":"691.70783ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-30T05:20:57.156257Z","caller":"traceutil/trace.go:171","msg":"trace[1316259606] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"520.180836ms","start":"2026-05-30T05:20:56.636065Z","end":"2026-05-30T05:20:57.156246Z","steps":["trace[1316259606] 'process raft request' (duration: 519.531129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.156266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:54.756564Z","time spent":"2.399579455s","remote":"127.0.0.1:44792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:20:57.155954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:56.151802Z","time spent":"1.004146978s","remote":"127.0.0.1:51640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.157\" "} {"level":"warn","ts":"2026-05-30T05:20:57.156191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.535054547s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"warn","ts":"2026-05-30T05:20:57.156378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:56.636041Z","time spent":"520.260947ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:20:57.156195Z","caller":"traceutil/trace.go:171","msg":"trace[172461478] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1354; }","duration":"644.071497ms","start":"2026-05-30T05:20:56.512103Z","end":"2026-05-30T05:20:57.156175Z","steps":["trace[172461478] 'agreement among raft nodes before linearized reading' (duration: 643.872332ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:57.156266Z","caller":"traceutil/trace.go:171","msg":"trace[1157156515] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1354; }","duration":"1.642713178s","start":"2026-05-30T05:20:55.513519Z","end":"2026-05-30T05:20:57.156232Z","steps":["trace[1157156515] 'agreement among raft nodes before linearized reading' (duration: 1.642542954s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.156492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:56.512076Z","time spent":"644.402524ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-30T05:20:57.156522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:55.513501Z","time spent":"1.643008376s","remote":"127.0.0.1:51900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-05-30T05:20:57.156417Z","caller":"traceutil/trace.go:171","msg":"trace[172767706] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1354; }","duration":"1.535340153s","start":"2026-05-30T05:20:55.621066Z","end":"2026-05-30T05:20:57.156406Z","steps":["trace[172767706] 'agreement among raft nodes before linearized reading' (duration: 1.534784409s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.156602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.42535343s","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-30T05:20:57.156705Z","caller":"traceutil/trace.go:171","msg":"trace[1084914364] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1354; }","duration":"2.425501053s","start":"2026-05-30T05:20:54.731192Z","end":"2026-05-30T05:20:57.156693Z","steps":["trace[1084914364] 'agreement among raft nodes before linearized reading' (duration: 2.424834137s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.156773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:54.731168Z","time spent":"2.425594715s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-05-30T05:20:57.156945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.459479541s","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-30T05:20:57.156987Z","caller":"traceutil/trace.go:171","msg":"trace[361383110] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1354; }","duration":"2.459545582s","start":"2026-05-30T05:20:54.697431Z","end":"2026-05-30T05:20:57.156977Z","steps":["trace[361383110] 'agreement among raft nodes before linearized reading' (duration: 2.459382578s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:57.157047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:54.697419Z","time spent":"2.459595654s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T05:20:57.156716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:55.621036Z","time spent":"1.5356039s","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-30T05:20:57.156762Z","caller":"traceutil/trace.go:171","msg":"trace[378153443] linearizableReadLoop","detail":"{readStateIndex:1408; appliedIndex:1406; }","duration":"525.120046ms","start":"2026-05-30T05:20:56.630614Z","end":"2026-05-30T05:20:57.155734Z","steps":["trace[378153443] 'read index received' (duration: 515.065849ms)","trace[378153443] 'applied index is now lower than readState.Index' (duration: 10.052437ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:20:57.172195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.782255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:57.172236Z","caller":"traceutil/trace.go:171","msg":"trace[1182668258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1354; }","duration":"161.900988ms","start":"2026-05-30T05:20:57.010325Z","end":"2026-05-30T05:20:57.172226Z","steps":["trace[1182668258] 'agreement among raft nodes before linearized reading' (duration: 161.594231ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:23:36.139738Z","caller":"traceutil/trace.go:171","msg":"trace[842616300] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"100.942133ms","start":"2026-05-30T05:23:36.038724Z","end":"2026-05-30T05:23:36.139666Z","steps":["trace[842616300] 'process raft request' (duration: 52.645964ms)","trace[842616300] 'compare' (duration: 48.141644ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:23:42.325396Z","caller":"traceutil/trace.go:171","msg":"trace[1544197111] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"107.827223ms","start":"2026-05-30T05:23:42.217534Z","end":"2026-05-30T05:23:42.325361Z","steps":["trace[1544197111] 'process raft request' (duration: 107.764971ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:23:42.325443Z","caller":"traceutil/trace.go:171","msg":"trace[421849461] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"111.120734ms","start":"2026-05-30T05:23:42.214274Z","end":"2026-05-30T05:23:42.325395Z","steps":["trace[421849461] 'process raft request' (duration: 110.815426ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:24:48.743142Z","caller":"traceutil/trace.go:171","msg":"trace[393707933] linearizableReadLoop","detail":"{readStateIndex:2543; appliedIndex:2542; }","duration":"196.806767ms","start":"2026-05-30T05:24:48.546304Z","end":"2026-05-30T05:24:48.74311Z","steps":["trace[393707933] 'read index received' (duration: 193.551207ms)","trace[393707933] 'applied index is now lower than readState.Index' (duration: 3.25378ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:24:48.743321Z","caller":"traceutil/trace.go:171","msg":"trace[2047099495] transaction","detail":"{read_only:false; response_revision:2441; number_of_response:1; }","duration":"232.006423ms","start":"2026-05-30T05:24:48.51129Z","end":"2026-05-30T05:24:48.743296Z","steps":["trace[2047099495] 'process raft request' (duration: 228.537447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:24:48.743646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.312229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-30T05:24:48.74377Z","caller":"traceutil/trace.go:171","msg":"trace[913512783] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2441; }","duration":"197.499373ms","start":"2026-05-30T05:24:48.546237Z","end":"2026-05-30T05:24:48.743736Z","steps":["trace[913512783] 'agreement among raft nodes before linearized reading' (duration: 197.187446ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:24:58.175137Z","caller":"traceutil/trace.go:171","msg":"trace[94072751] linearizableReadLoop","detail":"{readStateIndex:2591; appliedIndex:2590; }","duration":"419.194543ms","start":"2026-05-30T05:24:57.75591Z","end":"2026-05-30T05:24:58.175104Z","steps":["trace[94072751] 'read index received' (duration: 418.981128ms)","trace[94072751] 'applied index is now lower than readState.Index' (duration: 211.845µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:24:58.175263Z","caller":"traceutil/trace.go:171","msg":"trace[1273480613] transaction","detail":"{read_only:false; response_revision:2487; number_of_response:1; }","duration":"447.845598ms","start":"2026-05-30T05:24:57.727393Z","end":"2026-05-30T05:24:58.175238Z","steps":["trace[1273480613] 'process raft request' (duration: 447.438789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:24:58.175407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.49244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-05-30T05:24:58.175462Z","caller":"traceutil/trace.go:171","msg":"trace[1036806020] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2487; }","duration":"419.650553ms","start":"2026-05-30T05:24:57.755794Z","end":"2026-05-30T05:24:58.175445Z","steps":["trace[1036806020] 'agreement among raft nodes before linearized reading' (duration: 419.470489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:24:58.175746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:24:57.75577Z","time spent":"419.958711ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-30T05:24:58.175837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.524633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-30T05:24:58.175976Z","caller":"traceutil/trace.go:171","msg":"trace[202300145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2487; }","duration":"212.753629ms","start":"2026-05-30T05:24:57.963191Z","end":"2026-05-30T05:24:58.175944Z","steps":["trace[202300145] 'agreement among raft nodes before linearized reading' (duration: 212.322598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:24:58.175997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:24:57.727374Z","time spent":"447.953831ms","remote":"127.0.0.1:51868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:24:58.175852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.607895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:24:58.176118Z","caller":"traceutil/trace.go:171","msg":"trace[1637788598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2487; }","duration":"160.919112ms","start":"2026-05-30T05:24:58.015167Z","end":"2026-05-30T05:24:58.176086Z","steps":["trace[1637788598] 'agreement among raft nodes before linearized reading' (duration: 160.602095ms)"],"step_count":1}