{"level":"warn","ts":"2026-04-13T15:18:06.034065Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T15:18:06.034191Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-13T15:18:06.034285Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T15:18:06.034299Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-13T15:18:06.034323Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-13T15:18:06.035094Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-04-13T15:18:06.035212Z","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":16,"max-cpu-available":16,"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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-13T15:18:06.039723Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.230426ms"} {"level":"info","ts":"2026-04-13T15:18:06.049896Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-04-13T15:18:06.050011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T15:18:06.050042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-04-13T15:18:06.050068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T15:18:06.050082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-04-13T15:18:06.050152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-04-13T15:18:06.060554Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T15:18:06.061918Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T15:18:06.063088Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-13T15:18:06.065336Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T15:18:06.065909Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T15:18:06.06611Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T15:18:06.066733Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T15:18:06.066752Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-13T15:18:06.067311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-04-13T15:18:06.067485Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-13T15:18:06.07037Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-13T15:18:06.070554Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-13T15:18:06.070712Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-13T15:18:06.070856Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T15:18:06.070932Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T15:18:06.950752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T15:18:06.950812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T15:18:06.950831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-04-13T15:18:06.950845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-04-13T15:18:06.950852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-13T15:18:06.950862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-04-13T15:18:06.950871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-13T15:18:06.952137Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:18:06.953286Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T15:18:06.953288Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T15:18:06.953352Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T15:18:06.953734Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:18:06.953766Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T15:18:06.953848Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T15:18:06.953851Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:18:06.953893Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T15:18:06.956139Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-04-13T15:18:06.957256Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T15:18:18.102669Z","caller":"traceutil/trace.go:171","msg":"trace[863183373] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"139.173696ms","start":"2026-04-13T15:18:17.963447Z","end":"2026-04-13T15:18:18.10262Z","steps":["trace[863183373] 'process raft request' (duration: 138.954898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:26.390591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.023017ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-13T15:18:26.390721Z","caller":"traceutil/trace.go:171","msg":"trace[1123101663] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:463; }","duration":"221.727888ms","start":"2026-04-13T15:18:26.168977Z","end":"2026-04-13T15:18:26.390705Z","steps":["trace[1123101663] 'read index received' (duration: 39.281µs)","trace[1123101663] 'applied index is now lower than readState.Index' (duration: 221.687217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:18:26.390804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.822841ms","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-04-13T15:18:26.390831Z","caller":"traceutil/trace.go:171","msg":"trace[184856022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:450; }","duration":"221.900944ms","start":"2026-04-13T15:18:26.168923Z","end":"2026-04-13T15:18:26.390824Z","steps":["trace[184856022] 'agreement among raft nodes before linearized reading' (duration: 221.821421ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:37.197655Z","caller":"traceutil/trace.go:171","msg":"trace[1712965820] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"179.979772ms","start":"2026-04-13T15:18:37.017646Z","end":"2026-04-13T15:18:37.197626Z","steps":["trace[1712965820] 'read index received' (duration: 179.700614ms)","trace[1712965820] 'applied index is now lower than readState.Index' (duration: 277.618µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:18:37.19773Z","caller":"traceutil/trace.go:171","msg":"trace[1594227443] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"252.629186ms","start":"2026-04-13T15:18:36.945057Z","end":"2026-04-13T15:18:37.197686Z","steps":["trace[1594227443] 'process raft request' (duration: 252.389899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:37.197822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.161558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:18:37.197869Z","caller":"traceutil/trace.go:171","msg":"trace[1669229205] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:511; }","duration":"180.282221ms","start":"2026-04-13T15:18:37.017571Z","end":"2026-04-13T15:18:37.197853Z","steps":["trace[1669229205] 'agreement among raft nodes before linearized reading' (duration: 180.181569ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:43.483777Z","caller":"traceutil/trace.go:171","msg":"trace[1331228853] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"256.510995ms","start":"2026-04-13T15:18:43.227236Z","end":"2026-04-13T15:18:43.483747Z","steps":["trace[1331228853] 'process raft request' (duration: 256.32674ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:43.942821Z","caller":"traceutil/trace.go:171","msg":"trace[1623445319] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"628.918261ms","start":"2026-04-13T15:18:43.313871Z","end":"2026-04-13T15:18:43.94279Z","steps":["trace[1623445319] 'read index received' (duration: 169.593155ms)","trace[1623445319] 'applied index is now lower than readState.Index' (duration: 459.323956ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:18:43.942953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.057274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:18:43.942985Z","caller":"traceutil/trace.go:171","msg":"trace[556221117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"629.133807ms","start":"2026-04-13T15:18:43.313841Z","end":"2026-04-13T15:18:43.942975Z","steps":["trace[556221117] 'agreement among raft nodes before linearized reading' (duration: 629.056894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:43.943023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:43.313822Z","time spent":"629.193479ms","remote":"127.0.0.1:46704","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-04-13T15:18:43.94317Z","caller":"traceutil/trace.go:171","msg":"trace[1867180368] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"641.15722ms","start":"2026-04-13T15:18:43.301961Z","end":"2026-04-13T15:18:43.943118Z","steps":["trace[1867180368] 'process raft request' (duration: 640.222295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:43.944006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:43.301927Z","time spent":"641.364276ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:18:44.290546Z","caller":"traceutil/trace.go:171","msg":"trace[1903958835] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"281.961382ms","start":"2026-04-13T15:18:44.008558Z","end":"2026-04-13T15:18:44.290519Z","steps":["trace[1903958835] 'process raft request' (duration: 251.90858ms)","trace[1903958835] 'compare' (duration: 29.751494ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:18:44.290652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.436213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-222fs\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-13T15:18:44.290783Z","caller":"traceutil/trace.go:171","msg":"trace[662602493] range","detail":"{range_begin:/registry/pods/kube-system/cilium-222fs; range_end:; response_count:1; response_revision:617; }","duration":"292.618207ms","start":"2026-04-13T15:18:43.998134Z","end":"2026-04-13T15:18:44.290752Z","steps":["trace[662602493] 'range keys from in-memory index tree' (duration: 292.107554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:45.427323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.397905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-13T15:18:45.427422Z","caller":"traceutil/trace.go:171","msg":"trace[1741396402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"775.561959ms","start":"2026-04-13T15:18:44.651839Z","end":"2026-04-13T15:18:45.427401Z","steps":["trace[1741396402] 'range keys from in-memory index tree' (duration: 775.23141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:45.427462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:44.651813Z","time spent":"775.639241ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T15:18:45.427594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.47317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-13T15:18:45.427618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.495848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-13T15:18:45.427689Z","caller":"traceutil/trace.go:171","msg":"trace[1255083601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"765.648574ms","start":"2026-04-13T15:18:44.662019Z","end":"2026-04-13T15:18:45.427667Z","steps":["trace[1255083601] 'range keys from in-memory index tree' (duration: 765.241054ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:45.427728Z","caller":"traceutil/trace.go:171","msg":"trace[452551805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"874.641772ms","start":"2026-04-13T15:18:44.553057Z","end":"2026-04-13T15:18:45.427699Z","steps":["trace[452551805] 'range keys from in-memory index tree' (duration: 874.291343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:45.427738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:44.661993Z","time spent":"765.735467ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T15:18:45.427781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:44.553038Z","time spent":"874.731345ms","remote":"127.0.0.1:46970","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-04-13T15:18:45.427794Z","caller":"traceutil/trace.go:171","msg":"trace[46289491] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"112.095044ms","start":"2026-04-13T15:18:45.315682Z","end":"2026-04-13T15:18:45.427777Z","steps":["trace[46289491] 'read index received' (duration: 104.77854ms)","trace[46289491] 'applied index is now lower than readState.Index' (duration: 7.315254ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:18:45.427869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.192776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:18:45.427897Z","caller":"traceutil/trace.go:171","msg":"trace[2094510470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"112.273568ms","start":"2026-04-13T15:18:45.315612Z","end":"2026-04-13T15:18:45.427885Z","steps":["trace[2094510470] 'agreement among raft nodes before linearized reading' (duration: 112.222226ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:45.42793Z","caller":"traceutil/trace.go:171","msg":"trace[444564043] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"692.920104ms","start":"2026-04-13T15:18:44.734995Z","end":"2026-04-13T15:18:45.427915Z","steps":["trace[444564043] 'process raft request' (duration: 685.707453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:45.428049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:18:44.734963Z","time spent":"692.996166ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:18:47.331137Z","caller":"traceutil/trace.go:171","msg":"trace[758806964] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"175.045607ms","start":"2026-04-13T15:18:47.156032Z","end":"2026-04-13T15:18:47.331077Z","steps":["trace[758806964] 'read index received' (duration: 174.757269ms)","trace[758806964] 'applied index is now lower than readState.Index' (duration: 287.138µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:18:47.331148Z","caller":"traceutil/trace.go:171","msg":"trace[1245586411] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"180.055647ms","start":"2026-04-13T15:18:47.151064Z","end":"2026-04-13T15:18:47.331119Z","steps":["trace[1245586411] 'process raft request' (duration: 179.817781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:47.331421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.361315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:18:47.331505Z","caller":"traceutil/trace.go:171","msg":"trace[517932313] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:652; }","duration":"175.492317ms","start":"2026-04-13T15:18:47.155995Z","end":"2026-04-13T15:18:47.331487Z","steps":["trace[517932313] 'agreement among raft nodes before linearized reading' (duration: 175.21798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:47.331546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.373345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:18:47.331634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.984785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:18:47.331682Z","caller":"traceutil/trace.go:171","msg":"trace[1486135161] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:652; }","duration":"145.085628ms","start":"2026-04-13T15:18:47.186583Z","end":"2026-04-13T15:18:47.331668Z","steps":["trace[1486135161] 'agreement among raft nodes before linearized reading' (duration: 144.980645ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:47.331701Z","caller":"traceutil/trace.go:171","msg":"trace[1041201694] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:652; }","duration":"175.544179ms","start":"2026-04-13T15:18:47.156098Z","end":"2026-04-13T15:18:47.331642Z","steps":["trace[1041201694] 'agreement among raft nodes before linearized reading' (duration: 175.289893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:18:47.331838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.016815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:18:47.331849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.456324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:18:47.33184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.397946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:18:47.331909Z","caller":"traceutil/trace.go:171","msg":"trace[394263423] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:652; }","duration":"175.107938ms","start":"2026-04-13T15:18:47.156781Z","end":"2026-04-13T15:18:47.331889Z","steps":["trace[394263423] 'agreement among raft nodes before linearized reading' (duration: 174.973214ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:47.331917Z","caller":"traceutil/trace.go:171","msg":"trace[180210312] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:652; }","duration":"141.576917ms","start":"2026-04-13T15:18:47.190319Z","end":"2026-04-13T15:18:47.331896Z","steps":["trace[180210312] 'agreement among raft nodes before linearized reading' (duration: 141.483274ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:18:47.331936Z","caller":"traceutil/trace.go:171","msg":"trace[1977161772] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:652; }","duration":"145.905029ms","start":"2026-04-13T15:18:47.18601Z","end":"2026-04-13T15:18:47.331915Z","steps":["trace[1977161772] 'agreement among raft nodes before linearized reading' (duration: 145.690004ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:01.37266Z","caller":"traceutil/trace.go:171","msg":"trace[1540582079] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"250.973203ms","start":"2026-04-13T15:19:01.121652Z","end":"2026-04-13T15:19:01.372626Z","steps":["trace[1540582079] 'process raft request' (duration: 250.288527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:01.64701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.024481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-13T15:19:01.647155Z","caller":"traceutil/trace.go:171","msg":"trace[1512140738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:780; }","duration":"117.216936ms","start":"2026-04-13T15:19:01.529903Z","end":"2026-04-13T15:19:01.64712Z","steps":["trace[1512140738] 'range keys from in-memory index tree' (duration: 116.656442ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:16.023911Z","caller":"traceutil/trace.go:171","msg":"trace[129276224] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"290.813238ms","start":"2026-04-13T15:19:15.733071Z","end":"2026-04-13T15:19:16.023884Z","steps":["trace[129276224] 'process raft request' (duration: 290.635724ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:16.107626Z","caller":"traceutil/trace.go:171","msg":"trace[670082728] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"370.167203ms","start":"2026-04-13T15:19:15.737432Z","end":"2026-04-13T15:19:16.107599Z","steps":["trace[670082728] 'process raft request' (duration: 370.121542ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:16.107726Z","caller":"traceutil/trace.go:171","msg":"trace[1892044843] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"370.449658ms","start":"2026-04-13T15:19:15.737238Z","end":"2026-04-13T15:19:16.107688Z","steps":["trace[1892044843] 'process raft request' (duration: 370.255624ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:16.107717Z","caller":"traceutil/trace.go:171","msg":"trace[1130857900] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"371.345887ms","start":"2026-04-13T15:19:15.736303Z","end":"2026-04-13T15:19:16.107649Z","steps":["trace[1130857900] 'process raft request' (duration: 371.02105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:16.108278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:15.737218Z","time spent":"370.898887ms","remote":"127.0.0.1:46970","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-04-13T15:19:16.108201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:15.737423Z","time spent":"370.563721ms","remote":"127.0.0.1:46970","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-04-13T15:19:16.108392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:15.736288Z","time spent":"371.97641ms","remote":"127.0.0.1:46970","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-04-13T15:19:19.375472Z","caller":"traceutil/trace.go:171","msg":"trace[741819378] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"229.228439ms","start":"2026-04-13T15:19:19.146212Z","end":"2026-04-13T15:19:19.37544Z","steps":["trace[741819378] 'process raft request' (duration: 229.017285ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:40.040336Z","caller":"traceutil/trace.go:171","msg":"trace[1136601805] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"128.145129ms","start":"2026-04-13T15:19:39.912161Z","end":"2026-04-13T15:19:40.040307Z","steps":["trace[1136601805] 'read index received' (duration: 128.013016ms)","trace[1136601805] 'applied index is now lower than readState.Index' (duration: 130.873µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:19:40.040434Z","caller":"traceutil/trace.go:171","msg":"trace[604721238] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"523.319615ms","start":"2026-04-13T15:19:39.5171Z","end":"2026-04-13T15:19:40.040419Z","steps":["trace[604721238] 'process raft request' (duration: 523.07019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:40.040499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.316061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T15:19:40.040529Z","caller":"traceutil/trace.go:171","msg":"trace[1242768892] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1007; }","duration":"128.422144ms","start":"2026-04-13T15:19:39.9121Z","end":"2026-04-13T15:19:40.040522Z","steps":["trace[1242768892] 'agreement among raft nodes before linearized reading' (duration: 128.310722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:40.040538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:39.517067Z","time spent":"523.406757ms","remote":"127.0.0.1:46970","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-04-13T15:19:40.553855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.970175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:19:40.553958Z","caller":"traceutil/trace.go:171","msg":"trace[1888629518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1007; }","duration":"238.160327ms","start":"2026-04-13T15:19:40.315776Z","end":"2026-04-13T15:19:40.553937Z","steps":["trace[1888629518] 'range keys from in-memory index tree' (duration: 237.830962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:40.553944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.077204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T15:19:40.554031Z","caller":"traceutil/trace.go:171","msg":"trace[283079318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1007; }","duration":"322.224817ms","start":"2026-04-13T15:19:40.231785Z","end":"2026-04-13T15:19:40.55401Z","steps":["trace[283079318] 'range keys from in-memory index tree' (duration: 321.803109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:40.5541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:40.231758Z","time spent":"322.328208ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T15:19:40.554126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.550295ms","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-04-13T15:19:40.554163Z","caller":"traceutil/trace.go:171","msg":"trace[562134268] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1007; }","duration":"395.629916ms","start":"2026-04-13T15:19:40.158522Z","end":"2026-04-13T15:19:40.554152Z","steps":["trace[562134268] 'range keys from in-memory index tree' (duration: 395.321261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:40.554192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:40.158497Z","time spent":"395.689167ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T15:19:40.554201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.496543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-13T15:19:40.554249Z","caller":"traceutil/trace.go:171","msg":"trace[201870318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1007; }","duration":"317.573204ms","start":"2026-04-13T15:19:40.236664Z","end":"2026-04-13T15:19:40.554237Z","steps":["trace[201870318] 'range keys from in-memory index tree' (duration: 317.33094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:40.554291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:40.236644Z","time spent":"317.638886ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T15:19:40.554481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.295983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-13T15:19:40.554537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.385355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-13T15:19:40.554654Z","caller":"traceutil/trace.go:171","msg":"trace[1203974246] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:1007; }","duration":"376.554139ms","start":"2026-04-13T15:19:40.17807Z","end":"2026-04-13T15:19:40.554624Z","steps":["trace[1203974246] 'range keys from in-memory index tree' (duration: 376.130851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:40.554709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:40.178042Z","time spent":"376.65667ms","remote":"127.0.0.1:46738","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.223\" "} {"level":"info","ts":"2026-04-13T15:19:40.554589Z","caller":"traceutil/trace.go:171","msg":"trace[45055668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1007; }","duration":"324.478787ms","start":"2026-04-13T15:19:40.230084Z","end":"2026-04-13T15:19:40.554563Z","steps":["trace[45055668] 'range keys from in-memory index tree' (duration: 323.946147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:19:40.554797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:19:40.230054Z","time spent":"324.732701ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T15:19:40.554674Z","caller":"traceutil/trace.go:171","msg":"trace[486841235] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"137.902572ms","start":"2026-04-13T15:19:40.416743Z","end":"2026-04-13T15:19:40.554645Z","steps":["trace[486841235] 'process raft request' (duration: 136.591079ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:19:54.899452Z","caller":"traceutil/trace.go:171","msg":"trace[82149627] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"124.687581ms","start":"2026-04-13T15:19:54.774721Z","end":"2026-04-13T15:19:54.899409Z","steps":["trace[82149627] 'process raft request' (duration: 116.197812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:31.552414Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225476699581474,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T15:20:31.679318Z","caller":"traceutil/trace.go:171","msg":"trace[2101615110] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"816.343031ms","start":"2026-04-13T15:20:30.862936Z","end":"2026-04-13T15:20:31.679279Z","steps":["trace[2101615110] 'process raft request' (duration: 816.101168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:31.67955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:30.8629Z","time spent":"816.523044ms","remote":"127.0.0.1:46970","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-04-13T15:20:32.277025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.984516ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:20:32.277184Z","caller":"traceutil/trace.go:171","msg":"trace[1327261956] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1217; }","duration":"1.225277111s","start":"2026-04-13T15:20:31.051889Z","end":"2026-04-13T15:20:32.277166Z","steps":["trace[1327261956] 'read index received' (duration: 627.14254ms)","trace[1327261956] 'applied index is now lower than readState.Index' (duration: 598.133321ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:20:32.277312Z","caller":"traceutil/trace.go:171","msg":"trace[872774009] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"1.022213402s","start":"2026-04-13T15:20:31.255043Z","end":"2026-04-13T15:20:32.277257Z","steps":["trace[872774009] 'process raft request' (duration: 673.872961ms)","trace[872774009] 'compare' (duration: 347.832135ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:20:32.277431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.956915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:20:32.277489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.224843736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-13T15:20:32.277546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:31.255007Z","time spent":"1.022400474s","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:20:32.277553Z","caller":"traceutil/trace.go:171","msg":"trace[1971542152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1175; }","duration":"961.132668ms","start":"2026-04-13T15:20:31.316393Z","end":"2026-04-13T15:20:32.277526Z","steps":["trace[1971542152] 'agreement among raft nodes before linearized reading' (duration: 960.953796ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:20:32.277598Z","caller":"traceutil/trace.go:171","msg":"trace[2034664431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1175; }","duration":"1.224982587s","start":"2026-04-13T15:20:31.052594Z","end":"2026-04-13T15:20:32.277576Z","steps":["trace[2034664431] 'agreement among raft nodes before linearized reading' (duration: 1.224744945s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:32.277645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:31.316371Z","time spent":"961.258039ms","remote":"127.0.0.1:46702","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-04-13T15:20:32.277661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:31.052585Z","time spent":"1.225066418s","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T15:20:32.277578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203190449s","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-04-13T15:20:32.277786Z","caller":"traceutil/trace.go:171","msg":"trace[1027892728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1175; }","duration":"1.203456843s","start":"2026-04-13T15:20:31.074318Z","end":"2026-04-13T15:20:32.277775Z","steps":["trace[1027892728] 'agreement among raft nodes before linearized reading' (duration: 1.203025078s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:32.277832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:31.07429Z","time spent":"1.203526123s","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T15:20:32.277604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.225724805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-13T15:20:32.27795Z","caller":"traceutil/trace.go:171","msg":"trace[539676681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1175; }","duration":"1.22610058s","start":"2026-04-13T15:20:31.051822Z","end":"2026-04-13T15:20:32.277922Z","steps":["trace[539676681] 'agreement among raft nodes before linearized reading' (duration: 1.225440663s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:32.277508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.224949097s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-04-13T15:20:32.278021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:31.051794Z","time spent":"1.226207911s","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T15:20:32.278032Z","caller":"traceutil/trace.go:171","msg":"trace[1253417492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1175; }","duration":"1.225562504s","start":"2026-04-13T15:20:31.05246Z","end":"2026-04-13T15:20:32.278023Z","steps":["trace[1253417492] 'agreement among raft nodes before linearized reading' (duration: 1.224877497s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:32.278094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:20:31.052434Z","time spent":"1.225650295s","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T15:20:34.799009Z","caller":"traceutil/trace.go:171","msg":"trace[737512730] linearizableReadLoop","detail":"{readStateIndex:1231; appliedIndex:1230; }","duration":"193.420869ms","start":"2026-04-13T15:20:34.605565Z","end":"2026-04-13T15:20:34.798986Z","steps":["trace[737512730] 'read index received' (duration: 193.164986ms)","trace[737512730] 'applied index is now lower than readState.Index' (duration: 255.093µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:20:34.799113Z","caller":"traceutil/trace.go:171","msg":"trace[833175207] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"219.368514ms","start":"2026-04-13T15:20:34.579687Z","end":"2026-04-13T15:20:34.799055Z","steps":["trace[833175207] 'process raft request' (duration: 219.124761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:34.799181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.595861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:20:34.799211Z","caller":"traceutil/trace.go:171","msg":"trace[1332412412] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1187; }","duration":"193.682372ms","start":"2026-04-13T15:20:34.605518Z","end":"2026-04-13T15:20:34.799201Z","steps":["trace[1332412412] 'agreement among raft nodes before linearized reading' (duration: 193.603661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:20:34.799391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.483071ms","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-04-13T15:20:34.799459Z","caller":"traceutil/trace.go:171","msg":"trace[1811182416] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1187; }","duration":"136.630174ms","start":"2026-04-13T15:20:34.662813Z","end":"2026-04-13T15:20:34.799443Z","steps":["trace[1811182416] 'agreement among raft nodes before linearized reading' (duration: 136.472482ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:00.579553Z","caller":"traceutil/trace.go:171","msg":"trace[1814331431] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1315; }","duration":"344.015481ms","start":"2026-04-13T15:21:00.235515Z","end":"2026-04-13T15:21:00.57953Z","steps":["trace[1814331431] 'read index received' (duration: 343.840879ms)","trace[1814331431] 'applied index is now lower than readState.Index' (duration: 173.462µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:21:00.579609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:21:00.182432Z","time spent":"397.170836ms","remote":"127.0.0.1:46738","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-13T15:21:00.579777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.275743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T15:21:00.579791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.289475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T15:21:00.579822Z","caller":"traceutil/trace.go:171","msg":"trace[109067304] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1266; }","duration":"292.386685ms","start":"2026-04-13T15:21:00.287425Z","end":"2026-04-13T15:21:00.579811Z","steps":["trace[109067304] 'agreement among raft nodes before linearized reading' (duration: 292.294064ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:00.579838Z","caller":"traceutil/trace.go:171","msg":"trace[1610171627] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1266; }","duration":"344.386785ms","start":"2026-04-13T15:21:00.235442Z","end":"2026-04-13T15:21:00.579829Z","steps":["trace[1610171627] 'agreement among raft nodes before linearized reading' (duration: 344.216043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:21:00.579876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:21:00.235415Z","time spent":"344.450456ms","remote":"127.0.0.1:46762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":113,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-04-13T15:21:00.58007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.568986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:21:00.580101Z","caller":"traceutil/trace.go:171","msg":"trace[506630381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"262.628346ms","start":"2026-04-13T15:21:00.317465Z","end":"2026-04-13T15:21:00.580093Z","steps":["trace[506630381] 'agreement among raft nodes before linearized reading' (duration: 262.583556ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:00.729637Z","caller":"traceutil/trace.go:171","msg":"trace[147231296] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"148.323116ms","start":"2026-04-13T15:21:00.58129Z","end":"2026-04-13T15:21:00.729613Z","steps":["trace[147231296] 'process raft request' (duration: 135.311578ms)","trace[147231296] 'compare' (duration: 12.886397ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:21:00.735869Z","caller":"traceutil/trace.go:171","msg":"trace[2126620119] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"151.144679ms","start":"2026-04-13T15:21:00.584691Z","end":"2026-04-13T15:21:00.735835Z","steps":["trace[2126620119] 'process raft request' (duration: 151.039478ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:00.735932Z","caller":"traceutil/trace.go:171","msg":"trace[547268636] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"151.437032ms","start":"2026-04-13T15:21:00.584465Z","end":"2026-04-13T15:21:00.735902Z","steps":["trace[547268636] 'process raft request' (duration: 151.072387ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:00.736066Z","caller":"traceutil/trace.go:171","msg":"trace[398957642] linearizableReadLoop","detail":"{readStateIndex:1319; appliedIndex:1316; }","duration":"150.734683ms","start":"2026-04-13T15:21:00.585321Z","end":"2026-04-13T15:21:00.736056Z","steps":["trace[398957642] 'read index received' (duration: 131.295702ms)","trace[398957642] 'applied index is now lower than readState.Index' (duration: 19.438361ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:21:00.73609Z","caller":"traceutil/trace.go:171","msg":"trace[600121126] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"150.280579ms","start":"2026-04-13T15:21:00.585793Z","end":"2026-04-13T15:21:00.736073Z","steps":["trace[600121126] 'process raft request' (duration: 149.992755ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:00.736106Z","caller":"traceutil/trace.go:171","msg":"trace[672800254] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"149.047535ms","start":"2026-04-13T15:21:00.587042Z","end":"2026-04-13T15:21:00.73609Z","steps":["trace[672800254] 'process raft request' (duration: 148.947334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:21:00.736241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.910406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T15:21:00.736273Z","caller":"traceutil/trace.go:171","msg":"trace[939190681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1271; }","duration":"151.004987ms","start":"2026-04-13T15:21:00.585261Z","end":"2026-04-13T15:21:00.736266Z","steps":["trace[939190681] 'agreement among raft nodes before linearized reading' (duration: 150.867825ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:21:02.19988Z","caller":"traceutil/trace.go:171","msg":"trace[943043560] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"393.24204ms","start":"2026-04-13T15:21:01.806613Z","end":"2026-04-13T15:21:02.199855Z","steps":["trace[943043560] 'process raft request' (duration: 393.090808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:21:02.200022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:21:01.806586Z","time spent":"393.367812ms","remote":"127.0.0.1:46970","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-04-13T15:21:02.455442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.74486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:21:02.455528Z","caller":"traceutil/trace.go:171","msg":"trace[2038779919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1273; }","duration":"139.878781ms","start":"2026-04-13T15:21:02.315629Z","end":"2026-04-13T15:21:02.455508Z","steps":["trace[2038779919] 'range keys from in-memory index tree' (duration: 139.661068ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:34.536327Z","caller":"traceutil/trace.go:171","msg":"trace[941670436] transaction","detail":"{read_only:false; response_revision:2393; number_of_response:1; }","duration":"118.680347ms","start":"2026-04-13T15:25:34.417621Z","end":"2026-04-13T15:25:34.536301Z","steps":["trace[941670436] 'process raft request' (duration: 118.330078ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:34.554316Z","caller":"traceutil/trace.go:171","msg":"trace[667589338] transaction","detail":"{read_only:false; response_revision:2394; number_of_response:1; }","duration":"135.779853ms","start":"2026-04-13T15:25:34.418514Z","end":"2026-04-13T15:25:34.554294Z","steps":["trace[667589338] 'process raft request' (duration: 135.563678ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:34.554598Z","caller":"traceutil/trace.go:171","msg":"trace[201244321] transaction","detail":"{read_only:false; response_revision:2396; number_of_response:1; }","duration":"109.426776ms","start":"2026-04-13T15:25:34.445161Z","end":"2026-04-13T15:25:34.554588Z","steps":["trace[201244321] 'process raft request' (duration: 109.383665ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:34.554635Z","caller":"traceutil/trace.go:171","msg":"trace[451447681] transaction","detail":"{read_only:false; response_revision:2395; number_of_response:1; }","duration":"124.065604ms","start":"2026-04-13T15:25:34.430559Z","end":"2026-04-13T15:25:34.554625Z","steps":["trace[451447681] 'process raft request' (duration: 123.741186ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:38.72873Z","caller":"traceutil/trace.go:171","msg":"trace[861053610] linearizableReadLoop","detail":"{readStateIndex:2678; appliedIndex:2677; }","duration":"412.391821ms","start":"2026-04-13T15:25:38.316313Z","end":"2026-04-13T15:25:38.728705Z","steps":["trace[861053610] 'read index received' (duration: 412.225907ms)","trace[861053610] 'applied index is now lower than readState.Index' (duration: 164.964µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:25:38.728894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.562515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:38.728865Z","caller":"traceutil/trace.go:171","msg":"trace[788697194] transaction","detail":"{read_only:false; response_revision:2572; number_of_response:1; }","duration":"431.27128ms","start":"2026-04-13T15:25:38.297562Z","end":"2026-04-13T15:25:38.728833Z","steps":["trace[788697194] 'process raft request' (duration: 430.978183ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:38.728936Z","caller":"traceutil/trace.go:171","msg":"trace[664440349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2572; }","duration":"412.645277ms","start":"2026-04-13T15:25:38.316279Z","end":"2026-04-13T15:25:38.728925Z","steps":["trace[664440349] 'agreement among raft nodes before linearized reading' (duration: 412.567475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:38.728979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:38.316263Z","time spent":"412.708028ms","remote":"127.0.0.1:46702","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-04-13T15:25:38.729029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:38.297547Z","time spent":"431.403703ms","remote":"127.0.0.1:46970","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-04-13T15:25:38.729046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.008431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-13T15:25:38.729097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.730171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-13T15:25:38.729129Z","caller":"traceutil/trace.go:171","msg":"trace[1225476368] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2572; }","duration":"328.157344ms","start":"2026-04-13T15:25:38.400953Z","end":"2026-04-13T15:25:38.72911Z","steps":["trace[1225476368] 'agreement among raft nodes before linearized reading' (duration: 327.925609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:38.729126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.540067ms","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-04-13T15:25:38.729154Z","caller":"traceutil/trace.go:171","msg":"trace[820484564] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2572; }","duration":"161.844384ms","start":"2026-04-13T15:25:38.567296Z","end":"2026-04-13T15:25:38.729141Z","steps":["trace[820484564] 'agreement among raft nodes before linearized reading' (duration: 161.639299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:38.729047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.485061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T15:25:38.729187Z","caller":"traceutil/trace.go:171","msg":"trace[758833249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2572; }","duration":"308.64054ms","start":"2026-04-13T15:25:38.420533Z","end":"2026-04-13T15:25:38.729173Z","steps":["trace[758833249] 'agreement among raft nodes before linearized reading' (duration: 308.469416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:38.729185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:38.400922Z","time spent":"328.251127ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T15:25:38.729223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:38.420514Z","time spent":"308.699341ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T15:25:38.729225Z","caller":"traceutil/trace.go:171","msg":"trace[530425605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2572; }","duration":"304.706657ms","start":"2026-04-13T15:25:38.424498Z","end":"2026-04-13T15:25:38.729205Z","steps":["trace[530425605] 'agreement among raft nodes before linearized reading' (duration: 304.41221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:38.72928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:38.424486Z","time spent":"304.780378ms","remote":"127.0.0.1:46970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T15:25:40.431366Z","caller":"traceutil/trace.go:171","msg":"trace[647112957] linearizableReadLoop","detail":"{readStateIndex:2691; appliedIndex:2690; }","duration":"114.126697ms","start":"2026-04-13T15:25:40.317212Z","end":"2026-04-13T15:25:40.431339Z","steps":["trace[647112957] 'read index received' (duration: 113.985384ms)","trace[647112957] 'applied index is now lower than readState.Index' (duration: 139.663µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:25:40.43155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.328223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:40.431583Z","caller":"traceutil/trace.go:171","msg":"trace[1570542964] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2584; }","duration":"114.424735ms","start":"2026-04-13T15:25:40.317147Z","end":"2026-04-13T15:25:40.431572Z","steps":["trace[1570542964] 'agreement among raft nodes before linearized reading' (duration: 114.346413ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:40.80777Z","caller":"traceutil/trace.go:171","msg":"trace[1352527595] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"374.834996ms","start":"2026-04-13T15:25:40.432898Z","end":"2026-04-13T15:25:40.807733Z","steps":["trace[1352527595] 'process raft request' (duration: 284.218018ms)","trace[1352527595] 'compare' (duration: 90.425283ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:25:40.807938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:40.432869Z","time spent":"374.99119ms","remote":"127.0.0.1:46738","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-04-13T15:25:40.807756Z","caller":"traceutil/trace.go:171","msg":"trace[1499342229] linearizableReadLoop","detail":"{readStateIndex:2692; appliedIndex:2691; }","duration":"318.213897ms","start":"2026-04-13T15:25:40.489507Z","end":"2026-04-13T15:25:40.807721Z","steps":["trace[1499342229] 'read index received' (duration: 227.59134ms)","trace[1499342229] 'applied index is now lower than readState.Index' (duration: 90.621157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:25:40.808067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.541416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-4vdzs\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-13T15:25:40.808147Z","caller":"traceutil/trace.go:171","msg":"trace[1768056661] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-4vdzs; range_end:; response_count:1; response_revision:2585; }","duration":"318.688669ms","start":"2026-04-13T15:25:40.489437Z","end":"2026-04-13T15:25:40.808126Z","steps":["trace[1768056661] 'agreement among raft nodes before linearized reading' (duration: 318.401062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:40.808278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:40.489414Z","time spent":"318.849132ms","remote":"127.0.0.1:46866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":4219,"request content":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-4vdzs\" "} {"level":"warn","ts":"2026-04-13T15:25:40.808312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.118987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T15:25:40.808472Z","caller":"traceutil/trace.go:171","msg":"trace[933142033] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2585; }","duration":"266.287291ms","start":"2026-04-13T15:25:40.542125Z","end":"2026-04-13T15:25:40.808412Z","steps":["trace[933142033] 'agreement among raft nodes before linearized reading' (duration: 266.080886ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:41.160991Z","caller":"traceutil/trace.go:171","msg":"trace[1524265137] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"347.970647ms","start":"2026-04-13T15:25:40.813001Z","end":"2026-04-13T15:25:41.160971Z","steps":["trace[1524265137] 'process raft request' (duration: 347.896255ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:41.161016Z","caller":"traceutil/trace.go:171","msg":"trace[154242246] transaction","detail":"{read_only:false; response_revision:2587; number_of_response:1; }","duration":"348.092669ms","start":"2026-04-13T15:25:40.812885Z","end":"2026-04-13T15:25:41.160977Z","steps":["trace[154242246] 'process raft request' (duration: 347.843963ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:41.16107Z","caller":"traceutil/trace.go:171","msg":"trace[1951216126] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"348.095059ms","start":"2026-04-13T15:25:40.812933Z","end":"2026-04-13T15:25:41.161028Z","steps":["trace[1951216126] 'process raft request' (duration: 347.915285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:41.161113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:40.81299Z","time spent":"348.063779ms","remote":"127.0.0.1:46970","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-04-13T15:25:41.161223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:40.812851Z","time spent":"348.267413ms","remote":"127.0.0.1:46970","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-04-13T15:25:41.161251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:40.812909Z","time spent":"348.245853ms","remote":"127.0.0.1:46970","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-04-13T15:25:41.161381Z","caller":"traceutil/trace.go:171","msg":"trace[647717132] linearizableReadLoop","detail":"{readStateIndex:2697; appliedIndex:2692; }","duration":"347.387873ms","start":"2026-04-13T15:25:40.813969Z","end":"2026-04-13T15:25:41.161357Z","steps":["trace[647717132] 'read index received' (duration: 8.421461ms)","trace[647717132] 'applied index is now lower than readState.Index' (duration: 338.965212ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:25:41.161419Z","caller":"traceutil/trace.go:171","msg":"trace[506870925] transaction","detail":"{read_only:false; response_revision:2590; number_of_response:1; }","duration":"348.220722ms","start":"2026-04-13T15:25:40.813164Z","end":"2026-04-13T15:25:41.161385Z","steps":["trace[506870925] 'process raft request' (duration: 347.771742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:41.161503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.538976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-04-13T15:25:41.161511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:40.813139Z","time spent":"348.327584ms","remote":"127.0.0.1:46970","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-04-13T15:25:41.161516Z","caller":"traceutil/trace.go:171","msg":"trace[1614210884] transaction","detail":"{read_only:false; response_revision:2591; number_of_response:1; }","duration":"344.870842ms","start":"2026-04-13T15:25:40.816625Z","end":"2026-04-13T15:25:41.161496Z","steps":["trace[1614210884] 'process raft request' (duration: 344.630576ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:41.161541Z","caller":"traceutil/trace.go:171","msg":"trace[1533902117] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2591; }","duration":"347.608698ms","start":"2026-04-13T15:25:40.813925Z","end":"2026-04-13T15:25:41.161534Z","steps":["trace[1533902117] 'agreement among raft nodes before linearized reading' (duration: 347.523916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:41.161573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:40.813913Z","time spent":"347.652349ms","remote":"127.0.0.1:46980","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-04-13T15:25:41.16164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:40.816616Z","time spent":"344.946584ms","remote":"127.0.0.1:46866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4335,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T15:25:41.16221Z","caller":"traceutil/trace.go:171","msg":"trace[1752312194] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"257.158394ms","start":"2026-04-13T15:25:40.90503Z","end":"2026-04-13T15:25:41.162189Z","steps":["trace[1752312194] 'process raft request' (duration: 257.00516ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:42.820798Z","caller":"traceutil/trace.go:171","msg":"trace[441836427] transaction","detail":"{read_only:false; response_revision:2598; number_of_response:1; }","duration":"164.407755ms","start":"2026-04-13T15:25:42.656361Z","end":"2026-04-13T15:25:42.820769Z","steps":["trace[441836427] 'process raft request' (duration: 164.252162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T15:25:50.696033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:50.195475Z","time spent":"500.553812ms","remote":"127.0.0.1:46738","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-13T15:25:51.1016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.407823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T15:25:51.101853Z","caller":"traceutil/trace.go:171","msg":"trace[1663440585] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"404.831136ms","start":"2026-04-13T15:25:50.696999Z","end":"2026-04-13T15:25:51.101831Z","steps":["trace[1663440585] 'process raft request' (duration: 292.057295ms)","trace[1663440585] 'compare' (duration: 112.159477ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T15:25:51.101963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T15:25:50.696977Z","time spent":"404.937428ms","remote":"127.0.0.1:46738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T15:25:51.102061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.398793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-13T15:25:51.102125Z","caller":"traceutil/trace.go:171","msg":"trace[707468108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2772; }","duration":"238.508796ms","start":"2026-04-13T15:25:50.863603Z","end":"2026-04-13T15:25:51.102111Z","steps":["trace[707468108] 'agreement among raft nodes before linearized reading' (duration: 238.309342ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:25:51.10175Z","caller":"traceutil/trace.go:171","msg":"trace[813490584] linearizableReadLoop","detail":"{readStateIndex:2883; appliedIndex:2882; }","duration":"238.075377ms","start":"2026-04-13T15:25:50.863654Z","end":"2026-04-13T15:25:51.101729Z","steps":["trace[813490584] 'read index received' (duration: 125.415538ms)","trace[813490584] 'applied index is now lower than readState.Index' (duration: 112.657179ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:25:51.174384Z","caller":"traceutil/trace.go:171","msg":"trace[1605671678] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"275.670524ms","start":"2026-04-13T15:25:50.898674Z","end":"2026-04-13T15:25:51.174344Z","steps":["trace[1605671678] 'process raft request' (duration: 275.338257ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:11.39669Z","caller":"traceutil/trace.go:171","msg":"trace[1588222895] transaction","detail":"{read_only:false; response_revision:2858; number_of_response:1; }","duration":"110.833668ms","start":"2026-04-13T15:26:11.28583Z","end":"2026-04-13T15:26:11.396663Z","steps":["trace[1588222895] 'process raft request' (duration: 110.45956ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:11.608484Z","caller":"traceutil/trace.go:171","msg":"trace[33476569] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"207.617867ms","start":"2026-04-13T15:26:11.400823Z","end":"2026-04-13T15:26:11.608441Z","steps":["trace[33476569] 'process raft request' (duration: 192.584936ms)","trace[33476569] 'compare' (duration: 14.714934ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T15:26:11.62646Z","caller":"traceutil/trace.go:171","msg":"trace[614555405] transaction","detail":"{read_only:false; response_revision:2861; number_of_response:1; }","duration":"224.767945ms","start":"2026-04-13T15:26:11.401666Z","end":"2026-04-13T15:26:11.626434Z","steps":["trace[614555405] 'process raft request' (duration: 224.668543ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:11.626529Z","caller":"traceutil/trace.go:171","msg":"trace[1310077112] transaction","detail":"{read_only:false; response_revision:2860; number_of_response:1; }","duration":"224.876787ms","start":"2026-04-13T15:26:11.401617Z","end":"2026-04-13T15:26:11.626494Z","steps":["trace[1310077112] 'process raft request' (duration: 224.56863ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:11.626844Z","caller":"traceutil/trace.go:171","msg":"trace[16801234] transaction","detail":"{read_only:false; response_revision:2862; number_of_response:1; }","duration":"225.103301ms","start":"2026-04-13T15:26:11.401679Z","end":"2026-04-13T15:26:11.626782Z","steps":["trace[16801234] 'process raft request' (duration: 224.720883ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:11.626849Z","caller":"traceutil/trace.go:171","msg":"trace[250648229] transaction","detail":"{read_only:false; response_revision:2863; number_of_response:1; }","duration":"182.983755ms","start":"2026-04-13T15:26:11.443843Z","end":"2026-04-13T15:26:11.626827Z","steps":["trace[250648229] 'process raft request' (duration: 182.780651ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:13.788108Z","caller":"traceutil/trace.go:171","msg":"trace[374513621] transaction","detail":"{read_only:false; response_revision:2867; number_of_response:1; }","duration":"155.113712ms","start":"2026-04-13T15:26:13.632964Z","end":"2026-04-13T15:26:13.788078Z","steps":["trace[374513621] 'process raft request' (duration: 154.914747ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:13.824232Z","caller":"traceutil/trace.go:171","msg":"trace[98647088] transaction","detail":"{read_only:false; response_revision:2870; number_of_response:1; }","duration":"188.090837ms","start":"2026-04-13T15:26:13.636116Z","end":"2026-04-13T15:26:13.824207Z","steps":["trace[98647088] 'process raft request' (duration: 188.030846ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:13.824406Z","caller":"traceutil/trace.go:171","msg":"trace[487413441] transaction","detail":"{read_only:false; response_revision:2868; number_of_response:1; }","duration":"189.902778ms","start":"2026-04-13T15:26:13.634493Z","end":"2026-04-13T15:26:13.824396Z","steps":["trace[487413441] 'process raft request' (duration: 189.503889ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T15:26:13.824586Z","caller":"traceutil/trace.go:171","msg":"trace[597173008] transaction","detail":"{read_only:false; response_revision:2869; number_of_response:1; }","duration":"188.439226ms","start":"2026-04-13T15:26:13.636088Z","end":"2026-04-13T15:26:13.824528Z","steps":["trace[597173008] 'process raft request' (duration: 188.020586ms)"],"step_count":1}