{"level":"warn","ts":"2026-04-16T03:39:29.504409Z","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-16T03:39:29.504513Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.141: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.141:2380","--initial-cluster=instance=https://199.204.45.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.141: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-16T03:39:29.504588Z","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-16T03:39:29.504602Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-16T03:39:29.50462Z","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-16T03:39:29.505298Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"]} {"level":"info","ts":"2026-04-16T03:39:29.50539Z","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.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.141: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-16T03:39:29.509837Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.187314ms"} {"level":"info","ts":"2026-04-16T03:39:29.52094Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9ef3b4f68930dc2","cluster-id":"b19a5957e6e65747"} {"level":"info","ts":"2026-04-16T03:39:29.521098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T03:39:29.521143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 0"} {"level":"info","ts":"2026-04-16T03:39:29.521166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9ef3b4f68930dc2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T03:39:29.521187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became follower at term 1"} {"level":"info","ts":"2026-04-16T03:39:29.521258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"warn","ts":"2026-04-16T03:39:29.531762Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T03:39:29.534791Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T03:39:29.536879Z","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-16T03:39:29.540549Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9ef3b4f68930dc2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T03:39:29.540805Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9ef3b4f68930dc2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T03:39:29.540839Z","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-16T03:39:29.541052Z","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-16T03:39:29.541094Z","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-16T03:39:29.541623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 switched to configuration voters=(715856078018121154)"} {"level":"info","ts":"2026-04-16T03:39:29.541754Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","added-peer-id":"9ef3b4f68930dc2","added-peer-peer-urls":["https://199.204.45.141:2380"]} {"level":"info","ts":"2026-04-16T03:39:29.543779Z","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-16T03:39:29.543907Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-16T03:39:29.54401Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.141:2380"} {"level":"info","ts":"2026-04-16T03:39:29.544165Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9ef3b4f68930dc2","initial-advertise-peer-urls":["https://199.204.45.141:2380"],"listen-peer-urls":["https://199.204.45.141:2380"],"advertise-client-urls":["https://199.204.45.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T03:39:29.544201Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T03:39:29.92173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T03:39:29.921794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T03:39:29.921879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgPreVoteResp from 9ef3b4f68930dc2 at term 1"} {"level":"info","ts":"2026-04-16T03:39:29.9219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became candidate at term 2"} {"level":"info","ts":"2026-04-16T03:39:29.921907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 received MsgVoteResp from 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-16T03:39:29.92192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9ef3b4f68930dc2 became leader at term 2"} {"level":"info","ts":"2026-04-16T03:39:29.921934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9ef3b4f68930dc2 elected leader 9ef3b4f68930dc2 at term 2"} {"level":"info","ts":"2026-04-16T03:39:29.922921Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T03:39:29.923774Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9ef3b4f68930dc2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.141:2379]}","request-path":"/0/members/9ef3b4f68930dc2/attributes","cluster-id":"b19a5957e6e65747","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T03:39:29.924043Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T03:39:29.924382Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b19a5957e6e65747","local-member-id":"9ef3b4f68930dc2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T03:39:29.924507Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T03:39:29.92455Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T03:39:29.927479Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T03:39:29.934194Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T03:39:29.935418Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.141:2379"} {"level":"info","ts":"2026-04-16T03:39:29.938941Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T03:39:29.938964Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T03:39:56.468446Z","caller":"traceutil/trace.go:171","msg":"trace[1669966913] transaction","detail":"{read_only:false; number_of_response:1; response_revision:551; }","duration":"224.044534ms","start":"2026-04-16T03:39:56.244357Z","end":"2026-04-16T03:39:56.468402Z","steps":["trace[1669966913] 'process raft request' (duration: 217.515671ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:39:56.468561Z","caller":"traceutil/trace.go:171","msg":"trace[1702882695] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"206.10323ms","start":"2026-04-16T03:39:56.26242Z","end":"2026-04-16T03:39:56.468523Z","steps":["trace[1702882695] 'process raft request' (duration: 205.946305ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:40:02.049639Z","caller":"traceutil/trace.go:171","msg":"trace[1317167956] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"111.803468ms","start":"2026-04-16T03:40:01.937811Z","end":"2026-04-16T03:40:02.049614Z","steps":["trace[1317167956] 'process raft request' (duration: 77.293819ms)","trace[1317167956] 'compare' (duration: 34.16551ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:40:02.643959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.422709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:40:02.644265Z","caller":"traceutil/trace.go:171","msg":"trace[987111116] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"157.525577ms","start":"2026-04-16T03:40:02.486713Z","end":"2026-04-16T03:40:02.644239Z","steps":["trace[987111116] 'process raft request' (duration: 157.419684ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:40:02.644511Z","caller":"traceutil/trace.go:171","msg":"trace[1269685352] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"330.584277ms","start":"2026-04-16T03:40:02.31383Z","end":"2026-04-16T03:40:02.644414Z","steps":["trace[1269685352] 'process raft request' (duration: 228.964293ms)","trace[1269685352] 'compare' (duration: 100.230943ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:40:02.644776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:40:02.313805Z","time spent":"330.821414ms","remote":"127.0.0.1:37452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:40:19.095537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.237187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bp9cm\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-16T03:40:19.095668Z","caller":"traceutil/trace.go:171","msg":"trace[1734789620] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bp9cm; range_end:; response_count:1; response_revision:775; }","duration":"143.442723ms","start":"2026-04-16T03:40:18.952195Z","end":"2026-04-16T03:40:19.095638Z","steps":["trace[1734789620] 'range keys from in-memory index tree' (duration: 143.00647ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:40:19.244653Z","caller":"traceutil/trace.go:171","msg":"trace[474994020] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"131.053624ms","start":"2026-04-16T03:40:19.113575Z","end":"2026-04-16T03:40:19.244628Z","steps":["trace[474994020] 'read index received' (duration: 130.90437ms)","trace[474994020] 'applied index is now lower than readState.Index' (duration: 148.174µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:40:19.244715Z","caller":"traceutil/trace.go:171","msg":"trace[1907375675] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"142.135887ms","start":"2026-04-16T03:40:19.102554Z","end":"2026-04-16T03:40:19.24469Z","steps":["trace[1907375675] 'process raft request' (duration: 141.920451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:40:19.245025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.421446ms","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-16T03:40:19.245095Z","caller":"traceutil/trace.go:171","msg":"trace[93806120] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:776; }","duration":"131.52836ms","start":"2026-04-16T03:40:19.11355Z","end":"2026-04-16T03:40:19.245079Z","steps":["trace[93806120] 'agreement among raft nodes before linearized reading' (duration: 131.184239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:40:53.530226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.212206ms","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-16T03:40:53.530402Z","caller":"traceutil/trace.go:171","msg":"trace[5420777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:986; }","duration":"112.442953ms","start":"2026-04-16T03:40:53.417925Z","end":"2026-04-16T03:40:53.530368Z","steps":["trace[5420777] 'range keys from in-memory index tree' (duration: 112.037261ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:41:50.417495Z","caller":"traceutil/trace.go:171","msg":"trace[609850907] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"148.996597ms","start":"2026-04-16T03:41:50.268463Z","end":"2026-04-16T03:41:50.41746Z","steps":["trace[609850907] 'process raft request' (duration: 148.78538ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:42:18.188776Z","caller":"traceutil/trace.go:171","msg":"trace[387899616] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"190.756727ms","start":"2026-04-16T03:42:17.997988Z","end":"2026-04-16T03:42:18.188745Z","steps":["trace[387899616] 'process raft request' (duration: 190.620812ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:42:18.877296Z","caller":"traceutil/trace.go:171","msg":"trace[1521381155] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"177.382268ms","start":"2026-04-16T03:42:18.699867Z","end":"2026-04-16T03:42:18.877249Z","steps":["trace[1521381155] 'process raft request' (duration: 90.237541ms)","trace[1521381155] 'compare' (duration: 86.755714ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:42:18.939284Z","caller":"traceutil/trace.go:171","msg":"trace[1902226691] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1313; }","duration":"165.041494ms","start":"2026-04-16T03:42:18.774201Z","end":"2026-04-16T03:42:18.939242Z","steps":["trace[1902226691] 'read index received' (duration: 16.048667ms)","trace[1902226691] 'applied index is now lower than readState.Index' (duration: 148.988637ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:42:18.939554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.318754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-16T03:42:18.939652Z","caller":"traceutil/trace.go:171","msg":"trace[1048926071] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1268; }","duration":"165.49948ms","start":"2026-04-16T03:42:18.774133Z","end":"2026-04-16T03:42:18.939633Z","steps":["trace[1048926071] 'agreement among raft nodes before linearized reading' (duration: 165.248651ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:46:50.0073Z","caller":"traceutil/trace.go:171","msg":"trace[1829143486] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"113.807273ms","start":"2026-04-16T03:46:49.893469Z","end":"2026-04-16T03:46:50.007277Z","steps":["trace[1829143486] 'process raft request' (duration: 113.667509ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:46:55.090878Z","caller":"traceutil/trace.go:171","msg":"trace[313821744] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"261.452492ms","start":"2026-04-16T03:46:54.829407Z","end":"2026-04-16T03:46:55.090859Z","steps":["trace[313821744] 'process raft request' (duration: 261.334698ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:00.159333Z","caller":"traceutil/trace.go:171","msg":"trace[1087740034] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"122.618637ms","start":"2026-04-16T03:47:00.036647Z","end":"2026-04-16T03:47:00.159266Z","steps":["trace[1087740034] 'process raft request' (duration: 122.36221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:01.760214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.613503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:47:01.760331Z","caller":"traceutil/trace.go:171","msg":"trace[1683481936] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"245.057098ms","start":"2026-04-16T03:47:01.515254Z","end":"2026-04-16T03:47:01.760311Z","steps":["trace[1683481936] 'process raft request' (duration: 142.082065ms)","trace[1683481936] 'compare' (duration: 102.344585ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:04.5013Z","caller":"traceutil/trace.go:171","msg":"trace[2131107763] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"135.802052ms","start":"2026-04-16T03:47:04.36547Z","end":"2026-04-16T03:47:04.501272Z","steps":["trace[2131107763] 'process raft request' (duration: 124.952892ms)","trace[2131107763] 'compare' (duration: 10.608864ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:06.588709Z","caller":"traceutil/trace.go:171","msg":"trace[1369249311] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"128.229659ms","start":"2026-04-16T03:47:06.460455Z","end":"2026-04-16T03:47:06.588685Z","steps":["trace[1369249311] 'process raft request' (duration: 128.079665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:06.799701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.338492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:47:06.799801Z","caller":"traceutil/trace.go:171","msg":"trace[1011950224] linearizableReadLoop","detail":"{readStateIndex:2351; appliedIndex:2349; }","duration":"295.241324ms","start":"2026-04-16T03:47:06.504543Z","end":"2026-04-16T03:47:06.799784Z","steps":["trace[1011950224] 'read index received' (duration: 83.965325ms)","trace[1011950224] 'applied index is now lower than readState.Index' (duration: 211.274789ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:47:06.799991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.46103ms","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-04-16T03:47:06.799933Z","caller":"traceutil/trace.go:171","msg":"trace[149264430] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"338.48208ms","start":"2026-04-16T03:47:06.461404Z","end":"2026-04-16T03:47:06.799886Z","steps":["trace[149264430] 'process raft request' (duration: 232.860601ms)","trace[149264430] 'compare' (duration: 105.211408ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:06.800027Z","caller":"traceutil/trace.go:171","msg":"trace[1398275825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2245; }","duration":"295.557652ms","start":"2026-04-16T03:47:06.50446Z","end":"2026-04-16T03:47:06.800017Z","steps":["trace[1398275825] 'agreement among raft nodes before linearized reading' (duration: 295.414438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:06.800026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.225999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:47:06.800108Z","caller":"traceutil/trace.go:171","msg":"trace[2117399778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2245; }","duration":"151.328732ms","start":"2026-04-16T03:47:06.648761Z","end":"2026-04-16T03:47:06.800089Z","steps":["trace[2117399778] 'agreement among raft nodes before linearized reading' (duration: 151.202508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:06.800122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.02032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-16T03:47:06.800141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:47:06.461375Z","time spent":"338.679986ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:47:06.800209Z","caller":"traceutil/trace.go:171","msg":"trace[1204310752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2245; }","duration":"159.154473ms","start":"2026-04-16T03:47:06.641029Z","end":"2026-04-16T03:47:06.800183Z","steps":["trace[1204310752] 'agreement among raft nodes before linearized reading' (duration: 158.903527ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:07.039371Z","caller":"traceutil/trace.go:171","msg":"trace[1152416834] linearizableReadLoop","detail":"{readStateIndex:2353; appliedIndex:2352; }","duration":"165.264188ms","start":"2026-04-16T03:47:06.874082Z","end":"2026-04-16T03:47:07.039347Z","steps":["trace[1152416834] 'read index received' (duration: 114.420267ms)","trace[1152416834] 'applied index is now lower than readState.Index' (duration: 50.842691ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:07.039468Z","caller":"traceutil/trace.go:171","msg":"trace[1913591082] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"235.170943ms","start":"2026-04-16T03:47:06.804263Z","end":"2026-04-16T03:47:07.039434Z","steps":["trace[1913591082] 'process raft request' (duration: 184.22744ms)","trace[1913591082] 'compare' (duration: 50.641795ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:47:07.039567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.431833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:47:07.039605Z","caller":"traceutil/trace.go:171","msg":"trace[1230206840] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2247; }","duration":"165.546106ms","start":"2026-04-16T03:47:06.874048Z","end":"2026-04-16T03:47:07.039595Z","steps":["trace[1230206840] 'agreement among raft nodes before linearized reading' (duration: 165.431853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:07.039639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.276799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:47:07.039693Z","caller":"traceutil/trace.go:171","msg":"trace[1219770842] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:2247; }","duration":"102.374112ms","start":"2026-04-16T03:47:06.937304Z","end":"2026-04-16T03:47:07.039678Z","steps":["trace[1219770842] 'agreement among raft nodes before linearized reading' (duration: 102.280069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:20.859871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.574494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T03:47:20.859955Z","caller":"traceutil/trace.go:171","msg":"trace[1370705324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2289; }","duration":"159.710628ms","start":"2026-04-16T03:47:20.700223Z","end":"2026-04-16T03:47:20.859934Z","steps":["trace[1370705324] 'range keys from in-memory index tree' (duration: 159.39056ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:23.134688Z","caller":"traceutil/trace.go:171","msg":"trace[1203458787] transaction","detail":"{read_only:false; response_revision:2297; number_of_response:1; }","duration":"178.529306ms","start":"2026-04-16T03:47:22.956131Z","end":"2026-04-16T03:47:23.13466Z","steps":["trace[1203458787] 'process raft request' (duration: 178.327871ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:23.385772Z","caller":"traceutil/trace.go:171","msg":"trace[604695543] linearizableReadLoop","detail":"{readStateIndex:2408; appliedIndex:2406; }","duration":"215.318399ms","start":"2026-04-16T03:47:23.170426Z","end":"2026-04-16T03:47:23.385744Z","steps":["trace[604695543] 'read index received' (duration: 178.250619ms)","trace[604695543] 'applied index is now lower than readState.Index' (duration: 37.06627ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:23.385925Z","caller":"traceutil/trace.go:171","msg":"trace[730008668] transaction","detail":"{read_only:false; response_revision:2299; number_of_response:1; }","duration":"245.479692ms","start":"2026-04-16T03:47:23.140425Z","end":"2026-04-16T03:47:23.385905Z","steps":["trace[730008668] 'process raft request' (duration: 245.217215ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:23.385979Z","caller":"traceutil/trace.go:171","msg":"trace[2123259763] transaction","detail":"{read_only:false; response_revision:2298; number_of_response:1; }","duration":"247.515047ms","start":"2026-04-16T03:47:23.138441Z","end":"2026-04-16T03:47:23.385956Z","steps":["trace[2123259763] 'process raft request' (duration: 210.220942ms)","trace[2123259763] 'compare' (duration: 36.821483ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:47:23.386181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.465756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-16T03:47:23.386199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.77183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-16T03:47:23.386239Z","caller":"traceutil/trace.go:171","msg":"trace[1020293433] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:2299; }","duration":"105.578069ms","start":"2026-04-16T03:47:23.280648Z","end":"2026-04-16T03:47:23.386226Z","steps":["trace[1020293433] 'agreement among raft nodes before linearized reading' (duration: 105.396694ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:23.386251Z","caller":"traceutil/trace.go:171","msg":"trace[321933046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2299; }","duration":"215.867913ms","start":"2026-04-16T03:47:23.170367Z","end":"2026-04-16T03:47:23.386235Z","steps":["trace[321933046] 'agreement among raft nodes before linearized reading' (duration: 215.731959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:25.781259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.43523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:47:25.781335Z","caller":"traceutil/trace.go:171","msg":"trace[37214634] linearizableReadLoop","detail":"{readStateIndex:2418; appliedIndex:2417; }","duration":"132.135484ms","start":"2026-04-16T03:47:25.649189Z","end":"2026-04-16T03:47:25.781324Z","steps":["trace[37214634] 'read index received' (duration: 35.591µs)","trace[37214634] 'applied index is now lower than readState.Index' (duration: 132.099093ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:25.781391Z","caller":"traceutil/trace.go:171","msg":"trace[1556893501] transaction","detail":"{read_only:false; response_revision:2308; number_of_response:1; }","duration":"239.82943ms","start":"2026-04-16T03:47:25.541554Z","end":"2026-04-16T03:47:25.781383Z","steps":["trace[1556893501] 'process raft request' (duration: 83.209085ms)","trace[1556893501] 'compare' (duration: 156.356908ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:47:25.781608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.409501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:47:25.781688Z","caller":"traceutil/trace.go:171","msg":"trace[943202802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2308; }","duration":"132.510164ms","start":"2026-04-16T03:47:25.649142Z","end":"2026-04-16T03:47:25.781652Z","steps":["trace[943202802] 'agreement among raft nodes before linearized reading' (duration: 132.432192ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:27.300199Z","caller":"traceutil/trace.go:171","msg":"trace[1122245431] transaction","detail":"{read_only:false; response_revision:2311; number_of_response:1; }","duration":"113.09493ms","start":"2026-04-16T03:47:27.187085Z","end":"2026-04-16T03:47:27.30018Z","steps":["trace[1122245431] 'process raft request' (duration: 112.987647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:27.764593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.553151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:47:27.764682Z","caller":"traceutil/trace.go:171","msg":"trace[1563248882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2314; }","duration":"117.688635ms","start":"2026-04-16T03:47:27.646974Z","end":"2026-04-16T03:47:27.764662Z","steps":["trace[1563248882] 'range keys from in-memory index tree' (duration: 117.418108ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:31.517081Z","caller":"traceutil/trace.go:171","msg":"trace[1215368395] transaction","detail":"{read_only:false; response_revision:2323; number_of_response:1; }","duration":"108.144547ms","start":"2026-04-16T03:47:31.408913Z","end":"2026-04-16T03:47:31.517057Z","steps":["trace[1215368395] 'process raft request' (duration: 107.997803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:31.931026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.636673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:47:31.931154Z","caller":"traceutil/trace.go:171","msg":"trace[1387644642] linearizableReadLoop","detail":"{readStateIndex:2435; appliedIndex:2434; }","duration":"363.731262ms","start":"2026-04-16T03:47:31.567404Z","end":"2026-04-16T03:47:31.931135Z","steps":["trace[1387644642] 'read index received' (duration: 192.809061ms)","trace[1387644642] 'applied index is now lower than readState.Index' (duration: 170.920521ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:31.93124Z","caller":"traceutil/trace.go:171","msg":"trace[427533500] transaction","detail":"{read_only:false; response_revision:2324; number_of_response:1; }","duration":"410.237106ms","start":"2026-04-16T03:47:31.520991Z","end":"2026-04-16T03:47:31.931228Z","steps":["trace[427533500] 'process raft request' (duration: 239.303474ms)","trace[427533500] 'compare' (duration: 170.51416ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:47:31.931299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:47:31.520969Z","time spent":"410.300638ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:47:31.93142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.921569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T03:47:31.931507Z","caller":"traceutil/trace.go:171","msg":"trace[1177948859] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2324; }","duration":"175.072072ms","start":"2026-04-16T03:47:31.756417Z","end":"2026-04-16T03:47:31.931489Z","steps":["trace[1177948859] 'agreement among raft nodes before linearized reading' (duration: 174.915258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:31.931489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.567861ms","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-16T03:47:31.931573Z","caller":"traceutil/trace.go:171","msg":"trace[1288245592] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2324; }","duration":"289.662193ms","start":"2026-04-16T03:47:31.64189Z","end":"2026-04-16T03:47:31.931552Z","steps":["trace[1288245592] 'agreement among raft nodes before linearized reading' (duration: 289.434477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:31.931452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.168181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T03:47:31.931627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.211484ms","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-04-16T03:47:31.931702Z","caller":"traceutil/trace.go:171","msg":"trace[356220035] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2324; }","duration":"364.337128ms","start":"2026-04-16T03:47:31.567346Z","end":"2026-04-16T03:47:31.931683Z","steps":["trace[356220035] 'agreement among raft nodes before linearized reading' (duration: 364.082601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:31.931739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:47:31.567323Z","time spent":"364.40962ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T03:47:31.931709Z","caller":"traceutil/trace.go:171","msg":"trace[1676666385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2324; }","duration":"282.438808ms","start":"2026-04-16T03:47:31.649222Z","end":"2026-04-16T03:47:31.931661Z","steps":["trace[1676666385] 'agreement among raft nodes before linearized reading' (duration: 282.197562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:32.212895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.52614ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:47:32.213035Z","caller":"traceutil/trace.go:171","msg":"trace[1770420608] transaction","detail":"{read_only:false; response_revision:2327; number_of_response:1; }","duration":"276.744455ms","start":"2026-04-16T03:47:31.936277Z","end":"2026-04-16T03:47:32.213022Z","steps":["trace[1770420608] 'process raft request' (duration: 276.699934ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:32.213114Z","caller":"traceutil/trace.go:171","msg":"trace[1437520984] transaction","detail":"{read_only:false; response_revision:2326; number_of_response:1; }","duration":"277.215588ms","start":"2026-04-16T03:47:31.935864Z","end":"2026-04-16T03:47:32.21308Z","steps":["trace[1437520984] 'process raft request' (duration: 175.431852ms)","trace[1437520984] 'compare' (duration: 101.415386ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:35.017252Z","caller":"traceutil/trace.go:171","msg":"trace[398286266] transaction","detail":"{read_only:false; response_revision:2336; number_of_response:1; }","duration":"108.746904ms","start":"2026-04-16T03:47:34.90848Z","end":"2026-04-16T03:47:35.017227Z","steps":["trace[398286266] 'process raft request' (duration: 108.61174ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:35.062113Z","caller":"traceutil/trace.go:171","msg":"trace[89130092] transaction","detail":"{read_only:false; response_revision:2337; number_of_response:1; }","duration":"118.850267ms","start":"2026-04-16T03:47:34.943238Z","end":"2026-04-16T03:47:35.062088Z","steps":["trace[89130092] 'process raft request' (duration: 118.698343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:45.862763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.012333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:47:45.862852Z","caller":"traceutil/trace.go:171","msg":"trace[1231626086] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2371; }","duration":"181.130246ms","start":"2026-04-16T03:47:45.681701Z","end":"2026-04-16T03:47:45.862832Z","steps":["trace[1231626086] 'count revisions from in-memory index tree' (duration: 180.94877ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:51.501006Z","caller":"traceutil/trace.go:171","msg":"trace[555791259] transaction","detail":"{read_only:false; response_revision:2389; number_of_response:1; }","duration":"172.185464ms","start":"2026-04-16T03:47:51.328799Z","end":"2026-04-16T03:47:51.500985Z","steps":["trace[555791259] 'process raft request' (duration: 172.057391ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:54.361524Z","caller":"traceutil/trace.go:171","msg":"trace[787667217] transaction","detail":"{read_only:false; response_revision:2399; number_of_response:1; }","duration":"236.260452ms","start":"2026-04-16T03:47:54.125229Z","end":"2026-04-16T03:47:54.361489Z","steps":["trace[787667217] 'process raft request' (duration: 236.089428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:54.577058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.270591ms","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-04-16T03:47:54.577143Z","caller":"traceutil/trace.go:171","msg":"trace[465101719] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2400; }","duration":"101.395055ms","start":"2026-04-16T03:47:54.47573Z","end":"2026-04-16T03:47:54.577125Z","steps":["trace[465101719] 'range keys from in-memory index tree' (duration: 101.043095ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:56.718056Z","caller":"traceutil/trace.go:171","msg":"trace[160621701] linearizableReadLoop","detail":"{readStateIndex:2524; appliedIndex:2523; }","duration":"109.585006ms","start":"2026-04-16T03:47:56.608449Z","end":"2026-04-16T03:47:56.718034Z","steps":["trace[160621701] 'read index received' (duration: 109.38489ms)","trace[160621701] 'applied index is now lower than readState.Index' (duration: 199.256µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:56.718103Z","caller":"traceutil/trace.go:171","msg":"trace[2076461502] transaction","detail":"{read_only:false; response_revision:2408; number_of_response:1; }","duration":"120.47075ms","start":"2026-04-16T03:47:56.59762Z","end":"2026-04-16T03:47:56.718091Z","steps":["trace[2076461502] 'process raft request' (duration: 120.231904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:47:56.718345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.860573ms","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-04-16T03:47:56.718452Z","caller":"traceutil/trace.go:171","msg":"trace[1056265949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2408; }","duration":"109.988516ms","start":"2026-04-16T03:47:56.608445Z","end":"2026-04-16T03:47:56.718434Z","steps":["trace[1056265949] 'agreement among raft nodes before linearized reading' (duration: 109.682638ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:56.989922Z","caller":"traceutil/trace.go:171","msg":"trace[450966326] transaction","detail":"{read_only:false; response_revision:2409; number_of_response:1; }","duration":"268.954775ms","start":"2026-04-16T03:47:56.72094Z","end":"2026-04-16T03:47:56.989895Z","steps":["trace[450966326] 'process raft request' (duration: 218.623857ms)","trace[450966326] 'compare' (duration: 50.199225ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:47:57.845959Z","caller":"traceutil/trace.go:171","msg":"trace[167860332] transaction","detail":"{read_only:false; response_revision:2411; number_of_response:1; }","duration":"122.672209ms","start":"2026-04-16T03:47:57.723258Z","end":"2026-04-16T03:47:57.84593Z","steps":["trace[167860332] 'process raft request' (duration: 122.538285ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:47:59.997932Z","caller":"traceutil/trace.go:171","msg":"trace[31089767] transaction","detail":"{read_only:false; response_revision:2417; number_of_response:1; }","duration":"143.986703ms","start":"2026-04-16T03:47:59.853915Z","end":"2026-04-16T03:47:59.997901Z","steps":["trace[31089767] 'process raft request' (duration: 143.785158ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:02.296907Z","caller":"traceutil/trace.go:171","msg":"trace[1973779005] transaction","detail":"{read_only:false; response_revision:2423; number_of_response:1; }","duration":"291.166894ms","start":"2026-04-16T03:48:02.005721Z","end":"2026-04-16T03:48:02.296888Z","steps":["trace[1973779005] 'process raft request' (duration: 291.063702ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:02.703724Z","caller":"traceutil/trace.go:171","msg":"trace[1973420554] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"109.807352ms","start":"2026-04-16T03:48:02.593891Z","end":"2026-04-16T03:48:02.703698Z","steps":["trace[1973420554] 'process raft request' (duration: 109.660008ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:02.746148Z","caller":"traceutil/trace.go:171","msg":"trace[1114478638] transaction","detail":"{read_only:false; response_revision:2425; number_of_response:1; }","duration":"152.098392ms","start":"2026-04-16T03:48:02.594018Z","end":"2026-04-16T03:48:02.746116Z","steps":["trace[1114478638] 'process raft request' (duration: 151.954598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:03.022704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.044204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:03.022813Z","caller":"traceutil/trace.go:171","msg":"trace[443142180] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"260.183919ms","start":"2026-04-16T03:48:02.762609Z","end":"2026-04-16T03:48:03.022793Z","steps":["trace[443142180] 'process raft request' (duration: 48.96163ms)","trace[443142180] 'compare' (duration: 210.688275ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:03.071256Z","caller":"traceutil/trace.go:171","msg":"trace[1597722690] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"149.41584ms","start":"2026-04-16T03:48:02.921823Z","end":"2026-04-16T03:48:03.071238Z","steps":["trace[1597722690] 'process raft request' (duration: 149.153623ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:05.196656Z","caller":"traceutil/trace.go:171","msg":"trace[1698232932] transaction","detail":"{read_only:false; response_revision:2435; number_of_response:1; }","duration":"102.387912ms","start":"2026-04-16T03:48:05.094238Z","end":"2026-04-16T03:48:05.196625Z","steps":["trace[1698232932] 'process raft request' (duration: 76.885494ms)","trace[1698232932] 'compare' (duration: 25.360834ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:06.156446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.118415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:06.156518Z","caller":"traceutil/trace.go:171","msg":"trace[625163776] transaction","detail":"{read_only:false; response_revision:2437; number_of_response:1; }","duration":"359.065305ms","start":"2026-04-16T03:48:05.797439Z","end":"2026-04-16T03:48:06.156505Z","steps":["trace[625163776] 'process raft request' (duration: 256.792957ms)","trace[625163776] 'compare' (duration: 102.041812ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:06.156556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:05.797414Z","time spent":"359.126068ms","remote":"127.0.0.1:37120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11346,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:06.869767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.33321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:06.869833Z","caller":"traceutil/trace.go:171","msg":"trace[1390755631] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2439; }","duration":"221.446653ms","start":"2026-04-16T03:48:06.648371Z","end":"2026-04-16T03:48:06.869817Z","steps":["trace[1390755631] 'range keys from in-memory index tree' (duration: 221.250499ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:07.45092Z","caller":"traceutil/trace.go:171","msg":"trace[249085968] linearizableReadLoop","detail":"{readStateIndex:2559; appliedIndex:2558; }","duration":"381.10775ms","start":"2026-04-16T03:48:07.069791Z","end":"2026-04-16T03:48:07.450899Z","steps":["trace[249085968] 'read index received' (duration: 380.907294ms)","trace[249085968] 'applied index is now lower than readState.Index' (duration: 199.556µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:07.45098Z","caller":"traceutil/trace.go:171","msg":"trace[782221453] transaction","detail":"{read_only:false; response_revision:2441; number_of_response:1; }","duration":"576.352268ms","start":"2026-04-16T03:48:06.874595Z","end":"2026-04-16T03:48:07.450948Z","steps":["trace[782221453] 'process raft request' (duration: 576.171143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:07.451146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.340066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-16T03:48:07.451165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.293283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-16T03:48:07.451208Z","caller":"traceutil/trace.go:171","msg":"trace[865239665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2441; }","duration":"250.352394ms","start":"2026-04-16T03:48:07.200845Z","end":"2026-04-16T03:48:07.451198Z","steps":["trace[865239665] 'agreement among raft nodes before linearized reading' (duration: 250.18091ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:07.451207Z","caller":"traceutil/trace.go:171","msg":"trace[1846722256] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2441; }","duration":"381.458171ms","start":"2026-04-16T03:48:07.069734Z","end":"2026-04-16T03:48:07.451192Z","steps":["trace[1846722256] 'agreement among raft nodes before linearized reading' (duration: 381.282306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:07.45122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.394165ms","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":"warn","ts":"2026-04-16T03:48:07.451247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:07.06971Z","time spent":"381.531382ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-16T03:48:07.451273Z","caller":"traceutil/trace.go:171","msg":"trace[989304306] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2441; }","duration":"243.453688ms","start":"2026-04-16T03:48:07.207804Z","end":"2026-04-16T03:48:07.451258Z","steps":["trace[989304306] 'agreement among raft nodes before linearized reading' (duration: 243.310614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:07.451157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:06.874582Z","time spent":"576.47353ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:07.720671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.831426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:07.720898Z","caller":"traceutil/trace.go:171","msg":"trace[470923960] transaction","detail":"{read_only:false; response_revision:2442; number_of_response:1; }","duration":"265.806081ms","start":"2026-04-16T03:48:07.45507Z","end":"2026-04-16T03:48:07.720876Z","steps":["trace[470923960] 'process raft request' (duration: 60.680408ms)","trace[470923960] 'compare' (duration: 204.65221ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:07.720904Z","caller":"traceutil/trace.go:171","msg":"trace[1019621352] transaction","detail":"{read_only:false; response_revision:2443; number_of_response:1; }","duration":"265.79961ms","start":"2026-04-16T03:48:07.455069Z","end":"2026-04-16T03:48:07.720868Z","steps":["trace[1019621352] 'process raft request' (duration: 265.681077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:08.167331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.4755ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:08.16743Z","caller":"traceutil/trace.go:171","msg":"trace[1364966485] linearizableReadLoop","detail":"{readStateIndex:2562; appliedIndex:2561; }","duration":"187.508849ms","start":"2026-04-16T03:48:07.979905Z","end":"2026-04-16T03:48:08.167413Z","steps":["trace[1364966485] 'read index received' (duration: 158.555µs)","trace[1364966485] 'applied index is now lower than readState.Index' (duration: 187.349014ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:08.167499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.597601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:08.167526Z","caller":"traceutil/trace.go:171","msg":"trace[1795451672] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2444; }","duration":"187.671282ms","start":"2026-04-16T03:48:07.979846Z","end":"2026-04-16T03:48:08.167517Z","steps":["trace[1795451672] 'agreement among raft nodes before linearized reading' (duration: 187.613251ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:08.167499Z","caller":"traceutil/trace.go:171","msg":"trace[2003414941] transaction","detail":"{read_only:false; response_revision:2444; number_of_response:1; }","duration":"342.207591ms","start":"2026-04-16T03:48:07.825251Z","end":"2026-04-16T03:48:08.167459Z","steps":["trace[2003414941] 'process raft request' (duration: 122.411902ms)","trace[2003414941] 'compare' (duration: 219.361737ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:08.167709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:07.825225Z","time spent":"342.362245ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:08.607085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.204444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T03:48:08.607184Z","caller":"traceutil/trace.go:171","msg":"trace[1805477366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2444; }","duration":"189.352768ms","start":"2026-04-16T03:48:08.417809Z","end":"2026-04-16T03:48:08.607162Z","steps":["trace[1805477366] 'range keys from in-memory index tree' (duration: 189.017548ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:08.776294Z","caller":"traceutil/trace.go:171","msg":"trace[695367501] linearizableReadLoop","detail":"{readStateIndex:2563; appliedIndex:2562; }","duration":"129.220496ms","start":"2026-04-16T03:48:08.647051Z","end":"2026-04-16T03:48:08.776272Z","steps":["trace[695367501] 'read index received' (duration: 129.054192ms)","trace[695367501] 'applied index is now lower than readState.Index' (duration: 165.244µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:08.77632Z","caller":"traceutil/trace.go:171","msg":"trace[2435248] transaction","detail":"{read_only:false; response_revision:2445; number_of_response:1; }","duration":"165.251988ms","start":"2026-04-16T03:48:08.611049Z","end":"2026-04-16T03:48:08.776301Z","steps":["trace[2435248] 'process raft request' (duration: 165.084303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:08.776405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.330929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:08.776431Z","caller":"traceutil/trace.go:171","msg":"trace[1731591188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2445; }","duration":"129.39613ms","start":"2026-04-16T03:48:08.647026Z","end":"2026-04-16T03:48:08.776423Z","steps":["trace[1731591188] 'agreement among raft nodes before linearized reading' (duration: 129.331878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:09.41585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.852677ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T03:48:09.415959Z","caller":"traceutil/trace.go:171","msg":"trace[1588397557] linearizableReadLoop","detail":"{readStateIndex:2564; appliedIndex:2563; }","duration":"497.687866ms","start":"2026-04-16T03:48:08.918252Z","end":"2026-04-16T03:48:09.415939Z","steps":["trace[1588397557] 'read index received' (duration: 94.727346ms)","trace[1588397557] 'applied index is now lower than readState.Index' (duration: 402.95887ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:09.416093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.831619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T03:48:09.416127Z","caller":"traceutil/trace.go:171","msg":"trace[1742897873] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2445; }","duration":"497.911121ms","start":"2026-04-16T03:48:08.918207Z","end":"2026-04-16T03:48:09.416118Z","steps":["trace[1742897873] 'agreement among raft nodes before linearized reading' (duration: 497.826319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:09.416164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:08.918187Z","time spent":"497.968472ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-04-16T03:48:09.416206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.002924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-16T03:48:09.416216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.649273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:09.41627Z","caller":"traceutil/trace.go:171","msg":"trace[611380705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2445; }","duration":"445.109127ms","start":"2026-04-16T03:48:08.971143Z","end":"2026-04-16T03:48:09.416252Z","steps":["trace[611380705] 'agreement among raft nodes before linearized reading' (duration: 444.913032ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:09.416288Z","caller":"traceutil/trace.go:171","msg":"trace[110861182] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2445; }","duration":"276.722225ms","start":"2026-04-16T03:48:09.139541Z","end":"2026-04-16T03:48:09.416263Z","steps":["trace[110861182] 'agreement among raft nodes before linearized reading' (duration: 276.613292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:09.416308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:08.971124Z","time spent":"445.174958ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T03:48:09.784638Z","caller":"traceutil/trace.go:171","msg":"trace[1534685777] linearizableReadLoop","detail":"{readStateIndex:2565; appliedIndex:2564; }","duration":"329.727295ms","start":"2026-04-16T03:48:09.454896Z","end":"2026-04-16T03:48:09.784624Z","steps":["trace[1534685777] 'read index received' (duration: 329.686124ms)","trace[1534685777] 'applied index is now lower than readState.Index' (duration: 40.461µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:09.784705Z","caller":"traceutil/trace.go:171","msg":"trace[1486809223] transaction","detail":"{read_only:false; response_revision:2446; number_of_response:1; }","duration":"364.868203ms","start":"2026-04-16T03:48:09.419809Z","end":"2026-04-16T03:48:09.784677Z","steps":["trace[1486809223] 'process raft request' (duration: 364.717359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:09.784783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.88452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T03:48:09.784805Z","caller":"traceutil/trace.go:171","msg":"trace[815757212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2446; }","duration":"329.957241ms","start":"2026-04-16T03:48:09.454841Z","end":"2026-04-16T03:48:09.784798Z","steps":["trace[815757212] 'agreement among raft nodes before linearized reading' (duration: 329.872759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:09.784822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:09.454817Z","time spent":"330.001233ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T03:48:09.784884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:09.419783Z","time spent":"364.998027ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:09.784903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.303661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:09.784966Z","caller":"traceutil/trace.go:171","msg":"trace[557517285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2446; }","duration":"135.404194ms","start":"2026-04-16T03:48:09.649558Z","end":"2026-04-16T03:48:09.784962Z","steps":["trace[557517285] 'agreement among raft nodes before linearized reading' (duration: 135.330022ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:10.661233Z","caller":"traceutil/trace.go:171","msg":"trace[82953446] transaction","detail":"{read_only:false; response_revision:2447; number_of_response:1; }","duration":"872.300761ms","start":"2026-04-16T03:48:09.788908Z","end":"2026-04-16T03:48:10.661209Z","steps":["trace[82953446] 'process raft request' (duration: 872.145306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:10.661471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:09.788898Z","time spent":"872.491126ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:48:10.679635Z","caller":"traceutil/trace.go:171","msg":"trace[1779286504] transaction","detail":"{read_only:false; response_revision:2448; number_of_response:1; }","duration":"890.330207ms","start":"2026-04-16T03:48:09.78928Z","end":"2026-04-16T03:48:10.67961Z","steps":["trace[1779286504] 'process raft request' (duration: 890.135362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:10.679811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:09.789254Z","time spent":"890.460871ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:48:10.680064Z","caller":"traceutil/trace.go:171","msg":"trace[697963626] transaction","detail":"{read_only:false; response_revision:2449; number_of_response:1; }","duration":"890.612405ms","start":"2026-04-16T03:48:09.789433Z","end":"2026-04-16T03:48:10.680045Z","steps":["trace[697963626] 'process raft request' (duration: 890.135312ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:10.6801Z","caller":"traceutil/trace.go:171","msg":"trace[749290200] transaction","detail":"{read_only:false; response_revision:2450; number_of_response:1; }","duration":"506.991769ms","start":"2026-04-16T03:48:10.173079Z","end":"2026-04-16T03:48:10.680071Z","steps":["trace[749290200] 'process raft request' (duration: 506.841255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:10.680234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:09.789401Z","time spent":"890.742868ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:10.68032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:10.17305Z","time spent":"507.143254ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:11.369956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.692036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T03:48:11.370045Z","caller":"traceutil/trace.go:171","msg":"trace[1784335064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2450; }","duration":"589.841409ms","start":"2026-04-16T03:48:10.780183Z","end":"2026-04-16T03:48:11.370024Z","steps":["trace[1784335064] 'range keys from in-memory index tree' (duration: 589.491639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:11.370166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:10.780157Z","time spent":"589.995474ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T03:48:11.753685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.434493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:11.753773Z","caller":"traceutil/trace.go:171","msg":"trace[1799690100] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2451; }","duration":"104.590838ms","start":"2026-04-16T03:48:11.649164Z","end":"2026-04-16T03:48:11.753754Z","steps":["trace[1799690100] 'range keys from in-memory index tree' (duration: 104.344821ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:12.060859Z","caller":"traceutil/trace.go:171","msg":"trace[1858435114] transaction","detail":"{read_only:false; response_revision:2452; number_of_response:1; }","duration":"268.459017ms","start":"2026-04-16T03:48:11.792374Z","end":"2026-04-16T03:48:12.060833Z","steps":["trace[1858435114] 'process raft request' (duration: 268.293662ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:13.066762Z","caller":"traceutil/trace.go:171","msg":"trace[711692952] linearizableReadLoop","detail":"{readStateIndex:2572; appliedIndex:2571; }","duration":"382.850973ms","start":"2026-04-16T03:48:12.683888Z","end":"2026-04-16T03:48:13.066739Z","steps":["trace[711692952] 'read index received' (duration: 382.698909ms)","trace[711692952] 'applied index is now lower than readState.Index' (duration: 150.864µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:13.066912Z","caller":"traceutil/trace.go:171","msg":"trace[1934133531] transaction","detail":"{read_only:false; response_revision:2453; number_of_response:1; }","duration":"396.206161ms","start":"2026-04-16T03:48:12.670667Z","end":"2026-04-16T03:48:13.066873Z","steps":["trace[1934133531] 'process raft request' (duration: 395.921573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:13.06711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:12.67064Z","time spent":"396.355415ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:13.067113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.192842ms","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-16T03:48:13.06721Z","caller":"traceutil/trace.go:171","msg":"trace[446746433] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2453; }","duration":"383.340676ms","start":"2026-04-16T03:48:12.683842Z","end":"2026-04-16T03:48:13.067183Z","steps":["trace[446746433] 'agreement among raft nodes before linearized reading' (duration: 383.043218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:13.067263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:12.683824Z","time spent":"383.428859ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T03:48:13.385072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.951482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:13.385207Z","caller":"traceutil/trace.go:171","msg":"trace[1520933887] transaction","detail":"{read_only:false; response_revision:2454; number_of_response:1; }","duration":"700.272768ms","start":"2026-04-16T03:48:12.684904Z","end":"2026-04-16T03:48:13.385177Z","steps":["trace[1520933887] 'process raft request' (duration: 435.953646ms)","trace[1520933887] 'compare' (duration: 263.853949ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:13.385273Z","caller":"traceutil/trace.go:171","msg":"trace[1970429117] transaction","detail":"{read_only:false; response_revision:2455; number_of_response:1; }","duration":"313.683351ms","start":"2026-04-16T03:48:13.071573Z","end":"2026-04-16T03:48:13.385257Z","steps":["trace[1970429117] 'process raft request' (duration: 313.595149ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:13.385299Z","caller":"traceutil/trace.go:171","msg":"trace[784172877] linearizableReadLoop","detail":"{readStateIndex:2573; appliedIndex:2572; }","duration":"318.428582ms","start":"2026-04-16T03:48:13.066851Z","end":"2026-04-16T03:48:13.385279Z","steps":["trace[784172877] 'read index received' (duration: 54.018797ms)","trace[784172877] 'applied index is now lower than readState.Index' (duration: 264.407225ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:13.385341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:13.071545Z","time spent":"313.764114ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:13.385367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:12.684883Z","time spent":"700.395791ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:13.38551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.924096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T03:48:13.385864Z","caller":"traceutil/trace.go:171","msg":"trace[516261651] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2455; }","duration":"403.327667ms","start":"2026-04-16T03:48:12.982522Z","end":"2026-04-16T03:48:13.38585Z","steps":["trace[516261651] 'agreement among raft nodes before linearized reading' (duration: 402.872265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:13.38595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:12.9825Z","time spent":"403.433771ms","remote":"127.0.0.1:37134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-04-16T03:48:13.385599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.966535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T03:48:13.386032Z","caller":"traceutil/trace.go:171","msg":"trace[493982109] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:2455; }","duration":"102.432828ms","start":"2026-04-16T03:48:13.283587Z","end":"2026-04-16T03:48:13.386019Z","steps":["trace[493982109] 'agreement among raft nodes before linearized reading' (duration: 101.857042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:13.385643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.653815ms","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-04-16T03:48:13.386206Z","caller":"traceutil/trace.go:171","msg":"trace[932675665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2455; }","duration":"702.227321ms","start":"2026-04-16T03:48:12.683964Z","end":"2026-04-16T03:48:13.386192Z","steps":["trace[932675665] 'agreement among raft nodes before linearized reading' (duration: 701.582693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:13.386264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:12.683957Z","time spent":"702.287402ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T03:48:13.851473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.400642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:13.851756Z","caller":"traceutil/trace.go:171","msg":"trace[1706758274] transaction","detail":"{read_only:false; response_revision:2458; number_of_response:1; }","duration":"389.143546ms","start":"2026-04-16T03:48:13.46259Z","end":"2026-04-16T03:48:13.851734Z","steps":["trace[1706758274] 'process raft request' (duration: 389.086444ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:13.851827Z","caller":"traceutil/trace.go:171","msg":"trace[371327354] transaction","detail":"{read_only:false; response_revision:2457; number_of_response:1; }","duration":"427.520942ms","start":"2026-04-16T03:48:13.42428Z","end":"2026-04-16T03:48:13.851801Z","steps":["trace[371327354] 'process raft request' (duration: 427.320586ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:13.851847Z","caller":"traceutil/trace.go:171","msg":"trace[2056311332] transaction","detail":"{read_only:false; response_revision:2456; number_of_response:1; }","duration":"461.604389ms","start":"2026-04-16T03:48:13.390217Z","end":"2026-04-16T03:48:13.851821Z","steps":["trace[2056311332] 'process raft request' (duration: 328.737374ms)","trace[2056311332] 'compare' (duration: 132.242078ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:13.851867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:13.462576Z","time spent":"389.242328ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:48:13.851882Z","caller":"traceutil/trace.go:171","msg":"trace[205969097] linearizableReadLoop","detail":"{readStateIndex:2576; appliedIndex:2574; }","duration":"451.828591ms","start":"2026-04-16T03:48:13.399981Z","end":"2026-04-16T03:48:13.851809Z","steps":["trace[205969097] 'read index received' (duration: 23.308271ms)","trace[205969097] 'applied index is now lower than readState.Index' (duration: 428.50992ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:13.85196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:13.390195Z","time spent":"461.710403ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:13.851984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:13.424267Z","time spent":"427.631495ms","remote":"127.0.0.1:36994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:13.852852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.203833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T03:48:13.852943Z","caller":"traceutil/trace.go:171","msg":"trace[281807410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2458; }","duration":"452.976833ms","start":"2026-04-16T03:48:13.399946Z","end":"2026-04-16T03:48:13.852923Z","steps":["trace[281807410] 'agreement among raft nodes before linearized reading' (duration: 452.018807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:13.853004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:13.399933Z","time spent":"453.058266ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T03:48:13.853094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.16903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:13.853235Z","caller":"traceutil/trace.go:171","msg":"trace[336354511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2458; }","duration":"203.360395ms","start":"2026-04-16T03:48:13.649848Z","end":"2026-04-16T03:48:13.853209Z","steps":["trace[336354511] 'agreement among raft nodes before linearized reading' (duration: 202.260425ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:14.248552Z","caller":"traceutil/trace.go:171","msg":"trace[1092716684] linearizableReadLoop","detail":"{readStateIndex:2579; appliedIndex:2578; }","duration":"387.289706ms","start":"2026-04-16T03:48:13.861239Z","end":"2026-04-16T03:48:14.248528Z","steps":["trace[1092716684] 'read index received' (duration: 387.133302ms)","trace[1092716684] 'applied index is now lower than readState.Index' (duration: 155.224µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:14.248675Z","caller":"traceutil/trace.go:171","msg":"trace[2028454477] transaction","detail":"{read_only:false; response_revision:2459; number_of_response:1; }","duration":"388.53667ms","start":"2026-04-16T03:48:13.860126Z","end":"2026-04-16T03:48:14.248663Z","steps":["trace[2028454477] 'process raft request' (duration: 388.203011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:14.248781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:13.860107Z","time spent":"388.594672ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:48:14.248869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.017132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-16T03:48:14.248922Z","caller":"traceutil/trace.go:171","msg":"trace[304301981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2459; }","duration":"184.090865ms","start":"2026-04-16T03:48:14.064814Z","end":"2026-04-16T03:48:14.248905Z","steps":["trace[304301981] 'agreement among raft nodes before linearized reading' (duration: 183.951311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:14.249151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.901572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T03:48:14.249197Z","caller":"traceutil/trace.go:171","msg":"trace[81426420] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2459; }","duration":"387.969164ms","start":"2026-04-16T03:48:13.861217Z","end":"2026-04-16T03:48:14.249186Z","steps":["trace[81426420] 'agreement among raft nodes before linearized reading' (duration: 387.761828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:14.249228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:13.861209Z","time spent":"388.011376ms","remote":"127.0.0.1:36994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-04-16T03:48:14.629382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.931366ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:14.629566Z","caller":"traceutil/trace.go:171","msg":"trace[2099333970] transaction","detail":"{read_only:false; response_revision:2460; number_of_response:1; }","duration":"376.92334ms","start":"2026-04-16T03:48:14.252621Z","end":"2026-04-16T03:48:14.629544Z","steps":["trace[2099333970] 'process raft request' (duration: 134.734657ms)","trace[2099333970] 'compare' (duration: 241.813383ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:14.629664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:14.252604Z","time spent":"377.025803ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:48:15.216658Z","caller":"traceutil/trace.go:171","msg":"trace[1544523729] transaction","detail":"{read_only:false; response_revision:2461; number_of_response:1; }","duration":"141.675409ms","start":"2026-04-16T03:48:15.074959Z","end":"2026-04-16T03:48:15.216635Z","steps":["trace[1544523729] 'process raft request' (duration: 141.545035ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:15.53557Z","caller":"traceutil/trace.go:171","msg":"trace[583187904] transaction","detail":"{read_only:false; response_revision:2462; number_of_response:1; }","duration":"145.223434ms","start":"2026-04-16T03:48:15.390318Z","end":"2026-04-16T03:48:15.535541Z","steps":["trace[583187904] 'process raft request' (duration: 145.05809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:15.955266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.021803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:15.955735Z","caller":"traceutil/trace.go:171","msg":"trace[1154387922] transaction","detail":"{read_only:false; response_revision:2463; number_of_response:1; }","duration":"562.399714ms","start":"2026-04-16T03:48:15.393266Z","end":"2026-04-16T03:48:15.955666Z","steps":["trace[1154387922] 'process raft request' (duration: 264.868667ms)","trace[1154387922] 'compare' (duration: 296.640062ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:15.955983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:15.393246Z","time spent":"562.595799ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:48:16.157903Z","caller":"traceutil/trace.go:171","msg":"trace[263483708] transaction","detail":"{read_only:false; response_revision:2464; number_of_response:1; }","duration":"196.122856ms","start":"2026-04-16T03:48:15.961749Z","end":"2026-04-16T03:48:16.157872Z","steps":["trace[263483708] 'process raft request' (duration: 195.744645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:16.474928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.034985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:16.475047Z","caller":"traceutil/trace.go:171","msg":"trace[1191236991] linearizableReadLoop","detail":"{readStateIndex:2585; appliedIndex:2584; }","duration":"127.774016ms","start":"2026-04-16T03:48:16.347254Z","end":"2026-04-16T03:48:16.475028Z","steps":["trace[1191236991] 'read index received' (duration: 50.381µs)","trace[1191236991] 'applied index is now lower than readState.Index' (duration: 127.722445ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:16.475115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.865728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:16.475158Z","caller":"traceutil/trace.go:171","msg":"trace[1509515098] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:2465; }","duration":"127.93743ms","start":"2026-04-16T03:48:16.347204Z","end":"2026-04-16T03:48:16.475141Z","steps":["trace[1509515098] 'agreement among raft nodes before linearized reading' (duration: 127.874108ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:16.4752Z","caller":"traceutil/trace.go:171","msg":"trace[1667420017] transaction","detail":"{read_only:false; response_revision:2465; number_of_response:1; }","duration":"215.657554ms","start":"2026-04-16T03:48:16.259482Z","end":"2026-04-16T03:48:16.475139Z","steps":["trace[1667420017] 'process raft request' (duration: 84.31605ms)","trace[1667420017] 'compare' (duration: 130.891282ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:42.244202Z","caller":"traceutil/trace.go:171","msg":"trace[48935607] transaction","detail":"{read_only:false; response_revision:2549; number_of_response:1; }","duration":"144.136266ms","start":"2026-04-16T03:48:42.100044Z","end":"2026-04-16T03:48:42.244181Z","steps":["trace[48935607] 'process raft request' (duration: 143.952991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:43.049538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.630098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:43.049852Z","caller":"traceutil/trace.go:171","msg":"trace[602324834] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"273.284448ms","start":"2026-04-16T03:48:42.776538Z","end":"2026-04-16T03:48:43.049822Z","steps":["trace[602324834] 'process raft request' (duration: 111.231889ms)","trace[602324834] 'compare' (duration: 161.34474ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:43.829767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.586246ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:43.829891Z","caller":"traceutil/trace.go:171","msg":"trace[7055276] linearizableReadLoop","detail":"{readStateIndex:2681; appliedIndex:2680; }","duration":"182.473342ms","start":"2026-04-16T03:48:43.647399Z","end":"2026-04-16T03:48:43.829872Z","steps":["trace[7055276] 'read index received' (duration: 20.635559ms)","trace[7055276] 'applied index is now lower than readState.Index' (duration: 161.836223ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:43.829954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.555114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:43.829985Z","caller":"traceutil/trace.go:171","msg":"trace[1614679353] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2555; }","duration":"182.623956ms","start":"2026-04-16T03:48:43.647352Z","end":"2026-04-16T03:48:43.829976Z","steps":["trace[1614679353] 'agreement among raft nodes before linearized reading' (duration: 182.569254ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:43.829961Z","caller":"traceutil/trace.go:171","msg":"trace[604214711] transaction","detail":"{read_only:false; response_revision:2555; number_of_response:1; }","duration":"197.039282ms","start":"2026-04-16T03:48:43.632894Z","end":"2026-04-16T03:48:43.829934Z","steps":["trace[604214711] 'process raft request' (duration: 35.183988ms)","trace[604214711] 'compare' (duration: 161.446292ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:44.648773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.218841ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:44.64895Z","caller":"traceutil/trace.go:171","msg":"trace[1929571391] transaction","detail":"{read_only:false; response_revision:2558; number_of_response:1; }","duration":"294.287516ms","start":"2026-04-16T03:48:44.354647Z","end":"2026-04-16T03:48:44.648935Z","steps":["trace[1929571391] 'process raft request' (duration: 294.239465ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:44.649116Z","caller":"traceutil/trace.go:171","msg":"trace[29393706] transaction","detail":"{read_only:false; response_revision:2557; number_of_response:1; }","duration":"294.858632ms","start":"2026-04-16T03:48:44.354206Z","end":"2026-04-16T03:48:44.649065Z","steps":["trace[29393706] 'process raft request' (duration: 147.23109ms)","trace[29393706] 'compare' (duration: 147.096307ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:44.956226Z","caller":"traceutil/trace.go:171","msg":"trace[1294135400] transaction","detail":"{read_only:false; response_revision:2559; number_of_response:1; }","duration":"250.535864ms","start":"2026-04-16T03:48:44.705657Z","end":"2026-04-16T03:48:44.956193Z","steps":["trace[1294135400] 'process raft request' (duration: 225.228907ms)","trace[1294135400] 'compare' (duration: 25.182193ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:45.31177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.704937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:45.31202Z","caller":"traceutil/trace.go:171","msg":"trace[986887367] transaction","detail":"{read_only:false; response_revision:2560; number_of_response:1; }","duration":"254.861582ms","start":"2026-04-16T03:48:45.057132Z","end":"2026-04-16T03:48:45.311994Z","steps":["trace[986887367] 'process raft request' (duration: 103.846397ms)","trace[986887367] 'compare' (duration: 150.596614ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:45.636446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.380304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T03:48:45.636504Z","caller":"traceutil/trace.go:171","msg":"trace[976945819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2560; }","duration":"119.489699ms","start":"2026-04-16T03:48:45.517002Z","end":"2026-04-16T03:48:45.636492Z","steps":["trace[976945819] 'range keys from in-memory index tree' (duration: 119.202609ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:45.806392Z","caller":"traceutil/trace.go:171","msg":"trace[1821163718] linearizableReadLoop","detail":"{readStateIndex:2687; appliedIndex:2686; }","duration":"158.898953ms","start":"2026-04-16T03:48:45.647464Z","end":"2026-04-16T03:48:45.806362Z","steps":["trace[1821163718] 'read index received' (duration: 158.635476ms)","trace[1821163718] 'applied index is now lower than readState.Index' (duration: 243.616µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:45.806432Z","caller":"traceutil/trace.go:171","msg":"trace[1915188368] transaction","detail":"{read_only:false; response_revision:2561; number_of_response:1; }","duration":"166.284785ms","start":"2026-04-16T03:48:45.640112Z","end":"2026-04-16T03:48:45.806397Z","steps":["trace[1915188368] 'process raft request' (duration: 166.057749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:45.80655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.064877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:45.806587Z","caller":"traceutil/trace.go:171","msg":"trace[1646624160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2561; }","duration":"159.16954ms","start":"2026-04-16T03:48:45.647405Z","end":"2026-04-16T03:48:45.806574Z","steps":["trace[1646624160] 'agreement among raft nodes before linearized reading' (duration: 159.081377ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:46.509894Z","caller":"traceutil/trace.go:171","msg":"trace[1769935482] transaction","detail":"{read_only:false; response_revision:2563; number_of_response:1; }","duration":"150.856481ms","start":"2026-04-16T03:48:46.359006Z","end":"2026-04-16T03:48:46.509862Z","steps":["trace[1769935482] 'process raft request' (duration: 150.661826ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:46.796871Z","caller":"traceutil/trace.go:171","msg":"trace[1848805073] transaction","detail":"{read_only:false; response_revision:2564; number_of_response:1; }","duration":"139.615502ms","start":"2026-04-16T03:48:46.657215Z","end":"2026-04-16T03:48:46.79683Z","steps":["trace[1848805073] 'process raft request' (duration: 139.346824ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:47.947114Z","caller":"traceutil/trace.go:171","msg":"trace[255956441] transaction","detail":"{read_only:false; response_revision:2568; number_of_response:1; }","duration":"130.017296ms","start":"2026-04-16T03:48:47.817072Z","end":"2026-04-16T03:48:47.94709Z","steps":["trace[255956441] 'process raft request' (duration: 129.886973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:48.24486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.120761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:48.245016Z","caller":"traceutil/trace.go:171","msg":"trace[552798899] transaction","detail":"{read_only:false; response_revision:2569; number_of_response:1; }","duration":"332.815858ms","start":"2026-04-16T03:48:47.912175Z","end":"2026-04-16T03:48:48.244991Z","steps":["trace[552798899] 'process raft request' (duration: 198.446801ms)","trace[552798899] 'compare' (duration: 133.831481ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:48.245111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:47.912153Z","time spent":"332.90778ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:48:48.888141Z","caller":"traceutil/trace.go:171","msg":"trace[1722741217] linearizableReadLoop","detail":"{readStateIndex:2696; appliedIndex:2695; }","duration":"238.213744ms","start":"2026-04-16T03:48:48.649904Z","end":"2026-04-16T03:48:48.888118Z","steps":["trace[1722741217] 'read index received' (duration: 238.096441ms)","trace[1722741217] 'applied index is now lower than readState.Index' (duration: 116.563µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:48.888231Z","caller":"traceutil/trace.go:171","msg":"trace[1575075159] transaction","detail":"{read_only:false; response_revision:2570; number_of_response:1; }","duration":"367.464551ms","start":"2026-04-16T03:48:48.520745Z","end":"2026-04-16T03:48:48.888209Z","steps":["trace[1575075159] 'process raft request' (duration: 367.231754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:48.888276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.354898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:48.888308Z","caller":"traceutil/trace.go:171","msg":"trace[1929274677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2570; }","duration":"238.454861ms","start":"2026-04-16T03:48:48.649844Z","end":"2026-04-16T03:48:48.888298Z","steps":["trace[1929274677] 'agreement among raft nodes before linearized reading' (duration: 238.384509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:48.888359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:48:48.520714Z","time spent":"367.567333ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:48:48.98936Z","caller":"traceutil/trace.go:171","msg":"trace[523645857] linearizableReadLoop","detail":"{readStateIndex:2697; appliedIndex:2696; }","duration":"101.129522ms","start":"2026-04-16T03:48:48.88821Z","end":"2026-04-16T03:48:48.98934Z","steps":["trace[523645857] 'read index received' (duration: 12.229187ms)","trace[523645857] 'applied index is now lower than readState.Index' (duration: 88.898705ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:48:48.989523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.37383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:48:48.989556Z","caller":"traceutil/trace.go:171","msg":"trace[1469268671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2570; }","duration":"100.453232ms","start":"2026-04-16T03:48:48.889094Z","end":"2026-04-16T03:48:48.989547Z","steps":["trace[1469268671] 'agreement among raft nodes before linearized reading' (duration: 100.383461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:48.98964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.177725ms","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-04-16T03:48:48.989716Z","caller":"traceutil/trace.go:171","msg":"trace[1057896629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2570; }","duration":"189.319759ms","start":"2026-04-16T03:48:48.800382Z","end":"2026-04-16T03:48:48.989702Z","steps":["trace[1057896629] 'agreement among raft nodes before linearized reading' (duration: 189.085162ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:50.186725Z","caller":"traceutil/trace.go:171","msg":"trace[1890960341] transaction","detail":"{read_only:false; response_revision:2574; number_of_response:1; }","duration":"231.51804ms","start":"2026-04-16T03:48:49.955175Z","end":"2026-04-16T03:48:50.186693Z","steps":["trace[1890960341] 'process raft request' (duration: 231.330225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:50.437051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.953118ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:48:50.437248Z","caller":"traceutil/trace.go:171","msg":"trace[1013131220] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"186.523782ms","start":"2026-04-16T03:48:50.250694Z","end":"2026-04-16T03:48:50.437218Z","steps":["trace[1013131220] 'process raft request' (duration: 17.320927ms)","trace[1013131220] 'compare' (duration: 168.848786ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:48:51.008052Z","caller":"traceutil/trace.go:171","msg":"trace[417455467] transaction","detail":"{read_only:false; response_revision:2576; number_of_response:1; }","duration":"111.236271ms","start":"2026-04-16T03:48:50.896792Z","end":"2026-04-16T03:48:51.008028Z","steps":["trace[417455467] 'process raft request' (duration: 111.090567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:48:51.472597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.766746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-16T03:48:51.472675Z","caller":"traceutil/trace.go:171","msg":"trace[272200378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2578; }","duration":"107.907609ms","start":"2026-04-16T03:48:51.36475Z","end":"2026-04-16T03:48:51.472658Z","steps":["trace[272200378] 'range keys from in-memory index tree' (duration: 107.56782ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:51.647496Z","caller":"traceutil/trace.go:171","msg":"trace[904913143] transaction","detail":"{read_only:false; response_revision:2579; number_of_response:1; }","duration":"170.606544ms","start":"2026-04-16T03:48:51.476861Z","end":"2026-04-16T03:48:51.647468Z","steps":["trace[904913143] 'process raft request' (duration: 170.421099ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:52.386818Z","caller":"traceutil/trace.go:171","msg":"trace[104829314] transaction","detail":"{read_only:false; response_revision:2580; number_of_response:1; }","duration":"192.678482ms","start":"2026-04-16T03:48:52.194119Z","end":"2026-04-16T03:48:52.386798Z","steps":["trace[104829314] 'process raft request' (duration: 192.569509ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:48:52.579951Z","caller":"traceutil/trace.go:171","msg":"trace[2099034916] transaction","detail":"{read_only:false; response_revision:2581; number_of_response:1; }","duration":"137.740829ms","start":"2026-04-16T03:48:52.442174Z","end":"2026-04-16T03:48:52.579915Z","steps":["trace[2099034916] 'process raft request' (duration: 73.049779ms)","trace[2099034916] 'compare' (duration: 64.121685ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:13.509222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.655271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:49:13.509343Z","caller":"traceutil/trace.go:171","msg":"trace[320904735] linearizableReadLoop","detail":"{readStateIndex:2781; appliedIndex:2780; }","duration":"224.202139ms","start":"2026-04-16T03:49:13.285124Z","end":"2026-04-16T03:49:13.509326Z","steps":["trace[320904735] 'read index received' (duration: 31.379043ms)","trace[320904735] 'applied index is now lower than readState.Index' (duration: 192.821786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:13.509481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.356603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T03:49:13.509518Z","caller":"traceutil/trace.go:171","msg":"trace[1963826543] range","detail":"{range_begin:/registry/masterleases/199.204.45.141; range_end:; response_count:1; response_revision:2650; }","duration":"224.419385ms","start":"2026-04-16T03:49:13.285086Z","end":"2026-04-16T03:49:13.509506Z","steps":["trace[1963826543] 'agreement among raft nodes before linearized reading' (duration: 224.288231ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:13.50953Z","caller":"traceutil/trace.go:171","msg":"trace[2102411896] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"248.630741ms","start":"2026-04-16T03:49:13.260875Z","end":"2026-04-16T03:49:13.509506Z","steps":["trace[2102411896] 'process raft request' (duration: 55.583799ms)","trace[2102411896] 'compare' (duration: 192.543618ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:13.940124Z","caller":"traceutil/trace.go:171","msg":"trace[671045864] linearizableReadLoop","detail":"{readStateIndex:2783; appliedIndex:2782; }","duration":"354.824183ms","start":"2026-04-16T03:49:13.585258Z","end":"2026-04-16T03:49:13.940082Z","steps":["trace[671045864] 'read index received' (duration: 284.121418ms)","trace[671045864] 'applied index is now lower than readState.Index' (duration: 70.701175ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:13.940263Z","caller":"traceutil/trace.go:171","msg":"trace[986382584] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"404.029806ms","start":"2026-04-16T03:49:13.536173Z","end":"2026-04-16T03:49:13.940202Z","steps":["trace[986382584] 'process raft request' (duration: 333.185857ms)","trace[986382584] 'compare' (duration: 70.472709ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:13.94039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.145671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:49:13.940442Z","caller":"traceutil/trace.go:171","msg":"trace[151255176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2651; }","duration":"291.261634ms","start":"2026-04-16T03:49:13.649166Z","end":"2026-04-16T03:49:13.940428Z","steps":["trace[151255176] 'agreement among raft nodes before linearized reading' (duration: 291.142841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:13.940417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.120491ms","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":"warn","ts":"2026-04-16T03:49:13.940509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:13.536139Z","time spent":"404.225812ms","remote":"127.0.0.1:36994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:13.94052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.073705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-16T03:49:13.940555Z","caller":"traceutil/trace.go:171","msg":"trace[1488781595] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2651; }","duration":"355.338537ms","start":"2026-04-16T03:49:13.585186Z","end":"2026-04-16T03:49:13.940525Z","steps":["trace[1488781595] 'agreement among raft nodes before linearized reading' (duration: 355.027699ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:13.940599Z","caller":"traceutil/trace.go:171","msg":"trace[212012857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2651; }","duration":"196.203789ms","start":"2026-04-16T03:49:13.744378Z","end":"2026-04-16T03:49:13.940582Z","steps":["trace[212012857] 'agreement among raft nodes before linearized reading' (duration: 195.993693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:13.940622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:13.58514Z","time spent":"355.46635ms","remote":"127.0.0.1:38814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T03:49:14.276007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.229316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:49:14.276204Z","caller":"traceutil/trace.go:171","msg":"trace[290091592] linearizableReadLoop","detail":"{readStateIndex:2784; appliedIndex:2783; }","duration":"330.131333ms","start":"2026-04-16T03:49:13.946051Z","end":"2026-04-16T03:49:14.276183Z","steps":["trace[290091592] 'read index received' (duration: 176.423064ms)","trace[290091592] 'applied index is now lower than readState.Index' (duration: 153.706789ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:14.276299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.254137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-16T03:49:14.276335Z","caller":"traceutil/trace.go:171","msg":"trace[438990087] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2652; }","duration":"330.328839ms","start":"2026-04-16T03:49:13.945995Z","end":"2026-04-16T03:49:14.276324Z","steps":["trace[438990087] 'agreement among raft nodes before linearized reading' (duration: 330.242517ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:14.276351Z","caller":"traceutil/trace.go:171","msg":"trace[1083515878] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"331.734117ms","start":"2026-04-16T03:49:13.944452Z","end":"2026-04-16T03:49:14.276186Z","steps":["trace[1083515878] 'process raft request' (duration: 178.221273ms)","trace[1083515878] 'compare' (duration: 152.492937ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:14.276381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:13.945976Z","time spent":"330.39605ms","remote":"127.0.0.1:37216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-04-16T03:49:14.276569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:13.94444Z","time spent":"332.010126ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:49:19.728224Z","caller":"traceutil/trace.go:171","msg":"trace[1819057454] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"192.624737ms","start":"2026-04-16T03:49:19.535554Z","end":"2026-04-16T03:49:19.728178Z","steps":["trace[1819057454] 'process raft request' (duration: 192.318909ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:20.535376Z","caller":"traceutil/trace.go:171","msg":"trace[859290384] transaction","detail":"{read_only:false; response_revision:2672; number_of_response:1; }","duration":"233.049725ms","start":"2026-04-16T03:49:20.302298Z","end":"2026-04-16T03:49:20.535347Z","steps":["trace[859290384] 'process raft request' (duration: 232.833429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:26.165933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.911817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:49:26.166156Z","caller":"traceutil/trace.go:171","msg":"trace[1515893877] linearizableReadLoop","detail":"{readStateIndex:2901; appliedIndex:2899; }","duration":"299.530362ms","start":"2026-04-16T03:49:25.866606Z","end":"2026-04-16T03:49:26.166137Z","steps":["trace[1515893877] 'read index received' (duration: 298.499843ms)","trace[1515893877] 'applied index is now lower than readState.Index' (duration: 1.029398ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:26.166236Z","caller":"traceutil/trace.go:171","msg":"trace[1158106030] transaction","detail":"{read_only:false; response_revision:2763; number_of_response:1; }","duration":"375.507352ms","start":"2026-04-16T03:49:25.790717Z","end":"2026-04-16T03:49:26.166224Z","steps":["trace[1158106030] 'process raft request' (duration: 39.188264ms)","trace[1158106030] 'compare' (duration: 335.718481ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:26.166302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:25.790709Z","time spent":"375.567903ms","remote":"127.0.0.1:37054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1733,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T03:49:26.166317Z","caller":"traceutil/trace.go:171","msg":"trace[269597241] transaction","detail":"{read_only:false; response_revision:2764; number_of_response:1; }","duration":"366.125779ms","start":"2026-04-16T03:49:25.800125Z","end":"2026-04-16T03:49:26.166251Z","steps":["trace[269597241] 'process raft request' (duration: 365.954554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:26.166456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.819449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T03:49:26.166557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:25.800113Z","time spent":"366.358866ms","remote":"127.0.0.1:37268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1089,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T03:49:26.166582Z","caller":"traceutil/trace.go:171","msg":"trace[319816555] range","detail":"{range_begin:/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache; range_end:; response_count:0; response_revision:2764; }","duration":"300.004684ms","start":"2026-04-16T03:49:25.866547Z","end":"2026-04-16T03:49:26.166551Z","steps":["trace[319816555] 'agreement among raft nodes before linearized reading' (duration: 299.696425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:26.166645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:25.866527Z","time spent":"300.107927ms","remote":"127.0.0.1:37266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache\" "} {"level":"info","ts":"2026-04-16T03:49:26.511294Z","caller":"traceutil/trace.go:171","msg":"trace[1526656005] linearizableReadLoop","detail":"{readStateIndex:2902; appliedIndex:2901; }","duration":"345.067972ms","start":"2026-04-16T03:49:26.166193Z","end":"2026-04-16T03:49:26.511261Z","steps":["trace[1526656005] 'read index received' (duration: 313.313355ms)","trace[1526656005] 'applied index is now lower than readState.Index' (duration: 31.753247ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:26.51165Z","caller":"traceutil/trace.go:171","msg":"trace[1643071615] transaction","detail":"{read_only:false; response_revision:2765; number_of_response:1; }","duration":"637.449374ms","start":"2026-04-16T03:49:25.874185Z","end":"2026-04-16T03:49:26.511634Z","steps":["trace[1643071615] 'process raft request' (duration: 605.553783ms)","trace[1643071615] 'compare' (duration: 30.918333ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:26.511773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:25.874148Z","time spent":"637.544457ms","remote":"127.0.0.1:37048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":211512,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:26.511928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.75729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/monitoring/loki-memcached-results-cache\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:49:26.512054Z","caller":"traceutil/trace.go:171","msg":"trace[888725786] range","detail":"{range_begin:/registry/poddisruptionbudgets/monitoring/loki-memcached-results-cache; range_end:; response_count:0; response_revision:2765; }","duration":"341.947315ms","start":"2026-04-16T03:49:26.170078Z","end":"2026-04-16T03:49:26.512025Z","steps":["trace[888725786] 'agreement among raft nodes before linearized reading' (duration: 341.682767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:26.512115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.170056Z","time spent":"342.050258ms","remote":"127.0.0.1:37266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/monitoring/loki-memcached-results-cache\" "} {"level":"warn","ts":"2026-04-16T03:49:26.512329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.575289ms","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-16T03:49:26.512369Z","caller":"traceutil/trace.go:171","msg":"trace[1575219718] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2765; }","duration":"483.673491ms","start":"2026-04-16T03:49:26.028684Z","end":"2026-04-16T03:49:26.512357Z","steps":["trace[1575219718] 'agreement among raft nodes before linearized reading' (duration: 483.608869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:26.512399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.028652Z","time spent":"483.739183ms","remote":"127.0.0.1:38802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T03:49:26.512613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.783663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/ingress-nginx/ingress-nginx-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:49:26.512648Z","caller":"traceutil/trace.go:171","msg":"trace[575535454] range","detail":"{range_begin:/registry/rolebindings/ingress-nginx/ingress-nginx-admission; range_end:; response_count:0; response_revision:2765; }","duration":"335.853835ms","start":"2026-04-16T03:49:26.176785Z","end":"2026-04-16T03:49:26.512639Z","steps":["trace[575535454] 'agreement among raft nodes before linearized reading' (duration: 335.798083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:26.512675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.176766Z","time spent":"335.902877ms","remote":"127.0.0.1:37284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings/ingress-nginx/ingress-nginx-admission\" "} {"level":"warn","ts":"2026-04-16T03:49:27.224688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.216444ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:49:27.224808Z","caller":"traceutil/trace.go:171","msg":"trace[2064264336] linearizableReadLoop","detail":"{readStateIndex:2903; appliedIndex:2902; }","duration":"689.705222ms","start":"2026-04-16T03:49:26.535084Z","end":"2026-04-16T03:49:27.224789Z","steps":["trace[2064264336] 'read index received' (duration: 348.319122ms)","trace[2064264336] 'applied index is now lower than readState.Index' (duration: 341.38476ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:27.224904Z","caller":"traceutil/trace.go:171","msg":"trace[763631048] transaction","detail":"{read_only:false; response_revision:2766; number_of_response:1; }","duration":"690.01144ms","start":"2026-04-16T03:49:26.534828Z","end":"2026-04-16T03:49:27.224839Z","steps":["trace[763631048] 'process raft request' (duration: 348.554789ms)","trace[763631048] 'compare' (duration: 340.981098ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:27.22497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.850296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/loki-memberlist\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:49:27.225058Z","caller":"traceutil/trace.go:171","msg":"trace[727635861] range","detail":"{range_begin:/registry/services/specs/monitoring/loki-memberlist; range_end:; response_count:0; response_revision:2766; }","duration":"689.965589ms","start":"2026-04-16T03:49:26.535072Z","end":"2026-04-16T03:49:27.225037Z","steps":["trace[727635861] 'agreement among raft nodes before linearized reading' (duration: 689.786514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:27.225081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.534812Z","time spent":"690.182354ms","remote":"127.0.0.1:37154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:27.225102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.535067Z","time spent":"690.02755ms","remote":"127.0.0.1:37144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/monitoring/loki-memberlist\" "} {"level":"info","ts":"2026-04-16T03:49:27.228064Z","caller":"traceutil/trace.go:171","msg":"trace[2095034011] transaction","detail":"{read_only:false; response_revision:2767; number_of_response:1; }","duration":"692.800707ms","start":"2026-04-16T03:49:26.535244Z","end":"2026-04-16T03:49:27.228045Z","steps":["trace[2095034011] 'process raft request' (duration: 692.51618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:27.22816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.535239Z","time spent":"692.87085ms","remote":"127.0.0.1:37154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T03:49:27.228371Z","caller":"traceutil/trace.go:171","msg":"trace[1456501170] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"693.073095ms","start":"2026-04-16T03:49:26.535286Z","end":"2026-04-16T03:49:27.228359Z","steps":["trace[1456501170] 'process raft request' (duration: 692.602352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:27.228429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.53528Z","time spent":"693.123326ms","remote":"127.0.0.1:37154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":953,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:27.228646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.165786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:49:27.228919Z","caller":"traceutil/trace.go:171","msg":"trace[919340903] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"662.643717ms","start":"2026-04-16T03:49:26.566261Z","end":"2026-04-16T03:49:27.228905Z","steps":["trace[919340903] 'process raft request' (duration: 661.803413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:27.229003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.566215Z","time spent":"662.741389ms","remote":"127.0.0.1:37048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105407,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:49:27.229261Z","caller":"traceutil/trace.go:171","msg":"trace[446984054] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"530.1862ms","start":"2026-04-16T03:49:26.699064Z","end":"2026-04-16T03:49:27.22925Z","steps":["trace[446984054] 'process raft request' (duration: 529.306514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:27.229327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.699036Z","time spent":"530.257842ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:27.229296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.337884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-16T03:49:27.229415Z","caller":"traceutil/trace.go:171","msg":"trace[1992144850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2770; }","duration":"669.508018ms","start":"2026-04-16T03:49:26.559876Z","end":"2026-04-16T03:49:27.229384Z","steps":["trace[1992144850] 'agreement among raft nodes before linearized reading' (duration: 669.178039ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:27.228747Z","caller":"traceutil/trace.go:171","msg":"trace[1613844551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2770; }","duration":"579.341542ms","start":"2026-04-16T03:49:26.64938Z","end":"2026-04-16T03:49:27.228722Z","steps":["trace[1613844551] 'agreement among raft nodes before linearized reading' (duration: 579.188407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:27.229468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.306288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-16T03:49:27.229476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.559857Z","time spent":"669.60655ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T03:49:27.229522Z","caller":"traceutil/trace.go:171","msg":"trace[750870286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2770; }","duration":"580.408781ms","start":"2026-04-16T03:49:26.649095Z","end":"2026-04-16T03:49:27.229504Z","steps":["trace[750870286] 'agreement among raft nodes before linearized reading' (duration: 580.238136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:27.229521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.649347Z","time spent":"580.157424ms","remote":"127.0.0.1:36982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T03:49:27.229563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:26.649064Z","time spent":"580.491193ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-16T03:49:28.917079Z","caller":"traceutil/trace.go:171","msg":"trace[499550548] transaction","detail":"{read_only:false; response_revision:3008; number_of_response:1; }","duration":"253.629189ms","start":"2026-04-16T03:49:28.663425Z","end":"2026-04-16T03:49:28.917054Z","steps":["trace[499550548] 'process raft request' (duration: 253.478155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:29.574308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.094258ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T03:49:29.574912Z","caller":"traceutil/trace.go:171","msg":"trace[379549714] linearizableReadLoop","detail":"{readStateIndex:3150; appliedIndex:3148; }","duration":"654.133768ms","start":"2026-04-16T03:49:28.920756Z","end":"2026-04-16T03:49:29.57489Z","steps":["trace[379549714] 'read index received' (duration: 354.457173ms)","trace[379549714] 'applied index is now lower than readState.Index' (duration: 299.673865ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:29.574903Z","caller":"traceutil/trace.go:171","msg":"trace[1224547269] transaction","detail":"{read_only:false; response_revision:3009; number_of_response:1; }","duration":"720.112461ms","start":"2026-04-16T03:49:28.854754Z","end":"2026-04-16T03:49:29.574867Z","steps":["trace[1224547269] 'process raft request' (duration: 719.870184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:29.575042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:28.854717Z","time spent":"720.259475ms","remote":"127.0.0.1:38698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1689,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:29.575194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.406896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-5r4sq\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-16T03:49:29.57527Z","caller":"traceutil/trace.go:171","msg":"trace[289680963] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-5r4sq; range_end:; response_count:1; response_revision:3010; }","duration":"654.530629ms","start":"2026-04-16T03:49:28.920721Z","end":"2026-04-16T03:49:29.575252Z","steps":["trace[289680963] 'agreement among raft nodes before linearized reading' (duration: 654.262242ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:29.57526Z","caller":"traceutil/trace.go:171","msg":"trace[2325573] transaction","detail":"{read_only:false; response_revision:3010; number_of_response:1; }","duration":"520.277603ms","start":"2026-04-16T03:49:29.054936Z","end":"2026-04-16T03:49:29.575214Z","steps":["trace[2325573] 'process raft request' (duration: 519.80337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:29.57531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:28.920706Z","time spent":"654.596922ms","remote":"127.0.0.1:37134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":4220,"request content":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-5r4sq\" "} {"level":"info","ts":"2026-04-16T03:49:29.575417Z","caller":"traceutil/trace.go:171","msg":"trace[2135294446] transaction","detail":"{read_only:false; response_revision:3012; number_of_response:1; }","duration":"339.775864ms","start":"2026-04-16T03:49:29.235627Z","end":"2026-04-16T03:49:29.575403Z","steps":["trace[2135294446] 'process raft request' (duration: 339.580129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:29.57542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.054907Z","time spent":"520.436177ms","remote":"127.0.0.1:43420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2920,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:29.575508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.235605Z","time spent":"339.851996ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:29.575715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.985238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:11517"} {"level":"info","ts":"2026-04-16T03:49:29.575743Z","caller":"traceutil/trace.go:171","msg":"trace[2144265593] transaction","detail":"{read_only:false; response_revision:3013; number_of_response:1; }","duration":"319.773795ms","start":"2026-04-16T03:49:29.255958Z","end":"2026-04-16T03:49:29.575731Z","steps":["trace[2144265593] 'process raft request' (duration: 319.382545ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:29.575794Z","caller":"traceutil/trace.go:171","msg":"trace[777343678] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:3013; }","duration":"604.101462ms","start":"2026-04-16T03:49:28.971671Z","end":"2026-04-16T03:49:29.575773Z","steps":["trace[777343678] 'agreement among raft nodes before linearized reading' (duration: 603.759042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:29.575803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.255946Z","time spent":"319.831958ms","remote":"127.0.0.1:43420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3016,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:29.575808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.978646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-16T03:49:29.575853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:28.971653Z","time spent":"604.185334ms","remote":"127.0.0.1:37120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":11540,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" "} {"level":"warn","ts":"2026-04-16T03:49:29.575862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.505117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-16T03:49:29.575908Z","caller":"traceutil/trace.go:171","msg":"trace[1095729445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3013; }","duration":"332.105689ms","start":"2026-04-16T03:49:29.243772Z","end":"2026-04-16T03:49:29.575878Z","steps":["trace[1095729445] 'agreement among raft nodes before linearized reading' (duration: 331.982786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:29.575989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.211372ms","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-16T03:49:29.576035Z","caller":"traceutil/trace.go:171","msg":"trace[1815125155] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3013; }","duration":"332.285204ms","start":"2026-04-16T03:49:29.243739Z","end":"2026-04-16T03:49:29.576024Z","steps":["trace[1815125155] 'agreement among raft nodes before linearized reading' (duration: 332.1389ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:29.576Z","caller":"traceutil/trace.go:171","msg":"trace[239389536] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3013; }","duration":"291.6302ms","start":"2026-04-16T03:49:29.28434Z","end":"2026-04-16T03:49:29.57597Z","steps":["trace[239389536] 'agreement among raft nodes before linearized reading' (duration: 291.485816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:29.576075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.243721Z","time spent":"332.346576ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T03:49:29.575998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.243747Z","time spent":"332.225673ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T03:49:29.575937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.387673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-16T03:49:29.575263Z","caller":"traceutil/trace.go:171","msg":"trace[690799164] transaction","detail":"{read_only:false; response_revision:3011; number_of_response:1; }","duration":"503.622248ms","start":"2026-04-16T03:49:29.071627Z","end":"2026-04-16T03:49:29.575249Z","steps":["trace[690799164] 'process raft request' (duration: 503.503685ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:29.576252Z","caller":"traceutil/trace.go:171","msg":"trace[328569214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3013; }","duration":"334.721523ms","start":"2026-04-16T03:49:29.241512Z","end":"2026-04-16T03:49:29.576233Z","steps":["trace[328569214] 'agreement among raft nodes before linearized reading' (duration: 334.383953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:29.576348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.241484Z","time spent":"334.845407ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T03:49:29.576475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.071614Z","time spent":"504.707429ms","remote":"127.0.0.1:37106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:30.007057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.906645ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T03:49:30.007193Z","caller":"traceutil/trace.go:171","msg":"trace[928594516] transaction","detail":"{read_only:false; response_revision:3014; number_of_response:1; }","duration":"426.568086ms","start":"2026-04-16T03:49:29.580604Z","end":"2026-04-16T03:49:30.007172Z","steps":["trace[928594516] 'process raft request' (duration: 195.445165ms)","trace[928594516] 'compare' (duration: 230.772212ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:30.00726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.580575Z","time spent":"426.656639ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:49:30.009395Z","caller":"traceutil/trace.go:171","msg":"trace[256582480] transaction","detail":"{read_only:false; response_revision:3016; number_of_response:1; }","duration":"427.338938ms","start":"2026-04-16T03:49:29.582014Z","end":"2026-04-16T03:49:30.009353Z","steps":["trace[256582480] 'process raft request' (duration: 427.224395ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:30.009658Z","caller":"traceutil/trace.go:171","msg":"trace[1240976633] transaction","detail":"{read_only:false; response_revision:3017; number_of_response:1; }","duration":"427.599635ms","start":"2026-04-16T03:49:29.582038Z","end":"2026-04-16T03:49:30.009638Z","steps":["trace[1240976633] 'process raft request' (duration: 427.264536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.009667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.582001Z","time spent":"427.531003ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:30.00976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.582016Z","time spent":"427.693668ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:49:30.009805Z","caller":"traceutil/trace.go:171","msg":"trace[690682708] transaction","detail":"{read_only:false; response_revision:3018; number_of_response:1; }","duration":"426.718871ms","start":"2026-04-16T03:49:29.583046Z","end":"2026-04-16T03:49:30.009765Z","steps":["trace[690682708] 'process raft request' (duration: 426.442643ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:30.009914Z","caller":"traceutil/trace.go:171","msg":"trace[1804345988] linearizableReadLoop","detail":"{readStateIndex:3160; appliedIndex:3154; }","duration":"426.165535ms","start":"2026-04-16T03:49:29.583729Z","end":"2026-04-16T03:49:30.009894Z","steps":["trace[1804345988] 'read index received' (duration: 192.294118ms)","trace[1804345988] 'applied index is now lower than readState.Index' (duration: 233.870477ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:30.009982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.58303Z","time spent":"426.859975ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:49:30.010025Z","caller":"traceutil/trace.go:171","msg":"trace[2087003537] transaction","detail":"{read_only:false; response_revision:3020; number_of_response:1; }","duration":"425.197988ms","start":"2026-04-16T03:49:29.584817Z","end":"2026-04-16T03:49:30.010015Z","steps":["trace[2087003537] 'process raft request' (duration: 425.022533ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:30.010099Z","caller":"traceutil/trace.go:171","msg":"trace[1147225377] transaction","detail":"{read_only:false; response_revision:3019; number_of_response:1; }","duration":"426.583837ms","start":"2026-04-16T03:49:29.583502Z","end":"2026-04-16T03:49:30.010086Z","steps":["trace[1147225377] 'process raft request' (duration: 426.105433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.010158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.584799Z","time spent":"425.26017ms","remote":"127.0.0.1:37134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4332,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:30.010167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.583495Z","time spent":"426.642279ms","remote":"127.0.0.1:38698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2257,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:30.010301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.573876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11517"} {"level":"info","ts":"2026-04-16T03:49:30.010366Z","caller":"traceutil/trace.go:171","msg":"trace[368809524] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:3020; }","duration":"426.635788ms","start":"2026-04-16T03:49:29.583698Z","end":"2026-04-16T03:49:30.010334Z","steps":["trace[368809524] 'agreement among raft nodes before linearized reading' (duration: 426.472804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.010402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.583689Z","time spent":"426.70642ms","remote":"127.0.0.1:37120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":11540,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-16T03:49:30.010502Z","caller":"traceutil/trace.go:171","msg":"trace[599708745] transaction","detail":"{read_only:false; response_revision:3015; number_of_response:1; }","duration":"427.848463ms","start":"2026-04-16T03:49:29.581549Z","end":"2026-04-16T03:49:30.009397Z","steps":["trace[599708745] 'process raft request' (duration: 427.467642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.01069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.581523Z","time spent":"429.058317ms","remote":"127.0.0.1:37106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1351,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T03:49:30.239456Z","caller":"traceutil/trace.go:171","msg":"trace[323164450] transaction","detail":"{read_only:false; response_revision:3021; number_of_response:1; }","duration":"384.556393ms","start":"2026-04-16T03:49:29.854876Z","end":"2026-04-16T03:49:30.239432Z","steps":["trace[323164450] 'process raft request' (duration: 384.43759ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:30.239499Z","caller":"traceutil/trace.go:171","msg":"trace[349545908] linearizableReadLoop","detail":"{readStateIndex:3162; appliedIndex:3161; }","duration":"229.464365ms","start":"2026-04-16T03:49:30.009984Z","end":"2026-04-16T03:49:30.239448Z","steps":["trace[349545908] 'read index received' (duration: 229.425304ms)","trace[349545908] 'applied index is now lower than readState.Index' (duration: 36.691µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:30.239616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.854844Z","time spent":"384.695717ms","remote":"127.0.0.1:43420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2503,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:30.239797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.562694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:49:30.239851Z","caller":"traceutil/trace.go:171","msg":"trace[352997618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3021; }","duration":"590.700977ms","start":"2026-04-16T03:49:29.649136Z","end":"2026-04-16T03:49:30.239837Z","steps":["trace[352997618] 'agreement among raft nodes before linearized reading' (duration: 590.483961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.239866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.991141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T03:49:30.239961Z","caller":"traceutil/trace.go:171","msg":"trace[491122269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3021; }","duration":"464.161505ms","start":"2026-04-16T03:49:29.775777Z","end":"2026-04-16T03:49:30.239939Z","steps":["trace[491122269] 'agreement among raft nodes before linearized reading' (duration: 463.758084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.239896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.64911Z","time spent":"590.7769ms","remote":"127.0.0.1:36982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T03:49:30.240024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:29.775746Z","time spent":"464.268328ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-16T03:49:30.325381Z","caller":"traceutil/trace.go:171","msg":"trace[2041003376] transaction","detail":"{read_only:false; response_revision:3022; number_of_response:1; }","duration":"310.646151ms","start":"2026-04-16T03:49:30.014707Z","end":"2026-04-16T03:49:30.325353Z","steps":["trace[2041003376] 'process raft request' (duration: 310.455276ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:30.325468Z","caller":"traceutil/trace.go:171","msg":"trace[1600111486] transaction","detail":"{read_only:false; response_revision:3023; number_of_response:1; }","duration":"306.32627ms","start":"2026-04-16T03:49:30.019091Z","end":"2026-04-16T03:49:30.325417Z","steps":["trace[1600111486] 'process raft request' (duration: 306.157355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.325531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.014691Z","time spent":"310.764325ms","remote":"127.0.0.1:37036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":928,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T03:49:30.325576Z","caller":"traceutil/trace.go:171","msg":"trace[59648009] transaction","detail":"{read_only:false; response_revision:3024; number_of_response:1; }","duration":"271.513339ms","start":"2026-04-16T03:49:30.054051Z","end":"2026-04-16T03:49:30.325565Z","steps":["trace[59648009] 'process raft request' (duration: 271.265962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.325649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.793316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:17791"} {"level":"info","ts":"2026-04-16T03:49:30.325708Z","caller":"traceutil/trace.go:171","msg":"trace[726541298] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:3025; }","duration":"311.148576ms","start":"2026-04-16T03:49:30.014546Z","end":"2026-04-16T03:49:30.325694Z","steps":["trace[726541298] 'agreement among raft nodes before linearized reading' (duration: 310.995191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.325711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.01907Z","time spent":"306.515916ms","remote":"127.0.0.1:37120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17777,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:30.325748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.014526Z","time spent":"311.213717ms","remote":"127.0.0.1:37120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":17814,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-16T03:49:30.325498Z","caller":"traceutil/trace.go:171","msg":"trace[656451140] transaction","detail":"{read_only:false; response_revision:3025; number_of_response:1; }","duration":"151.029906ms","start":"2026-04-16T03:49:30.174429Z","end":"2026-04-16T03:49:30.325459Z","steps":["trace[656451140] 'process raft request' (duration: 150.927223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.325861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.925277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/node-feature-discovery-worker-fsb8p\" ","response":"range_response_count:1 size:6492"} {"level":"info","ts":"2026-04-16T03:49:30.325974Z","caller":"traceutil/trace.go:171","msg":"trace[159859588] range","detail":"{range_begin:/registry/pods/monitoring/node-feature-discovery-worker-fsb8p; range_end:; response_count:1; response_revision:3025; }","duration":"312.104722ms","start":"2026-04-16T03:49:30.01384Z","end":"2026-04-16T03:49:30.325945Z","steps":["trace[159859588] 'agreement among raft nodes before linearized reading' (duration: 311.739911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.326046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.013818Z","time spent":"312.211675ms","remote":"127.0.0.1:37134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":6515,"request content":"key:\"/registry/pods/monitoring/node-feature-discovery-worker-fsb8p\" "} {"level":"info","ts":"2026-04-16T03:49:30.6735Z","caller":"traceutil/trace.go:171","msg":"trace[838208981] linearizableReadLoop","detail":"{readStateIndex:3167; appliedIndex:3166; }","duration":"348.078206ms","start":"2026-04-16T03:49:30.325394Z","end":"2026-04-16T03:49:30.673472Z","steps":["trace[838208981] 'read index received' (duration: 346.730879ms)","trace[838208981] 'applied index is now lower than readState.Index' (duration: 1.346217ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:30.673565Z","caller":"traceutil/trace.go:171","msg":"trace[870681518] transaction","detail":"{read_only:false; response_revision:3026; number_of_response:1; }","duration":"428.976254ms","start":"2026-04-16T03:49:30.244569Z","end":"2026-04-16T03:49:30.673545Z","steps":["trace[870681518] 'process raft request' (duration: 427.609386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.673682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.244551Z","time spent":"429.059766ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:30.673746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.905501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:2 size:225435"} {"level":"info","ts":"2026-04-16T03:49:30.673808Z","caller":"traceutil/trace.go:171","msg":"trace[638777020] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:2; response_revision:3026; }","duration":"420.001844ms","start":"2026-04-16T03:49:30.253793Z","end":"2026-04-16T03:49:30.673795Z","steps":["trace[638777020] 'agreement among raft nodes before linearized reading' (duration: 419.729226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.673846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.253784Z","time spent":"420.052045ms","remote":"127.0.0.1:37048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":2,"response size":225458,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"warn","ts":"2026-04-16T03:49:30.673864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.629446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:49:30.673956Z","caller":"traceutil/trace.go:171","msg":"trace[1454186533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3026; }","duration":"432.738289ms","start":"2026-04-16T03:49:30.241195Z","end":"2026-04-16T03:49:30.673933Z","steps":["trace[1454186533] 'agreement among raft nodes before linearized reading' (duration: 432.371958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:30.673996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.241147Z","time spent":"432.841471ms","remote":"127.0.0.1:36986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T03:49:31.213085Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1699} {"level":"warn","ts":"2026-04-16T03:49:31.214092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.795927ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:5"} {"level":"info","ts":"2026-04-16T03:49:31.214236Z","caller":"traceutil/trace.go:171","msg":"trace[1929077579] compact","detail":"{revision:1699; response_revision:3026; }","duration":"885.393004ms","start":"2026-04-16T03:49:30.328826Z","end":"2026-04-16T03:49:31.214219Z","steps":["trace[1929077579] 'process raft request' (duration: 708.450455ms)","trace[1929077579] 'check and update compact revision' (duration: 175.616952ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:49:31.214283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.328806Z","time spent":"885.474486ms","remote":"127.0.0.1:36988","response type":"/etcdserverpb.KV/Compact","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-16T03:49:31.268743Z","caller":"traceutil/trace.go:171","msg":"trace[2130872246] transaction","detail":"{read_only:false; response_revision:3027; number_of_response:1; }","duration":"934.529416ms","start":"2026-04-16T03:49:30.334173Z","end":"2026-04-16T03:49:31.268703Z","steps":["trace[2130872246] 'process raft request' (duration: 880.014244ms)","trace[2130872246] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/events/monitoring/storage-loki-0.18a6b9c7af1487c9; req_size:776; } (duration: 54.313327ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:31.268825Z","caller":"traceutil/trace.go:171","msg":"trace[2056245433] linearizableReadLoop","detail":"{readStateIndex:3172; appliedIndex:3167; }","duration":"595.238655ms","start":"2026-04-16T03:49:30.673576Z","end":"2026-04-16T03:49:31.268814Z","steps":["trace[2056245433] 'read index received' (duration: 363.792354ms)","trace[2056245433] 'applied index is now lower than readState.Index' (duration: 231.445111ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:49:31.268845Z","caller":"traceutil/trace.go:171","msg":"trace[692758046] transaction","detail":"{read_only:false; response_revision:3030; number_of_response:1; }","duration":"614.693608ms","start":"2026-04-16T03:49:30.654129Z","end":"2026-04-16T03:49:31.268822Z","steps":["trace[692758046] 'process raft request' (duration: 614.587555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:31.268884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.334157Z","time spent":"934.663609ms","remote":"127.0.0.1:37036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:31.268949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.231008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T03:49:31.268964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.654103Z","time spent":"614.810832ms","remote":"127.0.0.1:38698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2175,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T03:49:31.26899Z","caller":"traceutil/trace.go:171","msg":"trace[1708863494] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:3031; }","duration":"934.28509ms","start":"2026-04-16T03:49:30.334694Z","end":"2026-04-16T03:49:31.268979Z","steps":["trace[1708863494] 'agreement among raft nodes before linearized reading' (duration: 934.201117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:31.269024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.334655Z","time spent":"934.360972ms","remote":"127.0.0.1:37102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" "} {"level":"info","ts":"2026-04-16T03:49:31.268764Z","caller":"traceutil/trace.go:171","msg":"trace[1644412078] transaction","detail":"{read_only:false; response_revision:3028; number_of_response:1; }","duration":"932.216011ms","start":"2026-04-16T03:49:30.336522Z","end":"2026-04-16T03:49:31.268738Z","steps":["trace[1644412078] 'process raft request' (duration: 932.101288ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:49:31.268835Z","caller":"traceutil/trace.go:171","msg":"trace[95244281] transaction","detail":"{read_only:false; response_revision:3029; number_of_response:1; }","duration":"813.801616ms","start":"2026-04-16T03:49:30.454976Z","end":"2026-04-16T03:49:31.268778Z","steps":["trace[95244281] 'process raft request' (duration: 813.708683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:31.269162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.33651Z","time spent":"932.602332ms","remote":"127.0.0.1:37134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6619,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:49:31.269209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.454945Z","time spent":"814.199717ms","remote":"127.0.0.1:43420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2949,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T03:49:31.269302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.387863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:17791"} {"level":"info","ts":"2026-04-16T03:49:31.26934Z","caller":"traceutil/trace.go:171","msg":"trace[643762500] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:3031; }","duration":"938.455275ms","start":"2026-04-16T03:49:30.330876Z","end":"2026-04-16T03:49:31.269331Z","steps":["trace[643762500] 'agreement among raft nodes before linearized reading' (duration: 938.323652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:31.269367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.33086Z","time spent":"938.500266ms","remote":"127.0.0.1:37120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":17814,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-16T03:49:31.269531Z","caller":"traceutil/trace.go:171","msg":"trace[1292212692] transaction","detail":"{read_only:false; response_revision:3031; number_of_response:1; }","duration":"252.993641ms","start":"2026-04-16T03:49:31.016521Z","end":"2026-04-16T03:49:31.269514Z","steps":["trace[1292212692] 'process raft request' (duration: 252.22696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:31.269664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.707062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:49:31.269702Z","caller":"traceutil/trace.go:171","msg":"trace[1784096379] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3033; }","duration":"588.796715ms","start":"2026-04-16T03:49:30.680897Z","end":"2026-04-16T03:49:31.269694Z","steps":["trace[1784096379] 'agreement among raft nodes before linearized reading' (duration: 588.697853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:31.269725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.680876Z","time spent":"588.844756ms","remote":"127.0.0.1:36982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T03:49:31.269954Z","caller":"traceutil/trace.go:171","msg":"trace[2113951905] transaction","detail":"{read_only:false; response_revision:3032; number_of_response:1; }","duration":"212.060729ms","start":"2026-04-16T03:49:31.057876Z","end":"2026-04-16T03:49:31.269936Z","steps":["trace[2113951905] 'process raft request' (duration: 210.911047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:31.269988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.12779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:2 size:225435"} {"level":"info","ts":"2026-04-16T03:49:31.270026Z","caller":"traceutil/trace.go:171","msg":"trace[723375099] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:2; response_revision:3033; }","duration":"361.222582ms","start":"2026-04-16T03:49:30.908793Z","end":"2026-04-16T03:49:31.270015Z","steps":["trace[723375099] 'agreement among raft nodes before linearized reading' (duration: 361.006026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:49:31.270077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:49:30.90876Z","time spent":"361.306284ms","remote":"127.0.0.1:37048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":2,"response size":225458,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"info","ts":"2026-04-16T03:49:31.287367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1699,"took":"73.46934ms","hash":2654478813,"current-db-size-bytes":28758016,"current-db-size":"29 MB","current-db-size-in-use-bytes":10502144,"current-db-size-in-use":"10 MB"} {"level":"info","ts":"2026-04-16T03:49:31.28741Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2654478813,"revision":1699,"compact-revision":-1} {"level":"info","ts":"2026-04-16T03:54:31.22187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3025} {"level":"info","ts":"2026-04-16T03:54:31.24807Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3025,"took":"24.897106ms","hash":1380167456,"current-db-size-bytes":28758016,"current-db-size":"29 MB","current-db-size-in-use-bytes":25382912,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-16T03:54:31.248136Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1380167456,"revision":3025,"compact-revision":1699} {"level":"info","ts":"2026-04-16T03:55:24.709438Z","caller":"traceutil/trace.go:171","msg":"trace[1659628465] linearizableReadLoop","detail":"{readStateIndex:6890; appliedIndex:6889; }","duration":"363.370973ms","start":"2026-04-16T03:55:24.346037Z","end":"2026-04-16T03:55:24.709408Z","steps":["trace[1659628465] 'read index received' (duration: 361.740387ms)","trace[1659628465] 'applied index is now lower than readState.Index' (duration: 1.629536ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T03:55:24.709483Z","caller":"traceutil/trace.go:171","msg":"trace[784264951] transaction","detail":"{read_only:false; response_revision:6620; number_of_response:1; }","duration":"470.34245ms","start":"2026-04-16T03:55:24.239104Z","end":"2026-04-16T03:55:24.709446Z","steps":["trace[784264951] 'process raft request' (duration: 468.54428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:55:24.709602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.546227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/podmonitors.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:55:24.70966Z","caller":"traceutil/trace.go:171","msg":"trace[298609763] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/podmonitors.monitoring.coreos.com; range_end:; response_count:0; response_revision:6620; }","duration":"363.62518ms","start":"2026-04-16T03:55:24.346004Z","end":"2026-04-16T03:55:24.709629Z","steps":["trace[298609763] 'agreement among raft nodes before linearized reading' (duration: 363.538517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:55:24.709651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:55:24.239087Z","time spent":"470.472974ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156617,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:55:24.709705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:55:24.345986Z","time spent":"363.709612ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/podmonitors.monitoring.coreos.com\" "} {"level":"info","ts":"2026-04-16T03:55:24.713477Z","caller":"traceutil/trace.go:171","msg":"trace[639450369] transaction","detail":"{read_only:false; response_revision:6621; number_of_response:1; }","duration":"367.286201ms","start":"2026-04-16T03:55:24.346169Z","end":"2026-04-16T03:55:24.713455Z","steps":["trace[639450369] 'process raft request' (duration: 367.056564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:55:24.713604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:55:24.346156Z","time spent":"367.398233ms","remote":"127.0.0.1:37470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T03:55:24.714124Z","caller":"traceutil/trace.go:171","msg":"trace[2035375121] transaction","detail":"{read_only:false; response_revision:6622; number_of_response:1; }","duration":"300.030607ms","start":"2026-04-16T03:55:24.414076Z","end":"2026-04-16T03:55:24.714106Z","steps":["trace[2035375121] 'process raft request' (duration: 299.403739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:55:24.714159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.870264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T03:55:24.714194Z","caller":"traceutil/trace.go:171","msg":"trace[2037444207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6622; }","duration":"311.936445ms","start":"2026-04-16T03:55:24.402249Z","end":"2026-04-16T03:55:24.714185Z","steps":["trace[2037444207] 'agreement among raft nodes before linearized reading' (duration: 311.819812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T03:55:24.714214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:55:24.402229Z","time spent":"311.981047ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T03:55:24.714225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T03:55:24.414039Z","time spent":"300.13267ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":278901,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T03:55:24.714417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.192874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:55:24.714514Z","caller":"traceutil/trace.go:171","msg":"trace[1634833866] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:6622; }","duration":"234.343268ms","start":"2026-04-16T03:55:24.480145Z","end":"2026-04-16T03:55:24.714488Z","steps":["trace[1634833866] 'agreement among raft nodes before linearized reading' (duration: 234.173283ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:55:33.774752Z","caller":"traceutil/trace.go:171","msg":"trace[229586820] linearizableReadLoop","detail":"{readStateIndex:6998; appliedIndex:6996; }","duration":"125.590141ms","start":"2026-04-16T03:55:33.649103Z","end":"2026-04-16T03:55:33.774693Z","steps":["trace[229586820] 'read index received' (duration: 118.545556ms)","trace[229586820] 'applied index is now lower than readState.Index' (duration: 7.043465ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T03:55:33.774888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.771696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T03:55:33.774922Z","caller":"traceutil/trace.go:171","msg":"trace[323162593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6726; }","duration":"125.865749ms","start":"2026-04-16T03:55:33.649045Z","end":"2026-04-16T03:55:33.77491Z","steps":["trace[323162593] 'agreement among raft nodes before linearized reading' (duration: 125.789097ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:55:33.775033Z","caller":"traceutil/trace.go:171","msg":"trace[1196909604] transaction","detail":"{read_only:false; response_revision:6725; number_of_response:1; }","duration":"257.219398ms","start":"2026-04-16T03:55:33.517781Z","end":"2026-04-16T03:55:33.775Z","steps":["trace[1196909604] 'process raft request' (duration: 250.806742ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:55:33.775079Z","caller":"traceutil/trace.go:171","msg":"trace[307455656] transaction","detail":"{read_only:false; response_revision:6726; number_of_response:1; }","duration":"159.626258ms","start":"2026-04-16T03:55:33.615406Z","end":"2026-04-16T03:55:33.775032Z","steps":["trace[307455656] 'process raft request' (duration: 159.202286ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:57:45.076869Z","caller":"traceutil/trace.go:171","msg":"trace[1939282676] transaction","detail":"{read_only:false; response_revision:8212; number_of_response:1; }","duration":"219.991359ms","start":"2026-04-16T03:57:44.856845Z","end":"2026-04-16T03:57:45.076837Z","steps":["trace[1939282676] 'process raft request' (duration: 219.762163ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:57:45.414154Z","caller":"traceutil/trace.go:171","msg":"trace[1351978741] transaction","detail":"{read_only:false; response_revision:8214; number_of_response:1; }","duration":"211.974279ms","start":"2026-04-16T03:57:45.202153Z","end":"2026-04-16T03:57:45.414127Z","steps":["trace[1351978741] 'process raft request' (duration: 209.204063ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T03:58:38.790385Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024c3.wal"} {"level":"info","ts":"2026-04-16T03:59:09.008923Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9ef3b4f68930dc2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T03:59:09.016146Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-16T03:59:09.017027Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-16T03:59:31.228612Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6136} {"level":"info","ts":"2026-04-16T03:59:31.307717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6136,"took":"76.791602ms","hash":2919981372,"current-db-size-bytes":51998720,"current-db-size":"52 MB","current-db-size-in-use-bytes":41361408,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-04-16T03:59:31.307817Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2919981372,"revision":6136,"compact-revision":3025} {"level":"info","ts":"2026-04-16T04:04:31.234615Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9894} {"level":"info","ts":"2026-04-16T04:04:31.371504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9894,"took":"133.869895ms","hash":161328177,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":34410496,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-16T04:04:31.371598Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":161328177,"revision":9894,"compact-revision":6136} {"level":"info","ts":"2026-04-16T04:09:31.241495Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13158} {"level":"info","ts":"2026-04-16T04:09:31.361094Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13158,"took":"115.985928ms","hash":368781078,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":33312768,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-16T04:09:31.361183Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":368781078,"revision":13158,"compact-revision":9894} {"level":"info","ts":"2026-04-16T04:11:41.735687Z","caller":"traceutil/trace.go:171","msg":"trace[318441332] transaction","detail":"{read_only:false; response_revision:17142; number_of_response:1; }","duration":"123.926024ms","start":"2026-04-16T04:11:41.61174Z","end":"2026-04-16T04:11:41.735667Z","steps":["trace[318441332] 'process raft request' (duration: 123.584165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:11:49.977219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.447767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-16T04:11:49.977347Z","caller":"traceutil/trace.go:171","msg":"trace[817630377] transaction","detail":"{read_only:false; response_revision:17186; number_of_response:1; }","duration":"146.072019ms","start":"2026-04-16T04:11:49.831254Z","end":"2026-04-16T04:11:49.977326Z","steps":["trace[817630377] 'compare' (duration: 136.323853ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:12:47.867617Z","caller":"traceutil/trace.go:171","msg":"trace[1134693064] transaction","detail":"{read_only:false; response_revision:17677; number_of_response:1; }","duration":"122.140668ms","start":"2026-04-16T04:12:47.745441Z","end":"2026-04-16T04:12:47.867582Z","steps":["trace[1134693064] 'process raft request' (duration: 73.825117ms)","trace[1134693064] 'compare' (duration: 48.147046ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T04:12:48.26944Z","caller":"traceutil/trace.go:171","msg":"trace[1071110912] transaction","detail":"{read_only:false; response_revision:17678; number_of_response:1; }","duration":"251.760101ms","start":"2026-04-16T04:12:48.017651Z","end":"2026-04-16T04:12:48.269411Z","steps":["trace[1071110912] 'process raft request' (duration: 251.564726ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:12:48.269902Z","caller":"traceutil/trace.go:171","msg":"trace[21367649] linearizableReadLoop","detail":"{readStateIndex:18255; appliedIndex:18254; }","duration":"243.32709ms","start":"2026-04-16T04:12:48.026514Z","end":"2026-04-16T04:12:48.269841Z","steps":["trace[21367649] 'read index received' (duration: 242.759785ms)","trace[21367649] 'applied index is now lower than readState.Index' (duration: 564.095µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T04:12:48.270326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.774282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-16T04:12:48.270454Z","caller":"traceutil/trace.go:171","msg":"trace[1732017605] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:17678; }","duration":"243.967017ms","start":"2026-04-16T04:12:48.026464Z","end":"2026-04-16T04:12:48.270431Z","steps":["trace[1732017605] 'agreement among raft nodes before linearized reading' (duration: 243.511315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:48.280099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.321329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-16T04:12:48.280175Z","caller":"traceutil/trace.go:171","msg":"trace[1348045743] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:17679; }","duration":"101.462662ms","start":"2026-04-16T04:12:48.178692Z","end":"2026-04-16T04:12:48.280155Z","steps":["trace[1348045743] 'agreement among raft nodes before linearized reading' (duration: 101.279587ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:12:48.280176Z","caller":"traceutil/trace.go:171","msg":"trace[709940166] transaction","detail":"{read_only:false; response_revision:17679; number_of_response:1; }","duration":"232.818863ms","start":"2026-04-16T04:12:48.047342Z","end":"2026-04-16T04:12:48.280161Z","steps":["trace[709940166] 'process raft request' (duration: 232.481934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:48.280106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.740953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-16T04:12:48.280365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.494533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-16T04:12:48.280408Z","caller":"traceutil/trace.go:171","msg":"trace[117959042] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:17679; }","duration":"101.095153ms","start":"2026-04-16T04:12:48.179301Z","end":"2026-04-16T04:12:48.280396Z","steps":["trace[117959042] 'agreement among raft nodes before linearized reading' (duration: 100.736763ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:12:48.280435Z","caller":"traceutil/trace.go:171","msg":"trace[1489114444] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:17679; }","duration":"101.609427ms","start":"2026-04-16T04:12:48.178807Z","end":"2026-04-16T04:12:48.280416Z","steps":["trace[1489114444] 'agreement among raft nodes before linearized reading' (duration: 101.461192ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:12:48.594063Z","caller":"traceutil/trace.go:171","msg":"trace[1093506151] linearizableReadLoop","detail":"{readStateIndex:18258; appliedIndex:18257; }","duration":"263.609624ms","start":"2026-04-16T04:12:48.330427Z","end":"2026-04-16T04:12:48.594037Z","steps":["trace[1093506151] 'read index received' (duration: 263.403728ms)","trace[1093506151] 'applied index is now lower than readState.Index' (duration: 204.296µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T04:12:48.59413Z","caller":"traceutil/trace.go:171","msg":"trace[606546345] transaction","detail":"{read_only:false; response_revision:17681; number_of_response:1; }","duration":"309.993262ms","start":"2026-04-16T04:12:48.284082Z","end":"2026-04-16T04:12:48.594076Z","steps":["trace[606546345] 'process raft request' (duration: 309.786516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:48.594339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.284057Z","time spent":"310.151666ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T04:12:48.594343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.824501ms","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:6"} {"level":"info","ts":"2026-04-16T04:12:48.594448Z","caller":"traceutil/trace.go:171","msg":"trace[1301705261] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:17681; }","duration":"264.079198ms","start":"2026-04-16T04:12:48.330343Z","end":"2026-04-16T04:12:48.594422Z","steps":["trace[1301705261] 'agreement among raft nodes before linearized reading' (duration: 263.8041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.176718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.800414ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-16T04:12:49.176973Z","caller":"traceutil/trace.go:171","msg":"trace[2070078616] linearizableReadLoop","detail":"{readStateIndex:18259; appliedIndex:18258; }","duration":"582.797199ms","start":"2026-04-16T04:12:48.594141Z","end":"2026-04-16T04:12:49.176938Z","steps":["trace[2070078616] 'read index received' (duration: 245.727476ms)","trace[2070078616] 'applied index is now lower than readState.Index' (duration: 337.063233ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T04:12:49.177191Z","caller":"traceutil/trace.go:171","msg":"trace[880638804] transaction","detail":"{read_only:false; response_revision:17682; number_of_response:1; }","duration":"396.141287ms","start":"2026-04-16T04:12:48.78103Z","end":"2026-04-16T04:12:49.177171Z","steps":["trace[880638804] 'process raft request' (duration: 395.985363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.177328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.780985Z","time spent":"396.26294ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T04:12:49.17736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.531307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-16T04:12:49.17739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.287632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-16T04:12:49.177462Z","caller":"traceutil/trace.go:171","msg":"trace[93670035] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:17682; }","duration":"647.66193ms","start":"2026-04-16T04:12:48.529783Z","end":"2026-04-16T04:12:49.177445Z","steps":["trace[93670035] 'agreement among raft nodes before linearized reading' (duration: 647.496755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.177486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.970691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-16T04:12:49.177578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.544582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-16T04:12:49.1776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.536542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-16T04:12:49.177533Z","caller":"traceutil/trace.go:171","msg":"trace[2113826448] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:17682; }","duration":"650.478477ms","start":"2026-04-16T04:12:48.527023Z","end":"2026-04-16T04:12:49.177502Z","steps":["trace[2113826448] 'agreement among raft nodes before linearized reading' (duration: 650.116957ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:12:49.177613Z","caller":"traceutil/trace.go:171","msg":"trace[651999117] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:17682; }","duration":"503.591463ms","start":"2026-04-16T04:12:48.674013Z","end":"2026-04-16T04:12:49.177605Z","steps":["trace[651999117] 'agreement among raft nodes before linearized reading' (duration: 503.542802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.177616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.488487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-04-16T04:12:49.17764Z","caller":"traceutil/trace.go:171","msg":"trace[346371928] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:17682; }","duration":"503.578873ms","start":"2026-04-16T04:12:48.674047Z","end":"2026-04-16T04:12:49.177625Z","steps":["trace[346371928] 'agreement among raft nodes before linearized reading' (duration: 503.474991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.177658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.674007Z","time spent":"503.645675ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"warn","ts":"2026-04-16T04:12:49.177686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.609901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-16T04:12:49.177735Z","caller":"traceutil/trace.go:171","msg":"trace[173664674] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:17682; }","duration":"504.704773ms","start":"2026-04-16T04:12:48.673019Z","end":"2026-04-16T04:12:49.177724Z","steps":["trace[173664674] 'agreement among raft nodes before linearized reading' (duration: 504.635591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.177766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.12373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-04-16T04:12:49.177758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.827054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-16T04:12:49.177813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.527012Z","time spent":"650.646971ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"info","ts":"2026-04-16T04:12:49.177843Z","caller":"traceutil/trace.go:171","msg":"trace[184239260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17682; }","duration":"121.253064ms","start":"2026-04-16T04:12:49.056572Z","end":"2026-04-16T04:12:49.177826Z","steps":["trace[184239260] 'agreement among raft nodes before linearized reading' (duration: 121.010057ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:12:49.177909Z","caller":"traceutil/trace.go:171","msg":"trace[1950307558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17682; }","duration":"108.990918ms","start":"2026-04-16T04:12:49.068855Z","end":"2026-04-16T04:12:49.177845Z","steps":["trace[1950307558] 'agreement among raft nodes before linearized reading' (duration: 108.643219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.177456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.463808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"warn","ts":"2026-04-16T04:12:49.17779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.673006Z","time spent":"504.772295ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"info","ts":"2026-04-16T04:12:49.177989Z","caller":"traceutil/trace.go:171","msg":"trace[1694380845] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:17682; }","duration":"647.091635ms","start":"2026-04-16T04:12:48.530884Z","end":"2026-04-16T04:12:49.177976Z","steps":["trace[1694380845] 'agreement among raft nodes before linearized reading' (duration: 646.380596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.177201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.107533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-16T04:12:49.177691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.674043Z","time spent":"503.639755ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5030,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"warn","ts":"2026-04-16T04:12:49.177528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.830612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-16T04:12:49.178186Z","caller":"traceutil/trace.go:171","msg":"trace[89428964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17682; }","duration":"121.537261ms","start":"2026-04-16T04:12:49.056636Z","end":"2026-04-16T04:12:49.178174Z","steps":["trace[89428964] 'agreement among raft nodes before linearized reading' (duration: 120.709209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.177531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.529774Z","time spent":"647.744052ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"info","ts":"2026-04-16T04:12:49.177615Z","caller":"traceutil/trace.go:171","msg":"trace[498194512] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:17682; }","duration":"651.163626ms","start":"2026-04-16T04:12:48.526428Z","end":"2026-04-16T04:12:49.177592Z","steps":["trace[498194512] 'agreement among raft nodes before linearized reading' (duration: 650.979772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.178296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.526401Z","time spent":"651.881885ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"info","ts":"2026-04-16T04:12:49.177686Z","caller":"traceutil/trace.go:171","msg":"trace[762786366] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17682; }","duration":"100.594059ms","start":"2026-04-16T04:12:49.077071Z","end":"2026-04-16T04:12:49.177665Z","steps":["trace[762786366] 'agreement among raft nodes before linearized reading' (duration: 100.298091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.178053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.530835Z","time spent":"647.203788ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5030,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"warn","ts":"2026-04-16T04:12:49.178491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.732442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-16T04:12:49.178562Z","caller":"traceutil/trace.go:171","msg":"trace[132903541] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:17682; }","duration":"506.169774ms","start":"2026-04-16T04:12:48.67237Z","end":"2026-04-16T04:12:49.17854Z","steps":["trace[132903541] 'agreement among raft nodes before linearized reading' (duration: 504.89055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.178608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.672347Z","time spent":"506.248836ms","remote":"127.0.0.1:37180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"info","ts":"2026-04-16T04:12:49.178696Z","caller":"traceutil/trace.go:171","msg":"trace[447755375] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:17681; }","duration":"589.026037ms","start":"2026-04-16T04:12:48.589006Z","end":"2026-04-16T04:12:49.178032Z","steps":["trace[447755375] 'agreement among raft nodes before linearized reading' (duration: 588.112343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.178745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:48.588981Z","time spent":"589.747137ms","remote":"127.0.0.1:46728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true "} {"level":"warn","ts":"2026-04-16T04:12:49.490624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.836135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-16T04:12:49.491046Z","caller":"traceutil/trace.go:171","msg":"trace[1113342383] transaction","detail":"{read_only:false; response_revision:17683; number_of_response:1; }","duration":"307.983688ms","start":"2026-04-16T04:12:49.183006Z","end":"2026-04-16T04:12:49.490989Z","steps":["trace[1113342383] 'process raft request' (duration: 30.686109ms)","trace[1113342383] 'compare' (duration: 276.580808ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T04:12:49.491243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:49.182955Z","time spent":"308.246064ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T04:12:49.660024Z","caller":"traceutil/trace.go:171","msg":"trace[224451841] transaction","detail":"{read_only:false; response_revision:17685; number_of_response:1; }","duration":"475.473634ms","start":"2026-04-16T04:12:49.184463Z","end":"2026-04-16T04:12:49.659937Z","steps":["trace[224451841] 'process raft request' (duration: 475.337281ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:12:49.660054Z","caller":"traceutil/trace.go:171","msg":"trace[438412201] transaction","detail":"{read_only:false; response_revision:17684; number_of_response:1; }","duration":"476.821471ms","start":"2026-04-16T04:12:49.183201Z","end":"2026-04-16T04:12:49.660023Z","steps":["trace[438412201] 'process raft request' (duration: 476.04207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.660406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:49.183116Z","time spent":"477.195791ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T04:12:49.660611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:49.184444Z","time spent":"475.709651ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T04:12:49.660079Z","caller":"traceutil/trace.go:171","msg":"trace[930281487] transaction","detail":"{read_only:false; response_revision:17686; number_of_response:1; }","duration":"475.273619ms","start":"2026-04-16T04:12:49.184701Z","end":"2026-04-16T04:12:49.659974Z","steps":["trace[930281487] 'process raft request' (duration: 475.148646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T04:12:49.660823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T04:12:49.184676Z","time spent":"476.04889ms","remote":"127.0.0.1:37200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T04:14:31.248576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15903} {"level":"info","ts":"2026-04-16T04:14:31.365157Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15903,"took":"113.114326ms","hash":3911416878,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":35627008,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-04-16T04:14:31.3653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3911416878,"revision":15903,"compact-revision":13158} {"level":"info","ts":"2026-04-16T04:15:49.333974Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9ef3b4f68930dc2","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T04:15:49.339701Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-04-16T04:15:49.339782Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-04-16T04:16:30.740006Z","caller":"traceutil/trace.go:171","msg":"trace[1245643333] transaction","detail":"{read_only:false; response_revision:19683; number_of_response:1; }","duration":"102.343602ms","start":"2026-04-16T04:16:30.637636Z","end":"2026-04-16T04:16:30.73998Z","steps":["trace[1245643333] 'process raft request' (duration: 101.823638ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:19:31.254692Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18720} {"level":"info","ts":"2026-04-16T04:19:31.394395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18720,"took":"135.525258ms","hash":1870719040,"current-db-size-bytes":57806848,"current-db-size":"58 MB","current-db-size-in-use-bytes":42889216,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-04-16T04:19:31.394488Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1870719040,"revision":18720,"compact-revision":15903} {"level":"info","ts":"2026-04-16T04:20:25.077119Z","caller":"traceutil/trace.go:171","msg":"trace[1959340560] transaction","detail":"{read_only:false; response_revision:22529; number_of_response:1; }","duration":"123.631572ms","start":"2026-04-16T04:20:24.953458Z","end":"2026-04-16T04:20:25.077089Z","steps":["trace[1959340560] 'process raft request' (duration: 116.826287ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T04:24:31.263763Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21937} {"level":"info","ts":"2026-04-16T04:24:31.409779Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21937,"took":"139.820361ms","hash":492375822,"current-db-size-bytes":58650624,"current-db-size":"59 MB","current-db-size-in-use-bytes":33996800,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-16T04:24:31.409844Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":492375822,"revision":21937,"compact-revision":18720} {"level":"info","ts":"2026-04-16T04:28:28.337536Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006990.wal"} {"level":"info","ts":"2026-04-16T04:29:31.271335Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24435} {"level":"info","ts":"2026-04-16T04:29:31.413994Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24435,"took":"137.338908ms","hash":1743316674,"current-db-size-bytes":58650624,"current-db-size":"59 MB","current-db-size-in-use-bytes":32595968,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-16T04:29:31.414076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1743316674,"revision":24435,"compact-revision":21937} {"level":"info","ts":"2026-04-16T04:34:31.278289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26667} {"level":"info","ts":"2026-04-16T04:34:31.401092Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26667,"took":"119.111996ms","hash":1367409622,"current-db-size-bytes":58650624,"current-db-size":"59 MB","current-db-size-in-use-bytes":33411072,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-16T04:34:31.401156Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1367409622,"revision":26667,"compact-revision":24435} {"level":"info","ts":"2026-04-16T04:34:58.706376Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9ef3b4f68930dc2","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-16T04:34:58.710771Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-04-16T04:34:58.711033Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}