{"level":"warn","ts":"2026-04-21T17:11:43.093754Z","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-21T17:11:43.093878Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.192:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.192:2380","--initial-cluster=instance=https://199.19.213.192:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.192:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.192: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-21T17:11:43.093967Z","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-21T17:11:43.09403Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.192:2380"]} {"level":"info","ts":"2026-04-21T17:11:43.094113Z","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-21T17:11:43.094889Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"]} {"level":"info","ts":"2026-04-21T17:11:43.095028Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.192:2380"],"listen-peer-urls":["https://199.19.213.192:2380"],"advertise-client-urls":["https://199.19.213.192:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.192: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-21T17:11:43.099372Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.093645ms"} {"level":"info","ts":"2026-04-21T17:11:43.104608Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"341a3703c39c1f5b","cluster-id":"65341987fa712ba2"} {"level":"info","ts":"2026-04-21T17:11:43.104675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T17:11:43.104694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became follower at term 0"} {"level":"info","ts":"2026-04-21T17:11:43.104854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 341a3703c39c1f5b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T17:11:43.104867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became follower at term 1"} {"level":"info","ts":"2026-04-21T17:11:43.104899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=(3754373728672948059)"} {"level":"warn","ts":"2026-04-21T17:11:43.11306Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T17:11:43.115807Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T17:11:43.117416Z","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-21T17:11:43.120457Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"341a3703c39c1f5b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T17:11:43.120849Z","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-21T17:11:43.120996Z","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-21T17:11:43.121022Z","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-21T17:11:43.120897Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"341a3703c39c1f5b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T17:11:43.121591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=(3754373728672948059)"} {"level":"info","ts":"2026-04-21T17:11:43.12208Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65341987fa712ba2","local-member-id":"341a3703c39c1f5b","added-peer-id":"341a3703c39c1f5b","added-peer-peer-urls":["https://199.19.213.192:2380"]} {"level":"info","ts":"2026-04-21T17:11:43.126331Z","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-21T17:11:43.126514Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.192:2380"} {"level":"info","ts":"2026-04-21T17:11:43.126639Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.192:2380"} {"level":"info","ts":"2026-04-21T17:11:43.126936Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"341a3703c39c1f5b","initial-advertise-peer-urls":["https://199.19.213.192:2380"],"listen-peer-urls":["https://199.19.213.192:2380"],"advertise-client-urls":["https://199.19.213.192:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T17:11:43.126987Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T17:11:43.405472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T17:11:43.405549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T17:11:43.405585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b received MsgPreVoteResp from 341a3703c39c1f5b at term 1"} {"level":"info","ts":"2026-04-21T17:11:43.405607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became candidate at term 2"} {"level":"info","ts":"2026-04-21T17:11:43.40562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b received MsgVoteResp from 341a3703c39c1f5b at term 2"} {"level":"info","ts":"2026-04-21T17:11:43.405674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became leader at term 2"} {"level":"info","ts":"2026-04-21T17:11:43.405695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 341a3703c39c1f5b elected leader 341a3703c39c1f5b at term 2"} {"level":"info","ts":"2026-04-21T17:11:43.406742Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"341a3703c39c1f5b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.192:2379]}","request-path":"/0/members/341a3703c39c1f5b/attributes","cluster-id":"65341987fa712ba2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T17:11:43.406899Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:11:43.406937Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:11:43.40707Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:11:43.40945Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65341987fa712ba2","local-member-id":"341a3703c39c1f5b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:11:43.409551Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:11:43.409584Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:11:43.40988Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T17:11:43.410326Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T17:11:43.410395Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T17:11:43.410522Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.192:2379"} {"level":"info","ts":"2026-04-21T17:12:02.172203Z","caller":"traceutil/trace.go:171","msg":"trace[699515715] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"270.10418ms","start":"2026-04-21T17:12:01.902074Z","end":"2026-04-21T17:12:02.172178Z","steps":["trace[699515715] 'process raft request' (duration: 269.976517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:02.498143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.465599ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-21T17:12:02.934391Z","caller":"traceutil/trace.go:171","msg":"trace[568925386] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"221.838819ms","start":"2026-04-21T17:12:02.712516Z","end":"2026-04-21T17:12:02.934354Z","steps":["trace[568925386] 'process raft request' (duration: 221.642363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:14.63412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.534551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:14.634231Z","caller":"traceutil/trace.go:171","msg":"trace[995344211] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:513; }","duration":"297.738787ms","start":"2026-04-21T17:12:14.33647Z","end":"2026-04-21T17:12:14.634208Z","steps":["trace[995344211] 'range keys from in-memory index tree' (duration: 297.443009ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:21.1344Z","caller":"traceutil/trace.go:171","msg":"trace[300935858] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"220.402376ms","start":"2026-04-21T17:12:20.913969Z","end":"2026-04-21T17:12:21.134371Z","steps":["trace[300935858] 'read index received' (duration: 219.622274ms)","trace[300935858] 'applied index is now lower than readState.Index' (duration: 778.922µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:21.134451Z","caller":"traceutil/trace.go:171","msg":"trace[29341350] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"369.168502ms","start":"2026-04-21T17:12:20.765255Z","end":"2026-04-21T17:12:21.134424Z","steps":["trace[29341350] 'process raft request' (duration: 368.527224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:21.13474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.743626ms","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-21T17:12:21.134853Z","caller":"traceutil/trace.go:171","msg":"trace[1455473519] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"220.891649ms","start":"2026-04-21T17:12:20.913933Z","end":"2026-04-21T17:12:21.134825Z","steps":["trace[1455473519] 'agreement among raft nodes before linearized reading' (duration: 220.579301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:21.135135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.765207Z","time spent":"369.325296ms","remote":"127.0.0.1:60564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:21.266162Z","caller":"traceutil/trace.go:171","msg":"trace[2033946430] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"120.566754ms","start":"2026-04-21T17:12:21.145563Z","end":"2026-04-21T17:12:21.26613Z","steps":["trace[2033946430] 'process raft request' (duration: 104.617896ms)","trace[2033946430] 'compare' (duration: 15.819734ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:21.56619Z","caller":"traceutil/trace.go:171","msg":"trace[538428] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"410.632396ms","start":"2026-04-21T17:12:21.155522Z","end":"2026-04-21T17:12:21.566154Z","steps":["trace[538428] 'process raft request' (duration: 335.62643ms)","trace[538428] 'compare' (duration: 74.508302ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:21.566472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.155504Z","time spent":"410.862543ms","remote":"127.0.0.1:60654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:21.566259Z","caller":"traceutil/trace.go:171","msg":"trace[399454348] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"366.980841ms","start":"2026-04-21T17:12:21.199252Z","end":"2026-04-21T17:12:21.566232Z","steps":["trace[399454348] 'process raft request' (duration: 366.60254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:21.566744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.199224Z","time spent":"367.449434ms","remote":"127.0.0.1:60810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:12:22.280079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.816526ms","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-21T17:12:22.280196Z","caller":"traceutil/trace.go:171","msg":"trace[495856670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"589.95961ms","start":"2026-04-21T17:12:21.690175Z","end":"2026-04-21T17:12:22.280135Z","steps":["trace[495856670] 'range keys from in-memory index tree' (duration: 589.657282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:22.280241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.690155Z","time spent":"590.075993ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T17:12:22.295788Z","caller":"traceutil/trace.go:171","msg":"trace[327571751] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"182.110612ms","start":"2026-04-21T17:12:22.113656Z","end":"2026-04-21T17:12:22.295767Z","steps":["trace[327571751] 'read index received' (duration: 180.228379ms)","trace[327571751] 'applied index is now lower than readState.Index' (duration: 1.881273ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:22.296013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.342028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:22.296038Z","caller":"traceutil/trace.go:171","msg":"trace[1600012979] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"290.633238ms","start":"2026-04-21T17:12:22.00537Z","end":"2026-04-21T17:12:22.296003Z","steps":["trace[1600012979] 'process raft request' (duration: 288.753305ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:22.296225Z","caller":"traceutil/trace.go:171","msg":"trace[831075144] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"182.603465ms","start":"2026-04-21T17:12:22.113606Z","end":"2026-04-21T17:12:22.296147Z","steps":["trace[831075144] 'agreement among raft nodes before linearized reading' (duration: 182.318167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:38.25208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.885082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:38.252178Z","caller":"traceutil/trace.go:171","msg":"trace[558583695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:784; }","duration":"137.058207ms","start":"2026-04-21T17:12:38.115101Z","end":"2026-04-21T17:12:38.252159Z","steps":["trace[558583695] 'range keys from in-memory index tree' (duration: 136.78825ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:38.488329Z","caller":"traceutil/trace.go:171","msg":"trace[2049531501] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"228.347759ms","start":"2026-04-21T17:12:38.259953Z","end":"2026-04-21T17:12:38.488301Z","steps":["trace[2049531501] 'process raft request' (duration: 228.169184ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:13.982734Z","caller":"traceutil/trace.go:171","msg":"trace[1237794881] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"266.282724ms","start":"2026-04-21T17:13:13.716417Z","end":"2026-04-21T17:13:13.982699Z","steps":["trace[1237794881] 'process raft request' (duration: 265.991216ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:39.850424Z","caller":"traceutil/trace.go:171","msg":"trace[1391298219] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"100.908345ms","start":"2026-04-21T17:13:39.749494Z","end":"2026-04-21T17:13:39.850402Z","steps":["trace[1391298219] 'process raft request' (duration: 100.753501ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:40.37121Z","caller":"traceutil/trace.go:171","msg":"trace[86091944] linearizableReadLoop","detail":"{readStateIndex:1136; appliedIndex:1135; }","duration":"256.684863ms","start":"2026-04-21T17:13:40.114484Z","end":"2026-04-21T17:13:40.371169Z","steps":["trace[86091944] 'read index received' (duration: 170.763309ms)","trace[86091944] 'applied index is now lower than readState.Index' (duration: 85.919584ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:40.371446Z","caller":"traceutil/trace.go:171","msg":"trace[1116624205] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"273.103523ms","start":"2026-04-21T17:13:40.098323Z","end":"2026-04-21T17:13:40.371427Z","steps":["trace[1116624205] 'process raft request' (duration: 186.988634ms)","trace[1116624205] 'compare' (duration: 85.676547ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:40.371734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.874097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T17:13:40.371847Z","caller":"traceutil/trace.go:171","msg":"trace[764512430] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1091; }","duration":"215.078273ms","start":"2026-04-21T17:13:40.156742Z","end":"2026-04-21T17:13:40.37182Z","steps":["trace[764512430] 'agreement among raft nodes before linearized reading' (duration: 214.776485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:40.371869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.979217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:13:40.37201Z","caller":"traceutil/trace.go:171","msg":"trace[1234018482] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1091; }","duration":"101.224114ms","start":"2026-04-21T17:13:40.270768Z","end":"2026-04-21T17:13:40.371992Z","steps":["trace[1234018482] 'agreement among raft nodes before linearized reading' (duration: 100.934896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:40.372045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.278282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:40.3721Z","caller":"traceutil/trace.go:171","msg":"trace[2061851994] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1091; }","duration":"160.380924ms","start":"2026-04-21T17:13:40.211706Z","end":"2026-04-21T17:13:40.372087Z","steps":["trace[2061851994] 'agreement among raft nodes before linearized reading' (duration: 160.288142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:40.372388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.869526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:40.372466Z","caller":"traceutil/trace.go:171","msg":"trace[326804013] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1091; }","duration":"258.01751ms","start":"2026-04-21T17:13:40.114431Z","end":"2026-04-21T17:13:40.372449Z","steps":["trace[326804013] 'agreement among raft nodes before linearized reading' (duration: 257.864036ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:42.164135Z","caller":"traceutil/trace.go:171","msg":"trace[847473338] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"227.571935ms","start":"2026-04-21T17:13:41.936538Z","end":"2026-04-21T17:13:42.16411Z","steps":["trace[847473338] 'process raft request' (duration: 227.306258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:42.521397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.432396ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:13:42.521728Z","caller":"traceutil/trace.go:171","msg":"trace[442159261] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"427.916845ms","start":"2026-04-21T17:13:42.093786Z","end":"2026-04-21T17:13:42.521703Z","steps":["trace[442159261] 'process raft request' (duration: 270.983425ms)","trace[442159261] 'compare' (duration: 156.092567ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:42.521815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:42.093752Z","time spent":"428.022528ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:13:42.521898Z","caller":"traceutil/trace.go:171","msg":"trace[387653571] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1140; }","duration":"408.118932ms","start":"2026-04-21T17:13:42.113724Z","end":"2026-04-21T17:13:42.521843Z","steps":["trace[387653571] 'read index received' (duration: 50.281818ms)","trace[387653571] 'applied index is now lower than readState.Index' (duration: 357.833723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:42.555158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.365177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-21T17:13:42.555213Z","caller":"traceutil/trace.go:171","msg":"trace[1981084440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1097; }","duration":"178.45973ms","start":"2026-04-21T17:13:42.37674Z","end":"2026-04-21T17:13:42.5552Z","steps":["trace[1981084440] 'agreement among raft nodes before linearized reading' (duration: 178.303076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:42.555222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.467465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:42.555307Z","caller":"traceutil/trace.go:171","msg":"trace[47010002] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1097; }","duration":"441.593579ms","start":"2026-04-21T17:13:42.113689Z","end":"2026-04-21T17:13:42.555283Z","steps":["trace[47010002] 'agreement among raft nodes before linearized reading' (duration: 408.316737ms)","trace[47010002] 'range keys from in-memory index tree' (duration: 33.144339ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:42.555365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:42.113648Z","time spent":"441.708292ms","remote":"127.0.0.1:60462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:13:42.555381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.803356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-21T17:13:42.555439Z","caller":"traceutil/trace.go:171","msg":"trace[1638037029] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1097; }","duration":"118.885658ms","start":"2026-04-21T17:13:42.436536Z","end":"2026-04-21T17:13:42.555422Z","steps":["trace[1638037029] 'agreement among raft nodes before linearized reading' (duration: 118.704963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:13.063932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.224178ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-21T17:14:13.064346Z","caller":"traceutil/trace.go:171","msg":"trace[1476606878] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1314; }","duration":"743.065531ms","start":"2026-04-21T17:14:12.32126Z","end":"2026-04-21T17:14:13.064325Z","steps":["trace[1476606878] 'read index received' (duration: 173.530415ms)","trace[1476606878] 'applied index is now lower than readState.Index' (duration: 569.533586ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:13.06465Z","caller":"traceutil/trace.go:171","msg":"trace[1941965621] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"434.164367ms","start":"2026-04-21T17:14:12.630444Z","end":"2026-04-21T17:14:13.064608Z","steps":["trace[1941965621] 'process raft request' (duration: 433.644283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:13.0651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:12.630408Z","time spent":"434.525067ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:14:13.182834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.824119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-21T17:14:13.18293Z","caller":"traceutil/trace.go:171","msg":"trace[50090311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1262; }","duration":"136.953213ms","start":"2026-04-21T17:14:13.045951Z","end":"2026-04-21T17:14:13.182904Z","steps":["trace[50090311] 'agreement among raft nodes before linearized reading' (duration: 18.706312ms)","trace[50090311] 'range keys from in-memory index tree' (duration: 118.004584ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:13.18295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.007365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-5hv5h\" ","response":"range_response_count:1 size:11061"} {"level":"info","ts":"2026-04-21T17:14:13.182996Z","caller":"traceutil/trace.go:171","msg":"trace[1936200364] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-5hv5h; range_end:; response_count:1; response_revision:1262; }","duration":"637.069417ms","start":"2026-04-21T17:14:12.545909Z","end":"2026-04-21T17:14:13.182978Z","steps":["trace[1936200364] 'agreement among raft nodes before linearized reading' (duration: 518.634181ms)","trace[1936200364] 'range keys from in-memory index tree' (duration: 118.318643ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:13.183026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:12.545892Z","time spent":"637.126589ms","remote":"127.0.0.1:60654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11083,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-5hv5h\" "} {"level":"warn","ts":"2026-04-21T17:14:13.183036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.951184ms","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-21T17:14:13.183149Z","caller":"traceutil/trace.go:171","msg":"trace[592474574] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1262; }","duration":"360.139239ms","start":"2026-04-21T17:14:12.822986Z","end":"2026-04-21T17:14:13.183126Z","steps":["trace[592474574] 'agreement among raft nodes before linearized reading' (duration: 241.678493ms)","trace[592474574] 'range keys from in-memory index tree' (duration: 118.124657ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:13.182843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.475167ms","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-21T17:14:13.183204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:12.822964Z","time spent":"360.227051ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-21T17:14:13.183216Z","caller":"traceutil/trace.go:171","msg":"trace[243639314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1262; }","duration":"414.884029ms","start":"2026-04-21T17:14:12.768302Z","end":"2026-04-21T17:14:13.183186Z","steps":["trace[243639314] 'agreement among raft nodes before linearized reading' (duration: 296.374791ms)","trace[243639314] 'range keys from in-memory index tree' (duration: 118.024645ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:13.183219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.93329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-21T17:14:13.183275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:12.768284Z","time spent":"414.976852ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:14:13.183328Z","caller":"traceutil/trace.go:171","msg":"trace[639098315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1262; }","duration":"862.100774ms","start":"2026-04-21T17:14:12.321199Z","end":"2026-04-21T17:14:13.1833Z","steps":["trace[639098315] 'agreement among raft nodes before linearized reading' (duration: 743.253537ms)","trace[639098315] 'range keys from in-memory index tree' (duration: 118.605611ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:13.183364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.49409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-21T17:14:13.183425Z","caller":"traceutil/trace.go:171","msg":"trace[612544608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1262; }","duration":"140.561952ms","start":"2026-04-21T17:14:13.04284Z","end":"2026-04-21T17:14:13.183402Z","steps":["trace[612544608] 'agreement among raft nodes before linearized reading' (duration: 21.798477ms)","trace[612544608] 'range keys from in-memory index tree' (duration: 118.678833ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:13.183372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:12.321157Z","time spent":"862.205037ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T17:14:13.434546Z","caller":"traceutil/trace.go:171","msg":"trace[645965602] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"165.080814ms","start":"2026-04-21T17:14:13.269447Z","end":"2026-04-21T17:14:13.434528Z","steps":["trace[645965602] 'process raft request' (duration: 165.041233ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:13.4348Z","caller":"traceutil/trace.go:171","msg":"trace[26254128] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"169.797113ms","start":"2026-04-21T17:14:13.264961Z","end":"2026-04-21T17:14:13.434758Z","steps":["trace[26254128] 'process raft request' (duration: 169.414713ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:15.36701Z","caller":"traceutil/trace.go:171","msg":"trace[1256878651] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"103.616639ms","start":"2026-04-21T17:14:15.263364Z","end":"2026-04-21T17:14:15.36698Z","steps":["trace[1256878651] 'read index received' (duration: 65.276708ms)","trace[1256878651] 'applied index is now lower than readState.Index' (duration: 38.338511ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:15.367163Z","caller":"traceutil/trace.go:171","msg":"trace[950543813] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"149.564708ms","start":"2026-04-21T17:14:15.217583Z","end":"2026-04-21T17:14:15.367148Z","steps":["trace[950543813] 'process raft request' (duration: 111.049763ms)","trace[950543813] 'compare' (duration: 38.205947ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:15.367358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.75689ms","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-21T17:14:15.367459Z","caller":"traceutil/trace.go:171","msg":"trace[1301503529] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1273; }","duration":"100.890954ms","start":"2026-04-21T17:14:15.266546Z","end":"2026-04-21T17:14:15.367437Z","steps":["trace[1301503529] 'agreement among raft nodes before linearized reading' (duration: 100.648488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:15.367805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.419651ms","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-21T17:14:15.367898Z","caller":"traceutil/trace.go:171","msg":"trace[859009468] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1273; }","duration":"104.568015ms","start":"2026-04-21T17:14:15.263308Z","end":"2026-04-21T17:14:15.367876Z","steps":["trace[859009468] 'agreement among raft nodes before linearized reading' (duration: 104.299028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:15.721464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.29301ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:14:15.721538Z","caller":"traceutil/trace.go:171","msg":"trace[190099642] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"347.394239ms","start":"2026-04-21T17:14:15.374132Z","end":"2026-04-21T17:14:15.721526Z","steps":["trace[190099642] 'process raft request' (duration: 235.977326ms)","trace[190099642] 'compare' (duration: 111.215698ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:14:15.721572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:15.374099Z","time spent":"347.458271ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:14:15.729429Z","caller":"traceutil/trace.go:171","msg":"trace[1154325552] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"354.790492ms","start":"2026-04-21T17:14:15.37462Z","end":"2026-04-21T17:14:15.729411Z","steps":["trace[1154325552] 'process raft request' (duration: 354.611278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:15.729556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:15.374589Z","time spent":"354.899086ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:14:15.729844Z","caller":"traceutil/trace.go:171","msg":"trace[1857098736] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"355.104051ms","start":"2026-04-21T17:14:15.374731Z","end":"2026-04-21T17:14:15.729835Z","steps":["trace[1857098736] 'process raft request' (duration: 354.608227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:15.729884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:15.374708Z","time spent":"355.157492ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:14:15.730257Z","caller":"traceutil/trace.go:171","msg":"trace[1348771831] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"355.571623ms","start":"2026-04-21T17:14:15.374679Z","end":"2026-04-21T17:14:15.73025Z","steps":["trace[1348771831] 'process raft request' (duration: 355.123021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:15.730297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:14:15.374643Z","time spent":"355.635015ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:14:28.91892Z","caller":"traceutil/trace.go:171","msg":"trace[1870403265] linearizableReadLoop","detail":"{readStateIndex:1425; appliedIndex:1424; }","duration":"181.588337ms","start":"2026-04-21T17:14:28.737307Z","end":"2026-04-21T17:14:28.918896Z","steps":["trace[1870403265] 'read index received' (duration: 181.415162ms)","trace[1870403265] 'applied index is now lower than readState.Index' (duration: 172.105µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:14:28.919183Z","caller":"traceutil/trace.go:171","msg":"trace[1009932522] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"230.215067ms","start":"2026-04-21T17:14:28.688905Z","end":"2026-04-21T17:14:28.91912Z","steps":["trace[1009932522] 'process raft request' (duration: 229.828107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:14:28.919406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.07221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-21T17:14:28.919494Z","caller":"traceutil/trace.go:171","msg":"trace[1444577628] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1368; }","duration":"182.175413ms","start":"2026-04-21T17:14:28.737302Z","end":"2026-04-21T17:14:28.919478Z","steps":["trace[1444577628] 'agreement among raft nodes before linearized reading' (duration: 181.69393ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:14:29.051732Z","caller":"traceutil/trace.go:171","msg":"trace[1481646973] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"127.440516ms","start":"2026-04-21T17:14:28.924266Z","end":"2026-04-21T17:14:29.051706Z","steps":["trace[1481646973] 'process raft request' (duration: 102.118343ms)","trace[1481646973] 'compare' (duration: 25.20413ms)"],"step_count":2}