{"level":"warn","ts":"2026-04-02T17:46:32.485784Z","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-02T17:46:32.485871Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-02T17:46:32.485937Z","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-02T17:46:32.48595Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]}
{"level":"info","ts":"2026-04-02T17:46:32.485967Z","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-02T17:46:32.486625Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]}
{"level":"info","ts":"2026-04-02T17:46:32.4867Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-02T17:46:32.491172Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.22733ms"}
{"level":"info","ts":"2026-04-02T17:46:32.497691Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"}
{"level":"info","ts":"2026-04-02T17:46:32.497769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"}
{"level":"info","ts":"2026-04-02T17:46:32.497795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"}
{"level":"info","ts":"2026-04-02T17:46:32.497813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-02T17:46:32.497821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"}
{"level":"info","ts":"2026-04-02T17:46:32.497856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"}
{"level":"warn","ts":"2026-04-02T17:46:32.506487Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-02T17:46:32.507994Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-02T17:46:32.509027Z","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-02T17:46:32.511119Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-02T17:46:32.511301Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-02T17:46:32.511373Z","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-02T17:46:32.511548Z","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-02T17:46:32.51156Z","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-02T17:46:32.513428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"}
{"level":"info","ts":"2026-04-02T17:46:32.514111Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]}
{"level":"info","ts":"2026-04-02T17:46:32.515487Z","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-02T17:46:32.515661Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"}
{"level":"info","ts":"2026-04-02T17:46:32.515727Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"}
{"level":"info","ts":"2026-04-02T17:46:32.51579Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-02T17:46:32.515845Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-02T17:46:32.698909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"}
{"level":"info","ts":"2026-04-02T17:46:32.698984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-02T17:46:32.699028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"}
{"level":"info","ts":"2026-04-02T17:46:32.699058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"}
{"level":"info","ts":"2026-04-02T17:46:32.699071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"}
{"level":"info","ts":"2026-04-02T17:46:32.699089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"}
{"level":"info","ts":"2026-04-02T17:46:32.699109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"}
{"level":"info","ts":"2026-04-02T17:46:32.700494Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-02T17:46:32.700698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-02T17:46:32.700702Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-02T17:46:32.700826Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-02T17:46:32.701795Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-02T17:46:32.701948Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-02T17:46:32.701966Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-02T17:46:32.701998Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-02T17:46:32.702062Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-02T17:46:32.703964Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-02T17:46:32.705054Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"}
{"level":"info","ts":"2026-04-02T17:46:50.789617Z","caller":"traceutil/trace.go:171","msg":"trace[1165072545] linearizableReadLoop","detail":"{readStateIndex:462; appliedIndex:461; }","duration":"135.578329ms","start":"2026-04-02T17:46:50.654015Z","end":"2026-04-02T17:46:50.789593Z","steps":["trace[1165072545] 'read index received'  (duration: 135.470146ms)","trace[1165072545] 'applied index is now lower than readState.Index'  (duration: 106.723µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:46:50.789777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.751432ms","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-02T17:46:50.789748Z","caller":"traceutil/trace.go:171","msg":"trace[95337829] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"295.369023ms","start":"2026-04-02T17:46:50.494324Z","end":"2026-04-02T17:46:50.789693Z","steps":["trace[95337829] 'process raft request'  (duration: 295.107227ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:46:50.789867Z","caller":"traceutil/trace.go:171","msg":"trace[980822032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:448; }","duration":"135.891966ms","start":"2026-04-02T17:46:50.653961Z","end":"2026-04-02T17:46:50.789853Z","steps":["trace[980822032] 'agreement among raft nodes before linearized reading'  (duration: 135.752022ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:46:56.053161Z","caller":"traceutil/trace.go:171","msg":"trace[1942083141] linearizableReadLoop","detail":"{readStateIndex:475; appliedIndex:474; }","duration":"193.568646ms","start":"2026-04-02T17:46:55.859567Z","end":"2026-04-02T17:46:56.053135Z","steps":["trace[1942083141] 'read index received'  (duration: 193.371852ms)","trace[1942083141] 'applied index is now lower than readState.Index'  (duration: 195.834µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:46:56.053228Z","caller":"traceutil/trace.go:171","msg":"trace[796601555] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"209.478993ms","start":"2026-04-02T17:46:55.843709Z","end":"2026-04-02T17:46:56.053188Z","steps":["trace[796601555] 'process raft request'  (duration: 209.302389ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:46:56.05331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.7341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:46:56.053372Z","caller":"traceutil/trace.go:171","msg":"trace[1410763191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:460; }","duration":"193.858602ms","start":"2026-04-02T17:46:55.8595Z","end":"2026-04-02T17:46:56.053359Z","steps":["trace[1410763191] 'agreement among raft nodes before linearized reading'  (duration: 193.7629ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:46:56.053425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.702415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-04-02T17:46:56.053511Z","caller":"traceutil/trace.go:171","msg":"trace[78688730] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:460; }","duration":"104.832778ms","start":"2026-04-02T17:46:55.948657Z","end":"2026-04-02T17:46:56.05349Z","steps":["trace[78688730] 'agreement among raft nodes before linearized reading'  (duration: 104.664115ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:47:10.002764Z","caller":"traceutil/trace.go:171","msg":"trace[395582831] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"140.598819ms","start":"2026-04-02T17:47:09.862143Z","end":"2026-04-02T17:47:10.002742Z","steps":["trace[395582831] 'read index received'  (duration: 139.890972ms)","trace[395582831] 'applied index is now lower than readState.Index'  (duration: 706.867µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:47:10.002885Z","caller":"traceutil/trace.go:171","msg":"trace[1712657856] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"205.125161ms","start":"2026-04-02T17:47:09.797681Z","end":"2026-04-02T17:47:10.002806Z","steps":["trace[1712657856] 'process raft request'  (duration: 204.576767ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:47:10.00295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.792023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:47:10.003195Z","caller":"traceutil/trace.go:171","msg":"trace[1022383385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"141.10573ms","start":"2026-04-02T17:47:09.862075Z","end":"2026-04-02T17:47:10.003181Z","steps":["trace[1022383385] 'agreement among raft nodes before linearized reading'  (duration: 140.753732ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:47:10.429527Z","caller":"traceutil/trace.go:171","msg":"trace[202036675] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"411.401438ms","start":"2026-04-02T17:47:10.018095Z","end":"2026-04-02T17:47:10.429497Z","steps":["trace[202036675] 'process raft request'  (duration: 346.040457ms)","trace[202036675] 'compare'  (duration: 65.173837ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:47:10.430226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:10.018069Z","time spent":"411.545781ms","remote":"127.0.0.1:58560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-v4qrx\" mod_revision:504 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-v4qrx\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-v4qrx\" > >"}
{"level":"info","ts":"2026-04-02T17:47:10.458205Z","caller":"traceutil/trace.go:171","msg":"trace[1956729228] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:639; }","duration":"346.209609ms","start":"2026-04-02T17:47:10.111972Z","end":"2026-04-02T17:47:10.458182Z","steps":["trace[1956729228] 'read index received'  (duration: 252.237908ms)","trace[1956729228] 'applied index is now lower than readState.Index'  (duration: 93.970791ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:47:10.458533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.558018ms","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-02T17:47:10.458574Z","caller":"traceutil/trace.go:171","msg":"trace[93090028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"346.635669ms","start":"2026-04-02T17:47:10.111927Z","end":"2026-04-02T17:47:10.458563Z","steps":["trace[93090028] 'agreement among raft nodes before linearized reading'  (duration: 346.332762ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:47:10.458604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:10.111914Z","time spent":"346.682771ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-02T17:47:10.458525Z","caller":"traceutil/trace.go:171","msg":"trace[348944019] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"395.346556ms","start":"2026-04-02T17:47:10.062923Z","end":"2026-04-02T17:47:10.458269Z","steps":["trace[348944019] 'process raft request'  (duration: 395.163562ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:47:10.459014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:10.062891Z","time spent":"395.881279ms","remote":"127.0.0.1:58724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"warn","ts":"2026-04-02T17:47:11.258679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.064458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:47:11.258773Z","caller":"traceutil/trace.go:171","msg":"trace[1846014536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"397.218501ms","start":"2026-04-02T17:47:10.861534Z","end":"2026-04-02T17:47:11.258752Z","steps":["trace[1846014536] 'range keys from in-memory index tree'  (duration: 396.981286ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:47:11.258823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:10.861511Z","time spent":"397.301154ms","remote":"127.0.0.1:58384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-02T17:47:11.270902Z","caller":"traceutil/trace.go:171","msg":"trace[1452279297] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"299.160523ms","start":"2026-04-02T17:47:10.971721Z","end":"2026-04-02T17:47:11.270882Z","steps":["trace[1452279297] 'read index received'  (duration: 298.063138ms)","trace[1452279297] 'applied index is now lower than readState.Index'  (duration: 1.096535ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:47:11.271013Z","caller":"traceutil/trace.go:171","msg":"trace[1540560177] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"403.505321ms","start":"2026-04-02T17:47:10.867464Z","end":"2026-04-02T17:47:11.270969Z","steps":["trace[1540560177] 'process raft request'  (duration: 402.618641ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:47:11.271621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.65403ms","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-02T17:47:11.271704Z","caller":"traceutil/trace.go:171","msg":"trace[945842088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"295.765963ms","start":"2026-04-02T17:47:10.975905Z","end":"2026-04-02T17:47:11.271671Z","steps":["trace[945842088] 'agreement among raft nodes before linearized reading'  (duration: 295.093386ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:47:11.27176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.496394ms","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-02T17:47:11.271898Z","caller":"traceutil/trace.go:171","msg":"trace[1715353724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:622; }","duration":"294.686318ms","start":"2026-04-02T17:47:10.977154Z","end":"2026-04-02T17:47:11.27184Z","steps":["trace[1715353724] 'agreement among raft nodes before linearized reading'  (duration: 293.994911ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:47:11.271869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:10.867384Z","time spent":"403.703075ms","remote":"127.0.0.1:58464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:618 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036209 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-04-02T17:47:11.271928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.185648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-02T17:47:11.272099Z","caller":"traceutil/trace.go:171","msg":"trace[798990556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"300.411934ms","start":"2026-04-02T17:47:10.971645Z","end":"2026-04-02T17:47:11.272057Z","steps":["trace[798990556] 'agreement among raft nodes before linearized reading'  (duration: 299.325937ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:47:11.27219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:10.971623Z","time spent":"300.531116ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-04-02T17:47:27.322881Z","caller":"traceutil/trace.go:171","msg":"trace[1044751876] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"206.91324ms","start":"2026-04-02T17:47:27.11593Z","end":"2026-04-02T17:47:27.322843Z","steps":["trace[1044751876] 'process raft request'  (duration: 206.651414ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:47:58.891899Z","caller":"traceutil/trace.go:171","msg":"trace[181668769] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"184.14838ms","start":"2026-04-02T17:47:58.707725Z","end":"2026-04-02T17:47:58.891873Z","steps":["trace[181668769] 'process raft request'  (duration: 183.581086ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:47:59.229583Z","caller":"traceutil/trace.go:171","msg":"trace[440898492] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"333.911943ms","start":"2026-04-02T17:47:58.895621Z","end":"2026-04-02T17:47:59.229533Z","steps":["trace[440898492] 'process raft request'  (duration: 313.688355ms)","trace[440898492] 'compare'  (duration: 20.107965ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:47:59.229776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:47:58.895603Z","time spent":"334.065017ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1198 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-02T17:48:23.930984Z","caller":"traceutil/trace.go:171","msg":"trace[1463139702] transaction","detail":"{read_only:false; response_revision:1505; number_of_response:1; }","duration":"106.035876ms","start":"2026-04-02T17:48:23.824928Z","end":"2026-04-02T17:48:23.930963Z","steps":["trace[1463139702] 'process raft request'  (duration: 105.558814ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:48:37.581264Z","caller":"traceutil/trace.go:171","msg":"trace[219161077] transaction","detail":"{read_only:false; response_revision:1754; number_of_response:1; }","duration":"132.451737ms","start":"2026-04-02T17:48:37.448787Z","end":"2026-04-02T17:48:37.581239Z","steps":["trace[219161077] 'process raft request'  (duration: 132.281043ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:48:47.319991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.566939ms","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-02T17:48:47.320092Z","caller":"traceutil/trace.go:171","msg":"trace[1610101873] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1886; }","duration":"152.729233ms","start":"2026-04-02T17:48:47.167344Z","end":"2026-04-02T17:48:47.320074Z","steps":["trace[1610101873] 'range keys from in-memory index tree'  (duration: 152.331413ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:48:47.94708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.052033ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300925424 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1864 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:48:47.947183Z","caller":"traceutil/trace.go:171","msg":"trace[1330312410] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1955; }","duration":"143.41092ms","start":"2026-04-02T17:48:47.803755Z","end":"2026-04-02T17:48:47.947166Z","steps":["trace[1330312410] 'read index received'  (duration: 40.011µs)","trace[1330312410] 'applied index is now lower than readState.Index'  (duration: 143.369859ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:48:47.947247Z","caller":"traceutil/trace.go:171","msg":"trace[2028307889] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"311.459099ms","start":"2026-04-02T17:48:47.635763Z","end":"2026-04-02T17:48:47.947222Z","steps":["trace[2028307889] 'process raft request'  (duration: 111.022456ms)","trace[2028307889] 'compare'  (duration: 199.91607ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:48:47.947352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.603555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"warn","ts":"2026-04-02T17:48:47.947352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:48:47.635752Z","time spent":"311.555611ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1864 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-02T17:48:47.947382Z","caller":"traceutil/trace.go:171","msg":"trace[308935627] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1889; }","duration":"143.674087ms","start":"2026-04-02T17:48:47.803697Z","end":"2026-04-02T17:48:47.947371Z","steps":["trace[308935627] 'agreement among raft nodes before linearized reading'  (duration: 143.555744ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:48:47.947564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.214775ms","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-02T17:48:47.947641Z","caller":"traceutil/trace.go:171","msg":"trace[2134047339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1889; }","duration":"120.339398ms","start":"2026-04-02T17:48:47.827282Z","end":"2026-04-02T17:48:47.947621Z","steps":["trace[2134047339] 'agreement among raft nodes before linearized reading'  (duration: 120.112112ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:48:47.947741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.894392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-02T17:48:47.947994Z","caller":"traceutil/trace.go:171","msg":"trace[1445982722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1889; }","duration":"111.295462ms","start":"2026-04-02T17:48:47.836678Z","end":"2026-04-02T17:48:47.947974Z","steps":["trace[1445982722] 'agreement among raft nodes before linearized reading'  (duration: 110.815851ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:49:33.060078Z","caller":"traceutil/trace.go:171","msg":"trace[1489030540] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2262; }","duration":"227.857569ms","start":"2026-04-02T17:49:32.832198Z","end":"2026-04-02T17:49:33.060056Z","steps":["trace[1489030540] 'read index received'  (duration: 226.685671ms)","trace[1489030540] 'applied index is now lower than readState.Index'  (duration: 1.171178ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:49:33.060198Z","caller":"traceutil/trace.go:171","msg":"trace[296874664] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"290.728964ms","start":"2026-04-02T17:49:32.769421Z","end":"2026-04-02T17:49:33.06015Z","steps":["trace[296874664] 'process raft request'  (duration: 289.472355ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:33.060364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.144736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-04-02T17:49:33.06045Z","caller":"traceutil/trace.go:171","msg":"trace[2065365722] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2186; }","duration":"228.30257ms","start":"2026-04-02T17:49:32.832129Z","end":"2026-04-02T17:49:33.060432Z","steps":["trace[2065365722] 'agreement among raft nodes before linearized reading'  (duration: 228.048644ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:49:38.761203Z","caller":"traceutil/trace.go:171","msg":"trace[1419572852] linearizableReadLoop","detail":"{readStateIndex:2287; appliedIndex:2286; }","duration":"358.446743ms","start":"2026-04-02T17:49:38.402732Z","end":"2026-04-02T17:49:38.761178Z","steps":["trace[1419572852] 'read index received'  (duration: 358.2804ms)","trace[1419572852] 'applied index is now lower than readState.Index'  (duration: 165.253µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:49:38.761281Z","caller":"traceutil/trace.go:171","msg":"trace[1952548702] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"387.002443ms","start":"2026-04-02T17:49:38.374247Z","end":"2026-04-02T17:49:38.76125Z","steps":["trace[1952548702] 'process raft request'  (duration: 386.758377ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:38.761438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.68648ms","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-02T17:49:38.761452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.374231Z","time spent":"387.125008ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2200 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-02T17:49:38.761526Z","caller":"traceutil/trace.go:171","msg":"trace[646992551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2209; }","duration":"358.812833ms","start":"2026-04-02T17:49:38.402696Z","end":"2026-04-02T17:49:38.761509Z","steps":["trace[646992551] 'agreement among raft nodes before linearized reading'  (duration: 358.609838ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:38.761574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.402681Z","time spent":"358.881214ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-02T17:49:39.261472Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680218899300926157,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-02T17:49:39.457481Z","caller":"traceutil/trace.go:171","msg":"trace[702214985] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"1.031085592s","start":"2026-04-02T17:49:38.426365Z","end":"2026-04-02T17:49:39.457451Z","steps":["trace[702214985] 'process raft request'  (duration: 1.030696973s)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:49:39.457688Z","caller":"traceutil/trace.go:171","msg":"trace[1684701842] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"734.704454ms","start":"2026-04-02T17:49:38.722951Z","end":"2026-04-02T17:49:39.457655Z","steps":["trace[1684701842] 'process raft request'  (duration: 734.660633ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:39.457795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.426336Z","time spent":"1.031238056s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:2156 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-04-02T17:49:39.457853Z","caller":"traceutil/trace.go:171","msg":"trace[969572278] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"943.632902ms","start":"2026-04-02T17:49:38.514191Z","end":"2026-04-02T17:49:39.457824Z","steps":["trace[969572278] 'process raft request'  (duration: 943.048858ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:39.457869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.72293Z","time spent":"734.854248ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2206 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-02T17:49:39.457955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.514176Z","time spent":"943.728435ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2204 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-02T17:49:39.458084Z","caller":"traceutil/trace.go:171","msg":"trace[1780974989] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"755.090249ms","start":"2026-04-02T17:49:38.702937Z","end":"2026-04-02T17:49:39.458027Z","steps":["trace[1780974989] 'process raft request'  (duration: 754.573576ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:39.458295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.702912Z","time spent":"755.277453ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2205 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-02T17:49:40.079525Z","caller":"traceutil/trace.go:171","msg":"trace[1175562913] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"1.313554781s","start":"2026-04-02T17:49:38.765944Z","end":"2026-04-02T17:49:40.079499Z","steps":["trace[1175562913] 'process raft request'  (duration: 1.215096679s)","trace[1175562913] 'compare'  (duration: 98.240017ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:49:40.079676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.76592Z","time spent":"1.313680933s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2201 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-02T17:49:40.079798Z","caller":"traceutil/trace.go:171","msg":"trace[1216282534] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"1.20716862s","start":"2026-04-02T17:49:38.872604Z","end":"2026-04-02T17:49:40.079772Z","steps":["trace[1216282534] 'process raft request'  (duration: 1.206836813s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:40.079943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.872583Z","time spent":"1.207284623s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2176 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-04-02T17:49:40.080044Z","caller":"traceutil/trace.go:171","msg":"trace[673837048] linearizableReadLoop","detail":"{readStateIndex:2294; appliedIndex:2287; }","duration":"1.318760053s","start":"2026-04-02T17:49:38.761272Z","end":"2026-04-02T17:49:40.080032Z","steps":["trace[673837048] 'read index received'  (duration: 695.744987ms)","trace[673837048] 'applied index is now lower than readState.Index'  (duration: 623.013966ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:49:40.080199Z","caller":"traceutil/trace.go:171","msg":"trace[1913760193] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"1.002769988s","start":"2026-04-02T17:49:39.077382Z","end":"2026-04-02T17:49:40.080152Z","steps":["trace[1913760193] 'process raft request'  (duration: 1.002306477s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:40.08027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.631108082s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-04-02T17:49:40.080265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.244353614s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T17:49:40.080304Z","caller":"traceutil/trace.go:171","msg":"trace[914186125] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2216; }","duration":"1.631181014s","start":"2026-04-02T17:49:38.449114Z","end":"2026-04-02T17:49:40.080295Z","steps":["trace[914186125] 'agreement among raft nodes before linearized reading'  (duration: 1.63100781s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:40.080288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217466865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T17:49:40.080336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.449092Z","time spent":"1.631236885s","remote":"127.0.0.1:58644","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-02T17:49:40.080352Z","caller":"traceutil/trace.go:171","msg":"trace[2127532460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2216; }","duration":"1.217598908s","start":"2026-04-02T17:49:38.862739Z","end":"2026-04-02T17:49:40.080338Z","steps":["trace[2127532460] 'agreement among raft nodes before linearized reading'  (duration: 1.217483075s)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:49:40.080349Z","caller":"traceutil/trace.go:171","msg":"trace[208091807] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:2216; }","duration":"1.244459087s","start":"2026-04-02T17:49:38.835854Z","end":"2026-04-02T17:49:40.080313Z","steps":["trace[208091807] 'agreement among raft nodes before linearized reading'  (duration: 1.244344004s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:40.08036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:39.077354Z","time spent":"1.002918192s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2207 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-02T17:49:40.080346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.62934519s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-02T17:49:40.080371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.654097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-04-02T17:49:40.080399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.835836Z","time spent":"1.244551369s","remote":"127.0.0.1:51216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"info","ts":"2026-04-02T17:49:40.080433Z","caller":"traceutil/trace.go:171","msg":"trace[385129963] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2216; }","duration":"976.76662ms","start":"2026-04-02T17:49:39.103649Z","end":"2026-04-02T17:49:40.080416Z","steps":["trace[385129963] 'agreement among raft nodes before linearized reading'  (duration: 976.558495ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:49:40.08043Z","caller":"traceutil/trace.go:171","msg":"trace[370782210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2216; }","duration":"1.629464562s","start":"2026-04-02T17:49:38.450949Z","end":"2026-04-02T17:49:40.080413Z","steps":["trace[370782210] 'agreement among raft nodes before linearized reading'  (duration: 1.629171386s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:40.080356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.347586ms","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-02T17:49:40.080463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:39.103628Z","time spent":"976.829281ms","remote":"127.0.0.1:51062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-04-02T17:49:40.080453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.928244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-04-02T17:49:40.080472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.45094Z","time spent":"1.629523774s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-02T17:49:40.080384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:38.862717Z","time spent":"1.21766211s","remote":"127.0.0.1:58384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-02T17:49:40.080508Z","caller":"traceutil/trace.go:171","msg":"trace[591648491] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2216; }","duration":"591.029236ms","start":"2026-04-02T17:49:39.489464Z","end":"2026-04-02T17:49:40.080494Z","steps":["trace[591648491] 'agreement among raft nodes before linearized reading'  (duration: 590.74039ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:49:40.080501Z","caller":"traceutil/trace.go:171","msg":"trace[951600996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2216; }","duration":"486.54147ms","start":"2026-04-02T17:49:39.593943Z","end":"2026-04-02T17:49:40.080484Z","steps":["trace[951600996] 'agreement among raft nodes before linearized reading'  (duration: 486.267814ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:40.080545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:39.489425Z","time spent":"591.111658ms","remote":"127.0.0.1:58890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":280,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T17:49:40.080558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:49:39.593928Z","time spent":"486.615152ms","remote":"127.0.0.1:58644","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-02T17:49:40.247477Z","caller":"traceutil/trace.go:171","msg":"trace[642930400] linearizableReadLoop","detail":"{readStateIndex:2297; appliedIndex:2294; }","duration":"160.260282ms","start":"2026-04-02T17:49:40.087196Z","end":"2026-04-02T17:49:40.247456Z","steps":["trace[642930400] 'read index received'  (duration: 59.766622ms)","trace[642930400] 'applied index is now lower than readState.Index'  (duration: 100.4929ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:49:40.247622Z","caller":"traceutil/trace.go:171","msg":"trace[1492556295] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"162.882014ms","start":"2026-04-02T17:49:40.084712Z","end":"2026-04-02T17:49:40.247594Z","steps":["trace[1492556295] 'process raft request'  (duration: 161.240935ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:49:40.247655Z","caller":"traceutil/trace.go:171","msg":"trace[560114192] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"162.876033ms","start":"2026-04-02T17:49:40.084741Z","end":"2026-04-02T17:49:40.247617Z","steps":["trace[560114192] 'process raft request'  (duration: 162.616457ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:40.247959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.454296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a29b7ada212e09\" ","response":"range_response_count:1 size:846"}
{"level":"info","ts":"2026-04-02T17:49:40.248008Z","caller":"traceutil/trace.go:171","msg":"trace[1591414484] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a29b7ada212e09; range_end:; response_count:1; response_revision:2219; }","duration":"160.512797ms","start":"2026-04-02T17:49:40.087473Z","end":"2026-04-02T17:49:40.247986Z","steps":["trace[1591414484] 'agreement among raft nodes before linearized reading'  (duration: 160.383494ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:49:40.247692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.482887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:49:40.248087Z","caller":"traceutil/trace.go:171","msg":"trace[130182648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2219; }","duration":"160.906577ms","start":"2026-04-02T17:49:40.087159Z","end":"2026-04-02T17:49:40.248066Z","steps":["trace[130182648] 'agreement among raft nodes before linearized reading'  (duration: 160.462507ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:04.49915Z","caller":"traceutil/trace.go:171","msg":"trace[862287005] transaction","detail":"{read_only:false; response_revision:2359; number_of_response:1; }","duration":"145.88372ms","start":"2026-04-02T17:50:04.353233Z","end":"2026-04-02T17:50:04.499117Z","steps":["trace[862287005] 'process raft request'  (duration: 130.884903ms)","trace[862287005] 'compare'  (duration: 14.861253ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:50:04.50299Z","caller":"traceutil/trace.go:171","msg":"trace[937693683] transaction","detail":"{read_only:false; response_revision:2360; number_of_response:1; }","duration":"145.833769ms","start":"2026-04-02T17:50:04.357127Z","end":"2026-04-02T17:50:04.502961Z","steps":["trace[937693683] 'process raft request'  (duration: 145.693476ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:32.622304Z","caller":"traceutil/trace.go:171","msg":"trace[897486497] linearizableReadLoop","detail":"{readStateIndex:2767; appliedIndex:2766; }","duration":"147.092328ms","start":"2026-04-02T17:50:32.475169Z","end":"2026-04-02T17:50:32.622261Z","steps":["trace[897486497] 'read index received'  (duration: 146.649058ms)","trace[897486497] 'applied index is now lower than readState.Index'  (duration: 441.4µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:50:32.622568Z","caller":"traceutil/trace.go:171","msg":"trace[276285811] transaction","detail":"{read_only:false; response_revision:2669; number_of_response:1; }","duration":"212.955837ms","start":"2026-04-02T17:50:32.409568Z","end":"2026-04-02T17:50:32.622524Z","steps":["trace[276285811] 'process raft request'  (duration: 212.389573ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:50:32.622629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.419166ms","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-02T17:50:32.622688Z","caller":"traceutil/trace.go:171","msg":"trace[1224425686] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2669; }","duration":"147.537979ms","start":"2026-04-02T17:50:32.475131Z","end":"2026-04-02T17:50:32.622669Z","steps":["trace[1224425686] 'agreement among raft nodes before linearized reading'  (duration: 147.305004ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:33.276532Z","caller":"traceutil/trace.go:171","msg":"trace[684022782] transaction","detail":"{read_only:false; response_revision:2670; number_of_response:1; }","duration":"650.004894ms","start":"2026-04-02T17:50:32.626465Z","end":"2026-04-02T17:50:33.27647Z","steps":["trace[684022782] 'process raft request'  (duration: 649.81741ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:50:33.27671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:50:32.626448Z","time spent":"650.176618ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2655 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-02T17:50:33.27736Z","caller":"traceutil/trace.go:171","msg":"trace[383063206] transaction","detail":"{read_only:false; response_revision:2672; number_of_response:1; }","duration":"650.26974ms","start":"2026-04-02T17:50:32.627068Z","end":"2026-04-02T17:50:33.277338Z","steps":["trace[383063206] 'process raft request'  (duration: 650.200849ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:50:33.2775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:50:32.627056Z","time spent":"650.378063ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2657 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-02T17:50:33.277414Z","caller":"traceutil/trace.go:171","msg":"trace[563634338] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"650.323911ms","start":"2026-04-02T17:50:32.627051Z","end":"2026-04-02T17:50:33.277375Z","steps":["trace[563634338] 'process raft request'  (duration: 650.116476ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:33.27768Z","caller":"traceutil/trace.go:171","msg":"trace[186367250] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"649.760238ms","start":"2026-04-02T17:50:32.627893Z","end":"2026-04-02T17:50:33.277653Z","steps":["trace[186367250] 'process raft request'  (duration: 649.41337ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:50:33.277711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:50:32.627044Z","time spent":"650.570977ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:2568 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-04-02T17:50:33.27783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:50:32.627873Z","time spent":"649.881681ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2658 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-04-02T17:50:33.277867Z","caller":"traceutil/trace.go:171","msg":"trace[2068243872] transaction","detail":"{read_only:false; response_revision:2674; number_of_response:1; }","duration":"542.620089ms","start":"2026-04-02T17:50:32.735219Z","end":"2026-04-02T17:50:33.277839Z","steps":["trace[2068243872] 'process raft request'  (duration: 542.353263ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:33.277818Z","caller":"traceutil/trace.go:171","msg":"trace[851977880] linearizableReadLoop","detail":"{readStateIndex:2772; appliedIndex:2767; }","duration":"415.938495ms","start":"2026-04-02T17:50:32.861834Z","end":"2026-04-02T17:50:33.277773Z","steps":["trace[851977880] 'read index received'  (duration: 414.47998ms)","trace[851977880] 'applied index is now lower than readState.Index'  (duration: 1.456475ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:50:33.277916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.069829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:50:33.277969Z","caller":"traceutil/trace.go:171","msg":"trace[1975685018] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2674; }","duration":"416.15686ms","start":"2026-04-02T17:50:32.861798Z","end":"2026-04-02T17:50:33.277955Z","steps":["trace[1975685018] 'agreement among raft nodes before linearized reading'  (duration: 416.070398ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:50:33.277992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:50:32.735204Z","time spent":"542.726102ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2551 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-04-02T17:50:33.278029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:50:32.861788Z","time spent":"416.229771ms","remote":"127.0.0.1:58384","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-02T17:50:33.278141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.612407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"warn","ts":"2026-04-02T17:50:33.278131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.51061ms","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-02T17:50:33.278176Z","caller":"traceutil/trace.go:171","msg":"trace[1118754037] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2674; }","duration":"175.667909ms","start":"2026-04-02T17:50:33.102496Z","end":"2026-04-02T17:50:33.278164Z","steps":["trace[1118754037] 'agreement among raft nodes before linearized reading'  (duration: 175.570397ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:33.278188Z","caller":"traceutil/trace.go:171","msg":"trace[146311382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2674; }","duration":"213.570831ms","start":"2026-04-02T17:50:33.064605Z","end":"2026-04-02T17:50:33.278176Z","steps":["trace[146311382] 'agreement among raft nodes before linearized reading'  (duration: 213.399417ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:50:33.278223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.735594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-04-02T17:50:33.27829Z","caller":"traceutil/trace.go:171","msg":"trace[1668042663] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2674; }","duration":"123.837186ms","start":"2026-04-02T17:50:33.154437Z","end":"2026-04-02T17:50:33.278274Z","steps":["trace[1668042663] 'agreement among raft nodes before linearized reading'  (duration: 123.617211ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:39.540784Z","caller":"traceutil/trace.go:171","msg":"trace[101563274] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"223.239031ms","start":"2026-04-02T17:50:39.31751Z","end":"2026-04-02T17:50:39.540749Z","steps":["trace[101563274] 'process raft request'  (duration: 217.991726ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:39.541078Z","caller":"traceutil/trace.go:171","msg":"trace[1171890725] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"222.907673ms","start":"2026-04-02T17:50:39.318144Z","end":"2026-04-02T17:50:39.541052Z","steps":["trace[1171890725] 'process raft request'  (duration: 222.511454ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:50:39.541311Z","caller":"traceutil/trace.go:171","msg":"trace[712394996] linearizableReadLoop","detail":"{readStateIndex:2812; appliedIndex:2810; }","duration":"222.721639ms","start":"2026-04-02T17:50:39.318562Z","end":"2026-04-02T17:50:39.541284Z","steps":["trace[712394996] 'read index received'  (duration: 216.921292ms)","trace[712394996] 'applied index is now lower than readState.Index'  (duration: 5.799117ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:50:39.541394Z","caller":"traceutil/trace.go:171","msg":"trace[1117651665] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"220.376993ms","start":"2026-04-02T17:50:39.320972Z","end":"2026-04-02T17:50:39.541349Z","steps":["trace[1117651665] 'process raft request'  (duration: 219.983894ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:50:39.54154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.946375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:8556"}
{"level":"info","ts":"2026-04-02T17:50:39.541591Z","caller":"traceutil/trace.go:171","msg":"trace[623019651] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2714; }","duration":"223.039656ms","start":"2026-04-02T17:50:39.318539Z","end":"2026-04-02T17:50:39.541578Z","steps":["trace[623019651] 'agreement among raft nodes before linearized reading'  (duration: 222.855512ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:51:06.917954Z","caller":"traceutil/trace.go:171","msg":"trace[1234321032] linearizableReadLoop","detail":"{readStateIndex:2982; appliedIndex:2981; }","duration":"425.132384ms","start":"2026-04-02T17:51:06.492799Z","end":"2026-04-02T17:51:06.917932Z","steps":["trace[1234321032] 'read index received'  (duration: 424.98701ms)","trace[1234321032] 'applied index is now lower than readState.Index'  (duration: 144.284µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:51:06.918079Z","caller":"traceutil/trace.go:171","msg":"trace[1678973090] transaction","detail":"{read_only:false; response_revision:2876; number_of_response:1; }","duration":"482.742145ms","start":"2026-04-02T17:51:06.435325Z","end":"2026-04-02T17:51:06.918068Z","steps":["trace[1678973090] 'process raft request'  (duration: 482.467359ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:06.918177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:06.435302Z","time spent":"482.801257ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2865 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-02T17:51:06.918325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.513764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:51:06.918388Z","caller":"traceutil/trace.go:171","msg":"trace[1209085253] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:2876; }","duration":"425.612435ms","start":"2026-04-02T17:51:06.492759Z","end":"2026-04-02T17:51:06.918372Z","steps":["trace[1209085253] 'agreement among raft nodes before linearized reading'  (duration: 425.516533ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:06.918452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:06.492738Z","time spent":"425.703558ms","remote":"127.0.0.1:50904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T17:51:06.918681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.923444ms","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-02T17:51:06.918771Z","caller":"traceutil/trace.go:171","msg":"trace[168030906] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2876; }","duration":"107.046596ms","start":"2026-04-02T17:51:06.811711Z","end":"2026-04-02T17:51:06.918758Z","steps":["trace[168030906] 'agreement among raft nodes before linearized reading'  (duration: 106.864242ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:06.919192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.802288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T17:51:06.919292Z","caller":"traceutil/trace.go:171","msg":"trace[2125652030] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2876; }","duration":"195.945541ms","start":"2026-04-02T17:51:06.723332Z","end":"2026-04-02T17:51:06.919278Z","steps":["trace[2125652030] 'agreement among raft nodes before linearized reading'  (duration: 195.795098ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:51:07.749376Z","caller":"traceutil/trace.go:171","msg":"trace[1467827379] transaction","detail":"{read_only:false; response_revision:2878; number_of_response:1; }","duration":"251.011541ms","start":"2026-04-02T17:51:07.49834Z","end":"2026-04-02T17:51:07.749351Z","steps":["trace[1467827379] 'process raft request'  (duration: 250.803246ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.542588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.469456ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300927681 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2869 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:51:08.542684Z","caller":"traceutil/trace.go:171","msg":"trace[1304402540] transaction","detail":"{read_only:false; response_revision:2879; number_of_response:1; }","duration":"788.716765ms","start":"2026-04-02T17:51:07.753953Z","end":"2026-04-02T17:51:08.54267Z","steps":["trace[1304402540] 'process raft request'  (duration: 370.100845ms)","trace[1304402540] 'compare'  (duration: 418.374083ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:51:08.542728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.753924Z","time spent":"788.784247ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2869 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-04-02T17:51:08.544493Z","caller":"traceutil/trace.go:171","msg":"trace[394080330] transaction","detail":"{read_only:false; response_revision:2880; number_of_response:1; }","duration":"790.286652ms","start":"2026-04-02T17:51:07.754181Z","end":"2026-04-02T17:51:08.544468Z","steps":["trace[394080330] 'process raft request'  (duration: 789.983055ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.544571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.754165Z","time spent":"790.373304ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2871 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-02T17:51:08.544775Z","caller":"traceutil/trace.go:171","msg":"trace[1791042662] transaction","detail":"{read_only:false; response_revision:2881; number_of_response:1; }","duration":"790.552678ms","start":"2026-04-02T17:51:07.754214Z","end":"2026-04-02T17:51:08.544767Z","steps":["trace[1791042662] 'process raft request'  (duration: 790.099388ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.544819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.754196Z","time spent":"790.601229ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2870 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-02T17:51:08.544915Z","caller":"traceutil/trace.go:171","msg":"trace[559815391] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"736.660517ms","start":"2026-04-02T17:51:07.808213Z","end":"2026-04-02T17:51:08.544873Z","steps":["trace[559815391] 'process raft request'  (duration: 736.418301ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.545137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.808181Z","time spent":"736.82892ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2872 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-02T17:51:08.545163Z","caller":"traceutil/trace.go:171","msg":"trace[679408786] transaction","detail":"{read_only:false; response_revision:2883; number_of_response:1; }","duration":"724.468216ms","start":"2026-04-02T17:51:07.820663Z","end":"2026-04-02T17:51:08.545131Z","steps":["trace[679408786] 'process raft request'  (duration: 724.076237ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.545442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.820648Z","time spent":"724.713992ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2874 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-02T17:51:08.546129Z","caller":"traceutil/trace.go:171","msg":"trace[1749169535] linearizableReadLoop","detail":"{readStateIndex:2990; appliedIndex:2984; }","duration":"690.376316ms","start":"2026-04-02T17:51:07.855731Z","end":"2026-04-02T17:51:08.546107Z","steps":["trace[1749169535] 'read index received'  (duration: 268.410356ms)","trace[1749169535] 'applied index is now lower than readState.Index'  (duration: 421.964009ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:51:08.546203Z","caller":"traceutil/trace.go:171","msg":"trace[1117188850] transaction","detail":"{read_only:false; response_revision:2884; number_of_response:1; }","duration":"725.261725ms","start":"2026-04-02T17:51:07.820924Z","end":"2026-04-02T17:51:08.546185Z","steps":["trace[1117188850] 'process raft request'  (duration: 724.781494ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.546522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.426667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:51:08.546587Z","caller":"traceutil/trace.go:171","msg":"trace[1425253325] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2884; }","duration":"437.556899ms","start":"2026-04-02T17:51:08.109012Z","end":"2026-04-02T17:51:08.546569Z","steps":["trace[1425253325] 'agreement among raft nodes before linearized reading'  (duration: 437.420996ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.546639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:08.108983Z","time spent":"437.643502ms","remote":"127.0.0.1:51076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T17:51:08.546711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.26462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-node-0.18a29b907b3e07cd\" ","response":"range_response_count:1 size:765"}
{"level":"info","ts":"2026-04-02T17:51:08.546785Z","caller":"traceutil/trace.go:171","msg":"trace[2219936] range","detail":"{range_begin:/registry/events/openstack/valkey-node-0.18a29b907b3e07cd; range_end:; response_count:1; response_revision:2884; }","duration":"568.400373ms","start":"2026-04-02T17:51:07.978371Z","end":"2026-04-02T17:51:08.546771Z","steps":["trace[2219936] 'agreement among raft nodes before linearized reading'  (duration: 568.066335ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.546838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.978336Z","time spent":"568.492715ms","remote":"127.0.0.1:58448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":787,"request content":"key:\"/registry/events/openstack/valkey-node-0.18a29b907b3e07cd\" "}
{"level":"warn","ts":"2026-04-02T17:51:08.547261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.820905Z","time spent":"725.601133ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2873 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-02T17:51:08.546277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.535649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:51:08.54762Z","caller":"traceutil/trace.go:171","msg":"trace[1486326711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2884; }","duration":"691.700806ms","start":"2026-04-02T17:51:07.855689Z","end":"2026-04-02T17:51:08.547389Z","steps":["trace[1486326711] 'agreement among raft nodes before linearized reading'  (duration: 690.543059ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.546346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.744711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:51:08.547745Z","caller":"traceutil/trace.go:171","msg":"trace[1485365486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2884; }","duration":"686.145014ms","start":"2026-04-02T17:51:07.86158Z","end":"2026-04-02T17:51:08.547725Z","steps":["trace[1485365486] 'agreement among raft nodes before linearized reading'  (duration: 684.737001ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:51:08.547799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.855673Z","time spent":"692.065705ms","remote":"127.0.0.1:58384","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-02T17:51:08.547812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:51:07.861574Z","time spent":"686.220716ms","remote":"127.0.0.1:58370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-02T17:53:39.277329Z","caller":"traceutil/trace.go:171","msg":"trace[363510705] transaction","detail":"{read_only:false; response_revision:3875; number_of_response:1; }","duration":"116.952269ms","start":"2026-04-02T17:53:39.16035Z","end":"2026-04-02T17:53:39.277302Z","steps":["trace[363510705] 'process raft request'  (duration: 116.783115ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:53:39.305241Z","caller":"traceutil/trace.go:171","msg":"trace[383148448] transaction","detail":"{read_only:false; response_revision:3877; number_of_response:1; }","duration":"142.164488ms","start":"2026-04-02T17:53:39.163046Z","end":"2026-04-02T17:53:39.30521Z","steps":["trace[383148448] 'process raft request'  (duration: 142.114037ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:53:39.305475Z","caller":"traceutil/trace.go:171","msg":"trace[491777156] transaction","detail":"{read_only:false; response_revision:3876; number_of_response:1; }","duration":"143.804036ms","start":"2026-04-02T17:53:39.161654Z","end":"2026-04-02T17:53:39.305458Z","steps":["trace[491777156] 'process raft request'  (duration: 143.348295ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:54:53.447828Z","caller":"traceutil/trace.go:171","msg":"trace[288612906] linearizableReadLoop","detail":"{readStateIndex:4935; appliedIndex:4934; }","duration":"194.872414ms","start":"2026-04-02T17:54:53.252934Z","end":"2026-04-02T17:54:53.447807Z","steps":["trace[288612906] 'read index received'  (duration: 194.68389ms)","trace[288612906] 'applied index is now lower than readState.Index'  (duration: 185.894µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:54:53.447958Z","caller":"traceutil/trace.go:171","msg":"trace[188820248] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"195.770416ms","start":"2026-04-02T17:54:53.252177Z","end":"2026-04-02T17:54:53.447947Z","steps":["trace[188820248] 'process raft request'  (duration: 195.488999ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:54:53.448177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.221733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-04-02T17:54:53.448218Z","caller":"traceutil/trace.go:171","msg":"trace[12472529] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4759; }","duration":"195.287235ms","start":"2026-04-02T17:54:53.252918Z","end":"2026-04-02T17:54:53.448205Z","steps":["trace[12472529] 'agreement among raft nodes before linearized reading'  (duration: 195.151561ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:54:53.449026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.90386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:49 size:1957109"}
{"level":"info","ts":"2026-04-02T17:54:53.449152Z","caller":"traceutil/trace.go:171","msg":"trace[2055383597] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:49; response_revision:4759; }","duration":"156.068314ms","start":"2026-04-02T17:54:53.293062Z","end":"2026-04-02T17:54:53.449131Z","steps":["trace[2055383597] 'agreement among raft nodes before linearized reading'  (duration: 155.161513ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:54:57.53638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.468088ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300932503 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cert-manager.io/certificaterequests/monitoring/kube-prometheus-stack-prometheus-node-exporter-ndgbw-m6kg8\" mod_revision:4860 > success:<request_put:<key:\"/registry/cert-manager.io/certificaterequests/monitoring/kube-prometheus-stack-prometheus-node-exporter-ndgbw-m6kg8\" value_size:3829 >> failure:<request_range:<key:\"/registry/cert-manager.io/certificaterequests/monitoring/kube-prometheus-stack-prometheus-node-exporter-ndgbw-m6kg8\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:54:57.536514Z","caller":"traceutil/trace.go:171","msg":"trace[1460931467] linearizableReadLoop","detail":"{readStateIndex:5046; appliedIndex:5045; }","duration":"133.883058ms","start":"2026-04-02T17:54:57.402609Z","end":"2026-04-02T17:54:57.536492Z","steps":["trace[1460931467] 'read index received'  (duration: 32.148204ms)","trace[1460931467] 'applied index is now lower than readState.Index'  (duration: 101.733254ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:54:57.536608Z","caller":"traceutil/trace.go:171","msg":"trace[531992855] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"137.321399ms","start":"2026-04-02T17:54:57.399259Z","end":"2026-04-02T17:54:57.53658Z","steps":["trace[531992855] 'process raft request'  (duration: 35.550204ms)","trace[531992855] 'compare'  (duration: 101.345995ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:54:57.536722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.126213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"}
{"level":"info","ts":"2026-04-02T17:54:57.536778Z","caller":"traceutil/trace.go:171","msg":"trace[2132636597] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4867; }","duration":"134.212735ms","start":"2026-04-02T17:54:57.402551Z","end":"2026-04-02T17:54:57.536764Z","steps":["trace[2132636597] 'agreement among raft nodes before linearized reading'  (duration: 134.00303ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:54:58.769866Z","caller":"traceutil/trace.go:171","msg":"trace[453084664] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"150.569504ms","start":"2026-04-02T17:54:58.619272Z","end":"2026-04-02T17:54:58.769842Z","steps":["trace[453084664] 'process raft request'  (duration: 150.41955ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:03.135289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.179509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c243d61f-81c8-40d2-b3b9-56fcc6ce4c6c\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-04-02T17:55:03.135371Z","caller":"traceutil/trace.go:171","msg":"trace[656051820] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c243d61f-81c8-40d2-b3b9-56fcc6ce4c6c; range_end:; response_count:1; response_revision:5062; }","duration":"205.302852ms","start":"2026-04-02T17:55:02.930049Z","end":"2026-04-02T17:55:03.135352Z","steps":["trace[656051820] 'range keys from in-memory index tree'  (duration: 205.005866ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:03.135365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.91483ms","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-02T17:55:03.135531Z","caller":"traceutil/trace.go:171","msg":"trace[1739504358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5062; }","duration":"129.114326ms","start":"2026-04-02T17:55:03.006392Z","end":"2026-04-02T17:55:03.135506Z","steps":["trace[1739504358] 'range keys from in-memory index tree'  (duration: 128.761276ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:03.522054Z","caller":"traceutil/trace.go:171","msg":"trace[1707226471] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"179.114881ms","start":"2026-04-02T17:55:03.342901Z","end":"2026-04-02T17:55:03.522016Z","steps":["trace[1707226471] 'process raft request'  (duration: 178.860234ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:03.790034Z","caller":"traceutil/trace.go:171","msg":"trace[1431084667] transaction","detail":"{read_only:false; response_revision:5065; number_of_response:1; }","duration":"263.850492ms","start":"2026-04-02T17:55:03.526149Z","end":"2026-04-02T17:55:03.789999Z","steps":["trace[1431084667] 'process raft request'  (duration: 255.636587ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:03.826259Z","caller":"traceutil/trace.go:171","msg":"trace[148039055] transaction","detail":"{read_only:false; response_revision:5066; number_of_response:1; }","duration":"283.637832ms","start":"2026-04-02T17:55:03.542596Z","end":"2026-04-02T17:55:03.826234Z","steps":["trace[148039055] 'process raft request'  (duration: 283.389616ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:03.826305Z","caller":"traceutil/trace.go:171","msg":"trace[1981190482] transaction","detail":"{read_only:false; response_revision:5067; number_of_response:1; }","duration":"266.505515ms","start":"2026-04-02T17:55:03.55977Z","end":"2026-04-02T17:55:03.826275Z","steps":["trace[1981190482] 'process raft request'  (duration: 266.352171ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:03.826341Z","caller":"traceutil/trace.go:171","msg":"trace[1304035945] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"246.810978ms","start":"2026-04-02T17:55:03.579503Z","end":"2026-04-02T17:55:03.826314Z","steps":["trace[1304035945] 'process raft request'  (duration: 246.659634ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:03.826432Z","caller":"traceutil/trace.go:171","msg":"trace[1674532259] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"245.103087ms","start":"2026-04-02T17:55:03.581293Z","end":"2026-04-02T17:55:03.826397Z","steps":["trace[1674532259] 'process raft request'  (duration: 244.908602ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:03.826496Z","caller":"traceutil/trace.go:171","msg":"trace[28109660] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"102.291897ms","start":"2026-04-02T17:55:03.724165Z","end":"2026-04-02T17:55:03.826457Z","steps":["trace[28109660] 'process raft request'  (duration: 102.067682ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:12.589737Z","caller":"traceutil/trace.go:171","msg":"trace[610406993] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"156.712279ms","start":"2026-04-02T17:55:12.432993Z","end":"2026-04-02T17:55:12.589706Z","steps":["trace[610406993] 'process raft request'  (duration: 156.531195ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:12.599618Z","caller":"traceutil/trace.go:171","msg":"trace[411896279] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"150.300057ms","start":"2026-04-02T17:55:12.449299Z","end":"2026-04-02T17:55:12.599599Z","steps":["trace[411896279] 'process raft request'  (duration: 150.215425ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:20.746176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.657437ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300933639 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" mod_revision:5407 > success:<request_put:<key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" value_size:2143 >> failure:<request_range:<key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:55:20.746282Z","caller":"traceutil/trace.go:171","msg":"trace[899932596] linearizableReadLoop","detail":"{readStateIndex:5603; appliedIndex:5602; }","duration":"237.697801ms","start":"2026-04-02T17:55:20.508569Z","end":"2026-04-02T17:55:20.746267Z","steps":["trace[899932596] 'read index received'  (duration: 37.071µs)","trace[899932596] 'applied index is now lower than readState.Index'  (duration: 237.65971ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:55:20.746363Z","caller":"traceutil/trace.go:171","msg":"trace[192576375] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"335.718447ms","start":"2026-04-02T17:55:20.410634Z","end":"2026-04-02T17:55:20.746352Z","steps":["trace[192576375] 'process raft request'  (duration: 87.806265ms)","trace[192576375] 'compare'  (duration: 247.527983ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:55:20.746424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:55:20.410605Z","time spent":"335.788909ms","remote":"127.0.0.1:46004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2250,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" mod_revision:5407 > success:<request_put:<key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" value_size:2143 >> failure:<request_range:<key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" > >"}
{"level":"warn","ts":"2026-04-02T17:55:20.746492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.27489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:55:20.746556Z","caller":"traceutil/trace.go:171","msg":"trace[796955154] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:5409; }","duration":"226.360712ms","start":"2026-04-02T17:55:20.520178Z","end":"2026-04-02T17:55:20.746538Z","steps":["trace[796955154] 'agreement among raft nodes before linearized reading'  (duration: 226.259439ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:20.746616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.610657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-02T17:55:20.746634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.888077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3ea427c5-f82e-409f-abfa-e8471f1c2ee6\" ","response":"range_response_count:1 size:3645"}
{"level":"warn","ts":"2026-04-02T17:55:20.746643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.058929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3ea427c5-f82e-409f-abfa-e8471f1c2ee6\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-04-02T17:55:20.746713Z","caller":"traceutil/trace.go:171","msg":"trace[277340926] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3ea427c5-f82e-409f-abfa-e8471f1c2ee6; range_end:; response_count:1; response_revision:5409; }","duration":"118.0086ms","start":"2026-04-02T17:55:20.628686Z","end":"2026-04-02T17:55:20.746694Z","steps":["trace[277340926] 'agreement among raft nodes before linearized reading'  (duration: 117.769135ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:20.746719Z","caller":"traceutil/trace.go:171","msg":"trace[2011630218] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3ea427c5-f82e-409f-abfa-e8471f1c2ee6; range_end:; response_count:1; response_revision:5409; }","duration":"238.181732ms","start":"2026-04-02T17:55:20.508519Z","end":"2026-04-02T17:55:20.746701Z","steps":["trace[2011630218] 'agreement among raft nodes before linearized reading'  (duration: 237.976668ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:20.746703Z","caller":"traceutil/trace.go:171","msg":"trace[1004111174] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:5409; }","duration":"164.75069ms","start":"2026-04-02T17:55:20.581934Z","end":"2026-04-02T17:55:20.746685Z","steps":["trace[1004111174] 'agreement among raft nodes before linearized reading'  (duration: 164.546375ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:21.076158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.832559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T17:55:21.076267Z","caller":"traceutil/trace.go:171","msg":"trace[1582847028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5411; }","duration":"214.981513ms","start":"2026-04-02T17:55:20.861255Z","end":"2026-04-02T17:55:21.076236Z","steps":["trace[1582847028] 'range keys from in-memory index tree'  (duration: 214.761118ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:21.076606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.264954ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300933645 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-9slc7\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-9slc7\" value_size:2489 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:55:21.076771Z","caller":"traceutil/trace.go:171","msg":"trace[890458560] transaction","detail":"{read_only:false; response_revision:5412; number_of_response:1; }","duration":"198.710427ms","start":"2026-04-02T17:55:20.87799Z","end":"2026-04-02T17:55:21.076701Z","steps":["trace[890458560] 'process raft request'  (duration: 62.271358ms)","trace[890458560] 'compare'  (duration: 136.006378ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:55:21.677436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.240503ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300933650 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" mod_revision:5409 > success:<request_put:<key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" value_size:2470 >> failure:<request_range:<key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:55:21.677674Z","caller":"traceutil/trace.go:171","msg":"trace[1034931096] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"588.886026ms","start":"2026-04-02T17:55:21.088752Z","end":"2026-04-02T17:55:21.677637Z","steps":["trace[1034931096] 'process raft request'  (duration: 251.332055ms)","trace[1034931096] 'compare'  (duration: 336.969367ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:55:21.67784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:55:21.088737Z","time spent":"589.02481ms","remote":"127.0.0.1:46004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2577,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" mod_revision:5409 > success:<request_put:<key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" value_size:2470 >> failure:<request_range:<key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" > >"}
{"level":"warn","ts":"2026-04-02T17:55:21.802531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.991847ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300933651 > lease_revoke:<id:4bba9d4f4dcedd9b>","response":"size:27"}
{"level":"info","ts":"2026-04-02T17:55:21.802632Z","caller":"traceutil/trace.go:171","msg":"trace[1913054256] linearizableReadLoop","detail":"{readStateIndex:5609; appliedIndex:5607; }","duration":"640.989192ms","start":"2026-04-02T17:55:21.161626Z","end":"2026-04-02T17:55:21.802615Z","steps":["trace[1913054256] 'read index received'  (duration: 178.440495ms)","trace[1913054256] 'applied index is now lower than readState.Index'  (duration: 462.547337ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:55:21.802799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.161866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-04-02T17:55:21.802838Z","caller":"traceutil/trace.go:171","msg":"trace[1314024733] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5414; }","duration":"641.223968ms","start":"2026-04-02T17:55:21.161602Z","end":"2026-04-02T17:55:21.802826Z","steps":["trace[1314024733] 'agreement among raft nodes before linearized reading'  (duration: 641.076845ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:21.802871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:55:21.16159Z","time spent":"641.273129ms","remote":"127.0.0.1:58464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1153,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "}
{"level":"warn","ts":"2026-04-02T17:55:21.821475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.033291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T17:55:21.821476Z","caller":"traceutil/trace.go:171","msg":"trace[153708841] transaction","detail":"{read_only:false; response_revision:5415; number_of_response:1; }","duration":"129.722678ms","start":"2026-04-02T17:55:21.691713Z","end":"2026-04-02T17:55:21.821436Z","steps":["trace[153708841] 'process raft request'  (duration: 129.493173ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:55:21.821538Z","caller":"traceutil/trace.go:171","msg":"trace[711618937] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5415; }","duration":"209.138953ms","start":"2026-04-02T17:55:21.612385Z","end":"2026-04-02T17:55:21.821524Z","steps":["trace[711618937] 'agreement among raft nodes before linearized reading'  (duration: 209.021ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:21.821543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.83746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T17:55:21.822216Z","caller":"traceutil/trace.go:171","msg":"trace[827827683] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5415; }","duration":"143.583067ms","start":"2026-04-02T17:55:21.67861Z","end":"2026-04-02T17:55:21.822193Z","steps":["trace[827827683] 'agreement among raft nodes before linearized reading'  (duration: 142.782418ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:21.821827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.616551ms","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-02T17:55:21.822327Z","caller":"traceutil/trace.go:171","msg":"trace[1339305533] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5415; }","duration":"595.162683ms","start":"2026-04-02T17:55:21.227146Z","end":"2026-04-02T17:55:21.822308Z","steps":["trace[1339305533] 'agreement among raft nodes before linearized reading'  (duration: 594.448977ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:21.822392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:55:21.227128Z","time spent":"595.245136ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-02T17:55:21.822681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.103374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210982"}
{"level":"info","ts":"2026-04-02T17:55:21.822737Z","caller":"traceutil/trace.go:171","msg":"trace[1730110929] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5415; }","duration":"523.188316ms","start":"2026-04-02T17:55:21.299536Z","end":"2026-04-02T17:55:21.822724Z","steps":["trace[1730110929] 'agreement among raft nodes before linearized reading'  (duration: 522.096321ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:21.822775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T17:55:21.299528Z","time spent":"523.236397ms","remote":"127.0.0.1:58478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2211004,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "}
{"level":"info","ts":"2026-04-02T17:55:34.452945Z","caller":"traceutil/trace.go:171","msg":"trace[1814639476] linearizableReadLoop","detail":"{readStateIndex:5810; appliedIndex:5809; }","duration":"179.466839ms","start":"2026-04-02T17:55:34.273447Z","end":"2026-04-02T17:55:34.452914Z","steps":["trace[1814639476] 'read index received'  (duration: 179.250784ms)","trace[1814639476] 'applied index is now lower than readState.Index'  (duration: 214.705µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:55:34.453049Z","caller":"traceutil/trace.go:171","msg":"trace[507956216] transaction","detail":"{read_only:false; response_revision:5611; number_of_response:1; }","duration":"216.629811ms","start":"2026-04-02T17:55:34.236383Z","end":"2026-04-02T17:55:34.453013Z","steps":["trace[507956216] 'process raft request'  (duration: 216.318924ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:34.453286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.790446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:124619"}
{"level":"info","ts":"2026-04-02T17:55:34.453345Z","caller":"traceutil/trace.go:171","msg":"trace[2044624360] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5611; }","duration":"176.883327ms","start":"2026-04-02T17:55:34.276447Z","end":"2026-04-02T17:55:34.45333Z","steps":["trace[2044624360] 'agreement among raft nodes before linearized reading'  (duration: 176.644802ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:55:34.453287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.758416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"}
{"level":"info","ts":"2026-04-02T17:55:34.453635Z","caller":"traceutil/trace.go:171","msg":"trace[1082573445] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:5611; }","duration":"180.185216ms","start":"2026-04-02T17:55:34.273417Z","end":"2026-04-02T17:55:34.453602Z","steps":["trace[1082573445] 'agreement among raft nodes before linearized reading'  (duration: 179.655183ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T17:56:12.573054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.408371ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300934978 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5912 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:56:12.573154Z","caller":"traceutil/trace.go:171","msg":"trace[2083883778] transaction","detail":"{read_only:false; response_revision:5938; number_of_response:1; }","duration":"278.204198ms","start":"2026-04-02T17:56:12.294935Z","end":"2026-04-02T17:56:12.57314Z","steps":["trace[2083883778] 'process raft request'  (duration: 20.632242ms)","trace[2083883778] 'compare'  (duration: 257.318649ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T17:56:22.359305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.850025ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300935170 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5989 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T17:56:22.359487Z","caller":"traceutil/trace.go:171","msg":"trace[210062906] transaction","detail":"{read_only:false; response_revision:6000; number_of_response:1; }","duration":"185.862311ms","start":"2026-04-02T17:56:22.173593Z","end":"2026-04-02T17:56:22.359455Z","steps":["trace[210062906] 'process raft request'  (duration: 56.7744ms)","trace[210062906] 'compare'  (duration: 128.59355ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T17:56:22.359616Z","caller":"traceutil/trace.go:171","msg":"trace[1593300995] transaction","detail":"{read_only:false; response_revision:6001; number_of_response:1; }","duration":"182.428969ms","start":"2026-04-02T17:56:22.177155Z","end":"2026-04-02T17:56:22.359584Z","steps":["trace[1593300995] 'process raft request'  (duration: 182.245255ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T17:56:33.024023Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3019}
{"level":"info","ts":"2026-04-02T17:56:33.127314Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3019,"took":"101.678989ms","hash":1661698619,"current-db-size-bytes":57245696,"current-db-size":"57 MB","current-db-size-in-use-bytes":31260672,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-04-02T17:56:33.127814Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1661698619,"revision":3019,"compact-revision":-1}
{"level":"info","ts":"2026-04-02T17:56:35.27661Z","caller":"traceutil/trace.go:171","msg":"trace[1541051394] transaction","detail":"{read_only:false; response_revision:6096; number_of_response:1; }","duration":"109.699799ms","start":"2026-04-02T17:56:35.166883Z","end":"2026-04-02T17:56:35.276583Z","steps":["trace[1541051394] 'process raft request'  (duration: 109.509874ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:30.62387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.28005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:30.623968Z","caller":"traceutil/trace.go:171","msg":"trace[825569868] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8286; }","duration":"762.439805ms","start":"2026-04-02T18:01:29.86151Z","end":"2026-04-02T18:01:30.62395Z","steps":["trace[825569868] 'range keys from in-memory index tree'  (duration: 762.177228ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:30.624006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:29.861483Z","time spent":"762.515406ms","remote":"127.0.0.1:58384","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-02T18:01:30.624087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.721882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d9jvw\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-04-02T18:01:30.624208Z","caller":"traceutil/trace.go:171","msg":"trace[1274050418] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d9jvw; range_end:; response_count:1; response_revision:8286; }","duration":"213.895716ms","start":"2026-04-02T18:01:30.410289Z","end":"2026-04-02T18:01:30.624185Z","steps":["trace[1274050418] 'range keys from in-memory index tree'  (duration: 213.525267ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:30.62422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.092231ms","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-02T18:01:30.624297Z","caller":"traceutil/trace.go:171","msg":"trace[1232803122] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8286; }","duration":"369.173923ms","start":"2026-04-02T18:01:30.255105Z","end":"2026-04-02T18:01:30.624279Z","steps":["trace[1232803122] 'range keys from in-memory index tree'  (duration: 368.940568ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:30.624352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:30.255072Z","time spent":"369.266896ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-02T18:01:30.624544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.605352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:30.624592Z","caller":"traceutil/trace.go:171","msg":"trace[1173193551] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:8286; }","duration":"319.695614ms","start":"2026-04-02T18:01:30.304885Z","end":"2026-04-02T18:01:30.62458Z","steps":["trace[1173193551] 'count revisions from in-memory index tree'  (duration: 319.497979ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:30.624623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:30.304857Z","time spent":"319.757175ms","remote":"127.0.0.1:50974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T18:01:30.624665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.491735ms","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-02T18:01:30.624723Z","caller":"traceutil/trace.go:171","msg":"trace[1583368123] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8286; }","duration":"759.598647ms","start":"2026-04-02T18:01:29.86511Z","end":"2026-04-02T18:01:30.624708Z","steps":["trace[1583368123] 'range keys from in-memory index tree'  (duration: 759.29559ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:30.624774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:29.86508Z","time spent":"759.68191ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-02T18:01:30.625036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.291496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:30.625055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.302969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-02T18:01:30.625083Z","caller":"traceutil/trace.go:171","msg":"trace[226889273] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8286; }","duration":"544.384198ms","start":"2026-04-02T18:01:30.080687Z","end":"2026-04-02T18:01:30.625071Z","steps":["trace[226889273] 'count revisions from in-memory index tree'  (duration: 544.207745ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:30.625103Z","caller":"traceutil/trace.go:171","msg":"trace[484961994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8286; }","duration":"377.400821ms","start":"2026-04-02T18:01:30.247688Z","end":"2026-04-02T18:01:30.625089Z","steps":["trace[484961994] 'range keys from in-memory index tree'  (duration: 377.136965ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:30.625115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:30.080648Z","time spent":"544.45789ms","remote":"127.0.0.1:58596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T18:01:30.625156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:30.247655Z","time spent":"377.490474ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-02T18:01:30.625211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.826459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-02T18:01:30.625303Z","caller":"traceutil/trace.go:171","msg":"trace[1156002014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8286; }","duration":"735.957012ms","start":"2026-04-02T18:01:29.889326Z","end":"2026-04-02T18:01:30.625283Z","steps":["trace[1156002014] 'range keys from in-memory index tree'  (duration: 735.622395ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:30.625354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:29.889311Z","time spent":"736.033744ms","remote":"127.0.0.1:58644","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-02T18:01:31.107129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.848317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:31.107217Z","caller":"traceutil/trace.go:171","msg":"trace[1949154170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8290; }","duration":"245.028211ms","start":"2026-04-02T18:01:30.86217Z","end":"2026-04-02T18:01:31.107198Z","steps":["trace[1949154170] 'range keys from in-memory index tree'  (duration: 244.679493ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:31.107264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.749289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-55c5c6885f-8q4tc.18a29c23ce20ab27\" ","response":"range_response_count:1 size:1134"}
{"level":"info","ts":"2026-04-02T18:01:31.107349Z","caller":"traceutil/trace.go:171","msg":"trace[1461636289] range","detail":"{range_begin:/registry/events/openstack/barbican-api-55c5c6885f-8q4tc.18a29c23ce20ab27; range_end:; response_count:1; response_revision:8290; }","duration":"372.859132ms","start":"2026-04-02T18:01:30.734461Z","end":"2026-04-02T18:01:31.10732Z","steps":["trace[1461636289] 'range keys from in-memory index tree'  (duration: 372.574705ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:31.107381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:30.734446Z","time spent":"372.927944ms","remote":"127.0.0.1:58448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1156,"request content":"key:\"/registry/events/openstack/barbican-api-55c5c6885f-8q4tc.18a29c23ce20ab27\" "}
{"level":"info","ts":"2026-04-02T18:01:33.05345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6080}
{"level":"info","ts":"2026-04-02T18:01:33.192793Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6080,"took":"137.482652ms","hash":3908879067,"current-db-size-bytes":57245696,"current-db-size":"57 MB","current-db-size-in-use-bytes":23777280,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-04-02T18:01:33.192862Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3908879067,"revision":6080,"compact-revision":3019}
{"level":"info","ts":"2026-04-02T18:01:41.503752Z","caller":"traceutil/trace.go:171","msg":"trace[1551078906] linearizableReadLoop","detail":"{readStateIndex:8636; appliedIndex:8635; }","duration":"167.603862ms","start":"2026-04-02T18:01:41.33612Z","end":"2026-04-02T18:01:41.503724Z","steps":["trace[1551078906] 'read index received'  (duration: 141.345686ms)","trace[1551078906] 'applied index is now lower than readState.Index'  (duration: 26.256936ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:01:41.50391Z","caller":"traceutil/trace.go:171","msg":"trace[210389792] transaction","detail":"{read_only:false; response_revision:8346; number_of_response:1; }","duration":"205.896916ms","start":"2026-04-02T18:01:41.2979Z","end":"2026-04-02T18:01:41.503797Z","steps":["trace[210389792] 'process raft request'  (duration: 179.580368ms)","trace[210389792] 'compare'  (duration: 26.113803ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:01:41.503944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.819787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:41.504258Z","caller":"traceutil/trace.go:171","msg":"trace[382722016] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:8346; }","duration":"168.154355ms","start":"2026-04-02T18:01:41.336085Z","end":"2026-04-02T18:01:41.504239Z","steps":["trace[382722016] 'agreement among raft nodes before linearized reading'  (duration: 167.738605ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:43.054213Z","caller":"traceutil/trace.go:171","msg":"trace[128026932] linearizableReadLoop","detail":"{readStateIndex:8641; appliedIndex:8640; }","duration":"301.684182ms","start":"2026-04-02T18:01:42.752509Z","end":"2026-04-02T18:01:43.054193Z","steps":["trace[128026932] 'read index received'  (duration: 301.518209ms)","trace[128026932] 'applied index is now lower than readState.Index'  (duration: 164.823µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:01:43.054319Z","caller":"traceutil/trace.go:171","msg":"trace[1038071140] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"324.238963ms","start":"2026-04-02T18:01:42.730042Z","end":"2026-04-02T18:01:43.054281Z","steps":["trace[1038071140] 'process raft request'  (duration: 324.013436ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:43.054413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.814626ms","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-02T18:01:43.054439Z","caller":"traceutil/trace.go:171","msg":"trace[1888325397] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8351; }","duration":"301.877648ms","start":"2026-04-02T18:01:42.752553Z","end":"2026-04-02T18:01:43.054431Z","steps":["trace[1888325397] 'agreement among raft nodes before linearized reading'  (duration: 301.760275ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:43.05444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.04857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:43.054495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:42.752542Z","time spent":"301.939739ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-02T18:01:43.054484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:42.730023Z","time spent":"324.373815ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8340 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-02T18:01:43.054488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.95172ms","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-02T18:01:43.054521Z","caller":"traceutil/trace.go:171","msg":"trace[436602050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8351; }","duration":"193.184223ms","start":"2026-04-02T18:01:42.861317Z","end":"2026-04-02T18:01:43.054501Z","steps":["trace[436602050] 'agreement among raft nodes before linearized reading'  (duration: 193.027399ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:43.054547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.962549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-02T18:01:43.054565Z","caller":"traceutil/trace.go:171","msg":"trace[1467472931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8351; }","duration":"302.067973ms","start":"2026-04-02T18:01:42.752477Z","end":"2026-04-02T18:01:43.054545Z","steps":["trace[1467472931] 'agreement among raft nodes before linearized reading'  (duration: 301.840777ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:43.054577Z","caller":"traceutil/trace.go:171","msg":"trace[1382886218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8351; }","duration":"299.03777ms","start":"2026-04-02T18:01:42.755531Z","end":"2026-04-02T18:01:43.054569Z","steps":["trace[1382886218] 'agreement among raft nodes before linearized reading'  (duration: 298.956148ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:43.054607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:42.752465Z","time spent":"302.132784ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-02T18:01:43.054631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.7268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d9jvw\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-04-02T18:01:43.054705Z","caller":"traceutil/trace.go:171","msg":"trace[310948787] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d9jvw; range_end:; response_count:1; response_revision:8351; }","duration":"292.833802ms","start":"2026-04-02T18:01:42.761851Z","end":"2026-04-02T18:01:43.054685Z","steps":["trace[310948787] 'agreement among raft nodes before linearized reading'  (duration: 292.584966ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.823141ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300941303 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:8307 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T18:01:44.442126Z","caller":"traceutil/trace.go:171","msg":"trace[249444671] linearizableReadLoop","detail":"{readStateIndex:8650; appliedIndex:8649; }","duration":"580.216803ms","start":"2026-04-02T18:01:43.861891Z","end":"2026-04-02T18:01:44.442108Z","steps":["trace[249444671] 'read index received'  (duration: 339.138067ms)","trace[249444671] 'applied index is now lower than readState.Index'  (duration: 241.076756ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:01:44.442187Z","caller":"traceutil/trace.go:171","msg":"trace[80263378] transaction","detail":"{read_only:false; response_revision:8360; number_of_response:1; }","duration":"642.250785ms","start":"2026-04-02T18:01:43.799917Z","end":"2026-04-02T18:01:44.442168Z","steps":["trace[80263378] 'process raft request'  (duration: 401.172519ms)","trace[80263378] 'compare'  (duration: 240.690407ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:01:44.44226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.369607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:44.442281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:43.799899Z","time spent":"642.336226ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:8307 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-04-02T18:01:44.4423Z","caller":"traceutil/trace.go:171","msg":"trace[1888741398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8360; }","duration":"580.443149ms","start":"2026-04-02T18:01:43.861843Z","end":"2026-04-02T18:01:44.442287Z","steps":["trace[1888741398] 'agreement among raft nodes before linearized reading'  (duration: 580.370047ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.442353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:43.861826Z","time spent":"580.516431ms","remote":"127.0.0.1:58384","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-02T18:01:44.442365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.868407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T18:01:44.442486Z","caller":"traceutil/trace.go:171","msg":"trace[134413621] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:8360; }","duration":"386.98698ms","start":"2026-04-02T18:01:44.055437Z","end":"2026-04-02T18:01:44.442424Z","steps":["trace[134413621] 'agreement among raft nodes before linearized reading'  (duration: 386.844456ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.442548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:44.055421Z","time spent":"387.116032ms","remote":"127.0.0.1:35814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":29,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T18:01:44.442852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.541716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:44.442922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.12621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:44.443007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.268983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443061Z","caller":"traceutil/trace.go:171","msg":"trace[1696949363] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8360; }","duration":"136.325885ms","start":"2026-04-02T18:01:44.306723Z","end":"2026-04-02T18:01:44.443049Z","steps":["trace[1696949363] 'agreement among raft nodes before linearized reading'  (duration: 136.244713ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.443075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.086031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443171Z","caller":"traceutil/trace.go:171","msg":"trace[874054351] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8360; }","duration":"116.229825ms","start":"2026-04-02T18:01:44.32692Z","end":"2026-04-02T18:01:44.44315Z","steps":["trace[874054351] 'agreement among raft nodes before linearized reading'  (duration: 116.03098ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.443217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.231535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443268Z","caller":"traceutil/trace.go:171","msg":"trace[1303638241] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8360; }","duration":"116.303526ms","start":"2026-04-02T18:01:44.326951Z","end":"2026-04-02T18:01:44.443254Z","steps":["trace[1303638241] 'agreement among raft nodes before linearized reading'  (duration: 116.234285ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.443277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.562473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:44.443326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.68394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443009Z","caller":"traceutil/trace.go:171","msg":"trace[372417889] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8360; }","duration":"136.219932ms","start":"2026-04-02T18:01:44.306766Z","end":"2026-04-02T18:01:44.442986Z","steps":["trace[372417889] 'agreement among raft nodes before linearized reading'  (duration: 136.081449ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.443453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.867369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443493Z","caller":"traceutil/trace.go:171","msg":"trace[1444930690] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8360; }","duration":"167.93244ms","start":"2026-04-02T18:01:44.275549Z","end":"2026-04-02T18:01:44.443481Z","steps":["trace[1444930690] 'agreement among raft nodes before linearized reading'  (duration: 167.875908ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.443512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.10995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443556Z","caller":"traceutil/trace.go:171","msg":"trace[874322699] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8360; }","duration":"149.184102ms","start":"2026-04-02T18:01:44.294361Z","end":"2026-04-02T18:01:44.443545Z","steps":["trace[874322699] 'agreement among raft nodes before linearized reading'  (duration: 149.115001ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.442914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.18557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443636Z","caller":"traceutil/trace.go:171","msg":"trace[466756321] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8360; }","duration":"115.972039ms","start":"2026-04-02T18:01:44.327643Z","end":"2026-04-02T18:01:44.443615Z","steps":["trace[466756321] 'agreement among raft nodes before linearized reading'  (duration: 115.143149ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.443789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.870304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:44.44381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.026266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443822Z","caller":"traceutil/trace.go:171","msg":"trace[419677084] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8360; }","duration":"184.971747ms","start":"2026-04-02T18:01:44.258841Z","end":"2026-04-02T18:01:44.443813Z","steps":["trace[419677084] 'agreement among raft nodes before linearized reading'  (duration: 184.888455ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:44.442938Z","caller":"traceutil/trace.go:171","msg":"trace[194835251] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8360; }","duration":"148.639309ms","start":"2026-04-02T18:01:44.294275Z","end":"2026-04-02T18:01:44.442915Z","steps":["trace[194835251] 'agreement among raft nodes before linearized reading'  (duration: 148.512236ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.443889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.134069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:44.443887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.430414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.443924Z","caller":"traceutil/trace.go:171","msg":"trace[1795892183] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8360; }","duration":"169.18221ms","start":"2026-04-02T18:01:44.274735Z","end":"2026-04-02T18:01:44.443917Z","steps":["trace[1795892183] 'agreement among raft nodes before linearized reading'  (duration: 169.132359ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:44.443377Z","caller":"traceutil/trace.go:171","msg":"trace[500989696] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8360; }","duration":"148.745961ms","start":"2026-04-02T18:01:44.294617Z","end":"2026-04-02T18:01:44.443363Z","steps":["trace[500989696] 'agreement among raft nodes before linearized reading'  (duration: 148.668769ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:44.443942Z","caller":"traceutil/trace.go:171","msg":"trace[1885323622] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8360; }","duration":"184.493995ms","start":"2026-04-02T18:01:44.259433Z","end":"2026-04-02T18:01:44.443927Z","steps":["trace[1885323622] 'agreement among raft nodes before linearized reading'  (duration: 184.403633ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:44.443376Z","caller":"traceutil/trace.go:171","msg":"trace[301336127] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8360; }","duration":"183.735647ms","start":"2026-04-02T18:01:44.259617Z","end":"2026-04-02T18:01:44.443353Z","steps":["trace[301336127] 'agreement among raft nodes before linearized reading'  (duration: 183.541172ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:44.443847Z","caller":"traceutil/trace.go:171","msg":"trace[455196706] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8360; }","duration":"169.077728ms","start":"2026-04-02T18:01:44.27476Z","end":"2026-04-02T18:01:44.443838Z","steps":["trace[455196706] 'agreement among raft nodes before linearized reading'  (duration: 168.973696ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:44.444268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.399957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:44.444343Z","caller":"traceutil/trace.go:171","msg":"trace[63628919] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8360; }","duration":"136.53101ms","start":"2026-04-02T18:01:44.307797Z","end":"2026-04-02T18:01:44.444328Z","steps":["trace[63628919] 'agreement among raft nodes before linearized reading'  (duration: 135.239798ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:45.363247Z","caller":"traceutil/trace.go:171","msg":"trace[842164891] linearizableReadLoop","detail":"{readStateIndex:8652; appliedIndex:8651; }","duration":"219.680776ms","start":"2026-04-02T18:01:45.143543Z","end":"2026-04-02T18:01:45.363224Z","steps":["trace[842164891] 'read index received'  (duration: 219.561773ms)","trace[842164891] 'applied index is now lower than readState.Index'  (duration: 118.073µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:01:45.3633Z","caller":"traceutil/trace.go:171","msg":"trace[127631751] transaction","detail":"{read_only:false; response_revision:8362; number_of_response:1; }","duration":"240.81161ms","start":"2026-04-02T18:01:45.122456Z","end":"2026-04-02T18:01:45.363268Z","steps":["trace[127631751] 'process raft request'  (duration: 240.622505ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:45.363472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.912052ms","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-02T18:01:45.363512Z","caller":"traceutil/trace.go:171","msg":"trace[1794875410] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8362; }","duration":"220.006294ms","start":"2026-04-02T18:01:45.143492Z","end":"2026-04-02T18:01:45.363498Z","steps":["trace[1794875410] 'agreement among raft nodes before linearized reading'  (duration: 219.84131ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:45.382993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.912054ms","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-02T18:01:45.383014Z","caller":"traceutil/trace.go:171","msg":"trace[1581867571] transaction","detail":"{read_only:false; response_revision:8363; number_of_response:1; }","duration":"100.003318ms","start":"2026-04-02T18:01:45.282988Z","end":"2026-04-02T18:01:45.382991Z","steps":["trace[1581867571] 'process raft request'  (duration: 99.771213ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:45.383057Z","caller":"traceutil/trace.go:171","msg":"trace[340613466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8363; }","duration":"239.005287ms","start":"2026-04-02T18:01:45.144035Z","end":"2026-04-02T18:01:45.383041Z","steps":["trace[340613466] 'agreement among raft nodes before linearized reading'  (duration: 238.830283ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:45.52537Z","caller":"traceutil/trace.go:171","msg":"trace[293779875] transaction","detail":"{read_only:false; response_revision:8365; number_of_response:1; }","duration":"138.111978ms","start":"2026-04-02T18:01:45.387223Z","end":"2026-04-02T18:01:45.525335Z","steps":["trace[293779875] 'process raft request'  (duration: 77.06201ms)","trace[293779875] 'compare'  (duration: 60.810943ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:01:46.174685Z","caller":"traceutil/trace.go:171","msg":"trace[2042336671] transaction","detail":"{read_only:false; response_revision:8367; number_of_response:1; }","duration":"550.808881ms","start":"2026-04-02T18:01:45.623843Z","end":"2026-04-02T18:01:46.174652Z","steps":["trace[2042336671] 'process raft request'  (duration: 550.624576ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:46.174849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:45.623814Z","time spent":"550.954045ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8357 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-02T18:01:46.196678Z","caller":"traceutil/trace.go:171","msg":"trace[2028134087] linearizableReadLoop","detail":"{readStateIndex:8658; appliedIndex:8656; }","duration":"501.415392ms","start":"2026-04-02T18:01:45.695238Z","end":"2026-04-02T18:01:46.196653Z","steps":["trace[2028134087] 'read index received'  (duration: 479.176101ms)","trace[2028134087] 'applied index is now lower than readState.Index'  (duration: 22.238201ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:01:46.196793Z","caller":"traceutil/trace.go:171","msg":"trace[1824806004] transaction","detail":"{read_only:false; response_revision:8368; number_of_response:1; }","duration":"528.265533ms","start":"2026-04-02T18:01:45.668495Z","end":"2026-04-02T18:01:46.196761Z","steps":["trace[1824806004] 'process raft request'  (duration: 528.010817ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:46.196967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:45.668467Z","time spent":"528.400735ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8358 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-02T18:01:46.197076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.826192ms","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-02T18:01:46.197151Z","caller":"traceutil/trace.go:171","msg":"trace[1344441247] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8368; }","duration":"501.943215ms","start":"2026-04-02T18:01:45.695194Z","end":"2026-04-02T18:01:46.197137Z","steps":["trace[1344441247] 'agreement among raft nodes before linearized reading'  (duration: 501.717579ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:46.197209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.26893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:01:46.197254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.666174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:01:46.197295Z","caller":"traceutil/trace.go:171","msg":"trace[1629055568] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:8368; }","duration":"486.444334ms","start":"2026-04-02T18:01:45.710831Z","end":"2026-04-02T18:01:46.197276Z","steps":["trace[1629055568] 'agreement among raft nodes before linearized reading'  (duration: 486.244649ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:46.197342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.368293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-04-02T18:01:46.197363Z","caller":"traceutil/trace.go:171","msg":"trace[337577796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8368; }","duration":"335.854518ms","start":"2026-04-02T18:01:45.861487Z","end":"2026-04-02T18:01:46.197342Z","steps":["trace[337577796] 'agreement among raft nodes before linearized reading'  (duration: 335.629283ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:01:46.197422Z","caller":"traceutil/trace.go:171","msg":"trace[280950969] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:8368; }","duration":"192.501417ms","start":"2026-04-02T18:01:46.004902Z","end":"2026-04-02T18:01:46.197404Z","steps":["trace[280950969] 'agreement among raft nodes before linearized reading'  (duration: 192.192149ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:01:46.197405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:45.71081Z","time spent":"486.579548ms","remote":"127.0.0.1:58594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T18:01:46.197544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:45.695179Z","time spent":"502.040047ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-02T18:01:46.19749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:01:45.861469Z","time spent":"336.003253ms","remote":"127.0.0.1:58384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-02T18:01:46.318286Z","caller":"traceutil/trace.go:171","msg":"trace[1265857546] transaction","detail":"{read_only:false; response_revision:8369; number_of_response:1; }","duration":"115.479098ms","start":"2026-04-02T18:01:46.202773Z","end":"2026-04-02T18:01:46.318252Z","steps":["trace[1265857546] 'process raft request'  (duration: 49.613115ms)","trace[1265857546] 'compare'  (duration: 65.615307ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:01:46.318438Z","caller":"traceutil/trace.go:171","msg":"trace[1153322729] transaction","detail":"{read_only:false; response_revision:8370; number_of_response:1; }","duration":"108.961132ms","start":"2026-04-02T18:01:46.209454Z","end":"2026-04-02T18:01:46.318415Z","steps":["trace[1153322729] 'process raft request'  (duration: 108.682226ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:04.577786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.454221ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300941644 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8460 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T18:02:04.577891Z","caller":"traceutil/trace.go:171","msg":"trace[2031293645] linearizableReadLoop","detail":"{readStateIndex:8765; appliedIndex:8764; }","duration":"164.730184ms","start":"2026-04-02T18:02:04.413145Z","end":"2026-04-02T18:02:04.577875Z","steps":["trace[2031293645] 'read index received'  (duration: 54.451µs)","trace[2031293645] 'applied index is now lower than readState.Index'  (duration: 164.674263ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:04.577992Z","caller":"traceutil/trace.go:171","msg":"trace[1940286704] transaction","detail":"{read_only:false; response_revision:8471; number_of_response:1; }","duration":"257.17605ms","start":"2026-04-02T18:02:04.320803Z","end":"2026-04-02T18:02:04.577979Z","steps":["trace[1940286704] 'process raft request'  (duration: 60.432253ms)","trace[1940286704] 'compare'  (duration: 196.238855ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:04.578477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.302997ms","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-02T18:02:04.578552Z","caller":"traceutil/trace.go:171","msg":"trace[809135801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8471; }","duration":"165.407199ms","start":"2026-04-02T18:02:04.413128Z","end":"2026-04-02T18:02:04.578535Z","steps":["trace[809135801] 'agreement among raft nodes before linearized reading'  (duration: 165.221895ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:05.041358Z","caller":"traceutil/trace.go:171","msg":"trace[1212858589] linearizableReadLoop","detail":"{readStateIndex:8767; appliedIndex:8766; }","duration":"152.354968ms","start":"2026-04-02T18:02:04.888977Z","end":"2026-04-02T18:02:05.041332Z","steps":["trace[1212858589] 'read index received'  (duration: 152.147253ms)","trace[1212858589] 'applied index is now lower than readState.Index'  (duration: 206.105µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:05.041539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.523992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T18:02:05.041507Z","caller":"traceutil/trace.go:171","msg":"trace[1614281752] transaction","detail":"{read_only:false; response_revision:8473; number_of_response:1; }","duration":"262.914578ms","start":"2026-04-02T18:02:04.778541Z","end":"2026-04-02T18:02:05.041456Z","steps":["trace[1614281752] 'process raft request'  (duration: 262.56471ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:05.041597Z","caller":"traceutil/trace.go:171","msg":"trace[1428989451] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:8473; }","duration":"152.647425ms","start":"2026-04-02T18:02:04.888931Z","end":"2026-04-02T18:02:05.041578Z","steps":["trace[1428989451] 'agreement among raft nodes before linearized reading'  (duration: 152.504661ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:05.492109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.640831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:02:05.492206Z","caller":"traceutil/trace.go:171","msg":"trace[710501816] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:8473; }","duration":"141.800455ms","start":"2026-04-02T18:02:05.350387Z","end":"2026-04-02T18:02:05.492188Z","steps":["trace[710501816] 'count revisions from in-memory index tree'  (duration: 141.496388ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:05.492364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.356269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d9jvw\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-04-02T18:02:05.492506Z","caller":"traceutil/trace.go:171","msg":"trace[1702695860] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d9jvw; range_end:; response_count:1; response_revision:8473; }","duration":"253.520233ms","start":"2026-04-02T18:02:05.238954Z","end":"2026-04-02T18:02:05.492475Z","steps":["trace[1702695860] 'range keys from in-memory index tree'  (duration: 253.039171ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:05.492419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.783469ms","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-02T18:02:05.492617Z","caller":"traceutil/trace.go:171","msg":"trace[48950449] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8473; }","duration":"277.014314ms","start":"2026-04-02T18:02:05.215573Z","end":"2026-04-02T18:02:05.492587Z","steps":["trace[48950449] 'range keys from in-memory index tree'  (duration: 276.614465ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:05.598326Z","caller":"traceutil/trace.go:171","msg":"trace[1132012273] linearizableReadLoop","detail":"{readStateIndex:8769; appliedIndex:8768; }","duration":"100.576641ms","start":"2026-04-02T18:02:05.497719Z","end":"2026-04-02T18:02:05.598296Z","steps":["trace[1132012273] 'read index received'  (duration: 98.967512ms)","trace[1132012273] 'applied index is now lower than readState.Index'  (duration: 1.608099ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:05.598346Z","caller":"traceutil/trace.go:171","msg":"trace[661920428] transaction","detail":"{read_only:false; response_revision:8475; number_of_response:1; }","duration":"100.743676ms","start":"2026-04-02T18:02:05.497562Z","end":"2026-04-02T18:02:05.598306Z","steps":["trace[661920428] 'process raft request'  (duration: 99.109716ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:05.599027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.280218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224105"}
{"level":"info","ts":"2026-04-02T18:02:05.599106Z","caller":"traceutil/trace.go:171","msg":"trace[1012937612] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8476; }","duration":"101.378731ms","start":"2026-04-02T18:02:05.497707Z","end":"2026-04-02T18:02:05.599086Z","steps":["trace[1012937612] 'agreement among raft nodes before linearized reading'  (duration: 100.680765ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:05.888857Z","caller":"traceutil/trace.go:171","msg":"trace[739074609] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"254.495476ms","start":"2026-04-02T18:02:05.634334Z","end":"2026-04-02T18:02:05.888829Z","steps":["trace[739074609] 'process raft request'  (duration: 180.691574ms)","trace[739074609] 'compare'  (duration: 73.530656ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:05.889025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.446779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T18:02:05.889073Z","caller":"traceutil/trace.go:171","msg":"trace[1092759200] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:8478; }","duration":"224.564682ms","start":"2026-04-02T18:02:05.664498Z","end":"2026-04-02T18:02:05.889063Z","steps":["trace[1092759200] 'agreement among raft nodes before linearized reading'  (duration: 224.416198ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:05.889336Z","caller":"traceutil/trace.go:171","msg":"trace[2068147443] linearizableReadLoop","detail":"{readStateIndex:8772; appliedIndex:8771; }","duration":"215.833924ms","start":"2026-04-02T18:02:05.672833Z","end":"2026-04-02T18:02:05.888667Z","steps":["trace[2068147443] 'read index received'  (duration: 142.206865ms)","trace[2068147443] 'applied index is now lower than readState.Index'  (duration: 73.626159ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:06.209399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.961247ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300941662 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8466 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T18:02:06.209513Z","caller":"traceutil/trace.go:171","msg":"trace[1537707300] linearizableReadLoop","detail":"{readStateIndex:8773; appliedIndex:8772; }","duration":"320.02554ms","start":"2026-04-02T18:02:05.88947Z","end":"2026-04-02T18:02:06.209496Z","steps":["trace[1537707300] 'read index received'  (duration: 121.790447ms)","trace[1537707300] 'applied index is now lower than readState.Index'  (duration: 198.233273ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:06.209626Z","caller":"traceutil/trace.go:171","msg":"trace[546537319] transaction","detail":"{read_only:false; response_revision:8479; number_of_response:1; }","duration":"532.142856ms","start":"2026-04-02T18:02:05.677422Z","end":"2026-04-02T18:02:06.209565Z","steps":["trace[546537319] 'process raft request'  (duration: 333.922653ms)","trace[546537319] 'compare'  (duration: 197.623739ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:06.209723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.080869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-04-02T18:02:06.209756Z","caller":"traceutil/trace.go:171","msg":"trace[1917825051] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:8479; }","duration":"203.17338ms","start":"2026-04-02T18:02:06.006571Z","end":"2026-04-02T18:02:06.209744Z","steps":["trace[1917825051] 'agreement among raft nodes before linearized reading'  (duration: 203.021887ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:06.209715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.854432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:02:06.20984Z","caller":"traceutil/trace.go:171","msg":"trace[314541626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8479; }","duration":"347.055357ms","start":"2026-04-02T18:02:05.862747Z","end":"2026-04-02T18:02:06.209803Z","steps":["trace[314541626] 'agreement among raft nodes before linearized reading'  (duration: 346.827711ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:06.209884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:05.677402Z","time spent":"532.34116ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8466 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:06.209909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:05.862718Z","time spent":"347.18148ms","remote":"127.0.0.1:58384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-02T18:02:06.610799Z","caller":"traceutil/trace.go:171","msg":"trace[383836104] transaction","detail":"{read_only:false; response_revision:8480; number_of_response:1; }","duration":"393.29097ms","start":"2026-04-02T18:02:06.21747Z","end":"2026-04-02T18:02:06.610761Z","steps":["trace[383836104] 'process raft request'  (duration: 388.877535ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:06.610906Z","caller":"traceutil/trace.go:171","msg":"trace[67800306] transaction","detail":"{read_only:false; response_revision:8481; number_of_response:1; }","duration":"308.129368ms","start":"2026-04-02T18:02:06.302738Z","end":"2026-04-02T18:02:06.610867Z","steps":["trace[67800306] 'process raft request'  (duration: 307.893872ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:06.611007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:06.217455Z","time spent":"393.441393ms","remote":"127.0.0.1:58394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.72\" mod_revision:8427 > success:<request_put:<key:\"/registry/masterleases/199.204.45.72\" value_size:66 lease:5456846862446165858 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.72\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:06.611256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:06.302707Z","time spent":"308.358814ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8470 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-02T18:02:09.283674Z","caller":"traceutil/trace.go:171","msg":"trace[941607488] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"126.235315ms","start":"2026-04-02T18:02:09.157413Z","end":"2026-04-02T18:02:09.283649Z","steps":["trace[941607488] 'process raft request'  (duration: 126.028149ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.566257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.350630229s","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300941804 > lease_revoke:<id:4bba9d4f4dcefed0>","response":"size:27"}
{"level":"info","ts":"2026-04-02T18:02:12.566343Z","caller":"traceutil/trace.go:171","msg":"trace[1137231259] linearizableReadLoop","detail":"{readStateIndex:8806; appliedIndex:8805; }","duration":"1.136151557s","start":"2026-04-02T18:02:11.430175Z","end":"2026-04-02T18:02:12.566327Z","steps":["trace[1137231259] 'read index received'  (duration: 61.141µs)","trace[1137231259] 'applied index is now lower than readState.Index'  (duration: 1.136089396s)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:12.566716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136538597s","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-02T18:02:12.566761Z","caller":"traceutil/trace.go:171","msg":"trace[1841189100] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:8510; }","duration":"1.136574698s","start":"2026-04-02T18:02:11.430157Z","end":"2026-04-02T18:02:12.566732Z","steps":["trace[1841189100] 'agreement among raft nodes before linearized reading'  (duration: 1.136515366s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.566786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.430094Z","time spent":"1.13668437s","remote":"127.0.0.1:51228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T18:02:12.569313Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.050193394s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-02T18:02:12.56969Z","caller":"traceutil/trace.go:171","msg":"trace[944462111] transaction","detail":"{read_only:false; response_revision:8511; number_of_response:1; }","duration":"1.050643985s","start":"2026-04-02T18:02:11.51902Z","end":"2026-04-02T18:02:12.569664Z","steps":["trace[944462111] 'process raft request'  (duration: 1.050483671s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.569831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.519001Z","time spent":"1.050757558s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8501 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:12.574057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003912189s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:02:12.574094Z","caller":"traceutil/trace.go:171","msg":"trace[993950972] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:8513; }","duration":"1.003986831s","start":"2026-04-02T18:02:11.570098Z","end":"2026-04-02T18:02:12.574084Z","steps":["trace[993950972] 'agreement among raft nodes before linearized reading'  (duration: 1.003893739s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.574117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.570079Z","time spent":"1.004031902s","remote":"127.0.0.1:45962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T18:02:12.5742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.582396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-02T18:02:12.574225Z","caller":"traceutil/trace.go:171","msg":"trace[663247922] transaction","detail":"{read_only:false; response_revision:8513; number_of_response:1; }","duration":"666.682418ms","start":"2026-04-02T18:02:11.907524Z","end":"2026-04-02T18:02:12.574206Z","steps":["trace[663247922] 'process raft request'  (duration: 666.431962ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.574264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.983974ms","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-02T18:02:12.574209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.302287ms","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":"warn","ts":"2026-04-02T18:02:12.574305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.867559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-02T18:02:12.574329Z","caller":"traceutil/trace.go:171","msg":"trace[666219168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8513; }","duration":"953.095196ms","start":"2026-04-02T18:02:11.621214Z","end":"2026-04-02T18:02:12.574309Z","steps":["trace[666219168] 'agreement among raft nodes before linearized reading'  (duration: 952.954853ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:12.574346Z","caller":"traceutil/trace.go:171","msg":"trace[1704901663] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8513; }","duration":"144.939611ms","start":"2026-04-02T18:02:12.429395Z","end":"2026-04-02T18:02:12.574335Z","steps":["trace[1704901663] 'agreement among raft nodes before linearized reading'  (duration: 144.858219ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.574366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.621179Z","time spent":"953.179299ms","remote":"127.0.0.1:58644","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-02T18:02:12.574364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.907497Z","time spent":"666.807201ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8505 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-02T18:02:12.574363Z","caller":"traceutil/trace.go:171","msg":"trace[1825330365] transaction","detail":"{read_only:false; response_revision:8512; number_of_response:1; }","duration":"799.199532ms","start":"2026-04-02T18:02:11.775138Z","end":"2026-04-02T18:02:12.574338Z","steps":["trace[1825330365] 'process raft request'  (duration: 798.659389ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:12.574279Z","caller":"traceutil/trace.go:171","msg":"trace[280973315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8513; }","duration":"336.708519ms","start":"2026-04-02T18:02:12.237554Z","end":"2026-04-02T18:02:12.574262Z","steps":["trace[280973315] 'agreement among raft nodes before linearized reading'  (duration: 336.484684ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.574445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.775113Z","time spent":"799.297294ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:8469 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:12.574461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.026574ms","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-02T18:02:12.574505Z","caller":"traceutil/trace.go:171","msg":"trace[1585070958] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8513; }","duration":"878.113696ms","start":"2026-04-02T18:02:11.696379Z","end":"2026-04-02T18:02:12.574492Z","steps":["trace[1585070958] 'agreement among raft nodes before linearized reading'  (duration: 877.975602ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.574474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.794909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:02:12.574553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.696347Z","time spent":"878.197598ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-02T18:02:12.574558Z","caller":"traceutil/trace.go:171","msg":"trace[827773742] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:8513; }","duration":"297.939283ms","start":"2026-04-02T18:02:12.276604Z","end":"2026-04-02T18:02:12.574543Z","steps":["trace[827773742] 'agreement among raft nodes before linearized reading'  (duration: 297.776699ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.574552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:12.237533Z","time spent":"336.958905ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-02T18:02:12.57414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.223213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d9jvw\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-04-02T18:02:12.574686Z","caller":"traceutil/trace.go:171","msg":"trace[399217877] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8513; }","duration":"952.470421ms","start":"2026-04-02T18:02:11.621842Z","end":"2026-04-02T18:02:12.574313Z","steps":["trace[399217877] 'agreement among raft nodes before linearized reading'  (duration: 952.240176ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:12.574707Z","caller":"traceutil/trace.go:171","msg":"trace[1189881150] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d9jvw; range_end:; response_count:1; response_revision:8513; }","duration":"941.818287ms","start":"2026-04-02T18:02:11.632878Z","end":"2026-04-02T18:02:12.574696Z","steps":["trace[1189881150] 'agreement among raft nodes before linearized reading'  (duration: 941.178572ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.574734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.632863Z","time spent":"941.864178ms","remote":"127.0.0.1:58560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-d9jvw\" "}
{"level":"warn","ts":"2026-04-02T18:02:12.574895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.13079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-02T18:02:12.574936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.621823Z","time spent":"952.890362ms","remote":"127.0.0.1:58644","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-02T18:02:12.575002Z","caller":"traceutil/trace.go:171","msg":"trace[912370515] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:8513; }","duration":"817.243992ms","start":"2026-04-02T18:02:11.757723Z","end":"2026-04-02T18:02:12.574967Z","steps":["trace[912370515] 'agreement among raft nodes before linearized reading'  (duration: 816.569206ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:12.575105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:11.7577Z","time spent":"817.395336ms","remote":"127.0.0.1:58708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":57,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T18:02:17.091577Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680218899300942001,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-02T18:02:17.737378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.785621Z","time spent":"951.750274ms","remote":"127.0.0.1:45506","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-04-02T18:02:17.738606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.878467ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218899300942003 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8567 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-02T18:02:17.738695Z","caller":"traceutil/trace.go:171","msg":"trace[773064079] transaction","detail":"{read_only:false; response_revision:8581; number_of_response:1; }","duration":"1.156078114s","start":"2026-04-02T18:02:16.5826Z","end":"2026-04-02T18:02:17.738679Z","steps":["trace[773064079] 'process raft request'  (duration: 697.054274ms)","trace[773064079] 'compare'  (duration: 458.777194ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:17.738743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.582572Z","time spent":"1.156150335s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8567 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-02T18:02:17.746695Z","caller":"traceutil/trace.go:171","msg":"trace[1011650228] linearizableReadLoop","detail":"{readStateIndex:8883; appliedIndex:8879; }","duration":"1.15549641s","start":"2026-04-02T18:02:16.59118Z","end":"2026-04-02T18:02:17.746676Z","steps":["trace[1011650228] 'read index received'  (duration: 688.55102ms)","trace[1011650228] 'applied index is now lower than readState.Index'  (duration: 466.94479ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:17.746733Z","caller":"traceutil/trace.go:171","msg":"trace[1404020791] transaction","detail":"{read_only:false; response_revision:8583; number_of_response:1; }","duration":"1.064776003s","start":"2026-04-02T18:02:16.68194Z","end":"2026-04-02T18:02:17.746717Z","steps":["trace[1404020791] 'process raft request'  (duration: 1.06468182s)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:17.746753Z","caller":"traceutil/trace.go:171","msg":"trace[2097789155] transaction","detail":"{read_only:false; response_revision:8584; number_of_response:1; }","duration":"1.059868316s","start":"2026-04-02T18:02:16.686868Z","end":"2026-04-02T18:02:17.746736Z","steps":["trace[2097789155] 'process raft request'  (duration: 1.059778134s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:17.746824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.681913Z","time spent":"1.064854196s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8573 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:17.746846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.686849Z","time spent":"1.059944408s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8574 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:17.746857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155672674s","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-02T18:02:17.74688Z","caller":"traceutil/trace.go:171","msg":"trace[1829640704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8584; }","duration":"1.155732185s","start":"2026-04-02T18:02:16.591141Z","end":"2026-04-02T18:02:17.746873Z","steps":["trace[1829640704] 'agreement among raft nodes before linearized reading'  (duration: 1.155637613s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:17.746904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.591121Z","time spent":"1.155778436s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-02T18:02:17.746959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.154765122s","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":"warn","ts":"2026-04-02T18:02:17.746981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.038335662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-04-02T18:02:17.746992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152033317s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-02T18:02:17.747004Z","caller":"traceutil/trace.go:171","msg":"trace[2030305807] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8584; }","duration":"1.038385933s","start":"2026-04-02T18:02:16.708611Z","end":"2026-04-02T18:02:17.746997Z","steps":["trace[2030305807] 'agreement among raft nodes before linearized reading'  (duration: 1.038313041s)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:17.747012Z","caller":"traceutil/trace.go:171","msg":"trace[1028334577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8584; }","duration":"1.152072188s","start":"2026-04-02T18:02:16.594935Z","end":"2026-04-02T18:02:17.747008Z","steps":["trace[1028334577] 'agreement among raft nodes before linearized reading'  (duration: 1.152012247s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:17.747028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152436957s","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-02T18:02:17.747049Z","caller":"traceutil/trace.go:171","msg":"trace[443743793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8584; }","duration":"1.152467727s","start":"2026-04-02T18:02:16.594577Z","end":"2026-04-02T18:02:17.747045Z","steps":["trace[443743793] 'agreement among raft nodes before linearized reading'  (duration: 1.152417506s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:17.747067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.594573Z","time spent":"1.152489288s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-02T18:02:17.747082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.150124891s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d9jvw\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-04-02T18:02:17.747099Z","caller":"traceutil/trace.go:171","msg":"trace[939090271] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d9jvw; range_end:; response_count:1; response_revision:8584; }","duration":"1.150179972s","start":"2026-04-02T18:02:16.596915Z","end":"2026-04-02T18:02:17.747095Z","steps":["trace[939090271] 'agreement among raft nodes before linearized reading'  (duration: 1.150125861s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:17.747027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.708596Z","time spent":"1.038425404s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-02T18:02:17.74712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.59689Z","time spent":"1.150224944s","remote":"127.0.0.1:58560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-d9jvw\" "}
{"level":"warn","ts":"2026-04-02T18:02:17.74703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.594925Z","time spent":"1.152101239s","remote":"127.0.0.1:58644","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-02T18:02:17.746983Z","caller":"traceutil/trace.go:171","msg":"trace[1748303463] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8584; }","duration":"1.154809334s","start":"2026-04-02T18:02:16.592168Z","end":"2026-04-02T18:02:17.746977Z","steps":["trace[1748303463] 'agreement among raft nodes before linearized reading'  (duration: 1.154741672s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:17.747178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.46349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-02T18:02:17.747185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.592147Z","time spent":"1.155032548s","remote":"127.0.0.1:58644","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-02T18:02:17.747196Z","caller":"traceutil/trace.go:171","msg":"trace[339203204] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:8584; }","duration":"815.518052ms","start":"2026-04-02T18:02:16.931671Z","end":"2026-04-02T18:02:17.747189Z","steps":["trace[339203204] 'agreement among raft nodes before linearized reading'  (duration: 815.487601ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:17.747218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.931649Z","time spent":"815.563782ms","remote":"127.0.0.1:50948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "}
{"level":"info","ts":"2026-04-02T18:02:17.748879Z","caller":"traceutil/trace.go:171","msg":"trace[1935131090] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"1.164001722s","start":"2026-04-02T18:02:16.584853Z","end":"2026-04-02T18:02:17.748855Z","steps":["trace[1935131090] 'process raft request'  (duration: 1.161671967s)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:17.749082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:16.584843Z","time spent":"1.164157555s","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8568 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-04-02T18:02:20.011862Z","caller":"traceutil/trace.go:171","msg":"trace[1008185867] transaction","detail":"{read_only:false; response_revision:8596; number_of_response:1; }","duration":"180.297055ms","start":"2026-04-02T18:02:19.831526Z","end":"2026-04-02T18:02:20.011823Z","steps":["trace[1008185867] 'process raft request'  (duration: 90.06128ms)","trace[1008185867] 'compare'  (duration: 89.967968ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:20.014822Z","caller":"traceutil/trace.go:171","msg":"trace[780651465] linearizableReadLoop","detail":"{readStateIndex:8899; appliedIndex:8894; }","duration":"181.76238ms","start":"2026-04-02T18:02:19.833044Z","end":"2026-04-02T18:02:20.014806Z","steps":["trace[780651465] 'read index received'  (duration: 88.451312ms)","trace[780651465] 'applied index is now lower than readState.Index'  (duration: 93.309788ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:20.014904Z","caller":"traceutil/trace.go:171","msg":"trace[5972405] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"182.859936ms","start":"2026-04-02T18:02:19.832033Z","end":"2026-04-02T18:02:20.014893Z","steps":["trace[5972405] 'process raft request'  (duration: 182.512968ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:20.014912Z","caller":"traceutil/trace.go:171","msg":"trace[2127746849] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"182.352804ms","start":"2026-04-02T18:02:19.832525Z","end":"2026-04-02T18:02:20.014878Z","steps":["trace[2127746849] 'process raft request'  (duration: 182.19976ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:20.014854Z","caller":"traceutil/trace.go:171","msg":"trace[1948200555] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"182.371645ms","start":"2026-04-02T18:02:19.832461Z","end":"2026-04-02T18:02:20.014832Z","steps":["trace[1948200555] 'process raft request'  (duration: 182.208081ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:20.014988Z","caller":"traceutil/trace.go:171","msg":"trace[2041773960] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"182.096088ms","start":"2026-04-02T18:02:19.832873Z","end":"2026-04-02T18:02:20.014969Z","steps":["trace[2041773960] 'process raft request'  (duration: 181.891913ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:20.015342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.288402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228835"}
{"level":"info","ts":"2026-04-02T18:02:20.015401Z","caller":"traceutil/trace.go:171","msg":"trace[737277076] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8600; }","duration":"182.386915ms","start":"2026-04-02T18:02:19.833001Z","end":"2026-04-02T18:02:20.015388Z","steps":["trace[737277076] 'agreement among raft nodes before linearized reading'  (duration: 181.947354ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:20.385916Z","caller":"traceutil/trace.go:171","msg":"trace[1969757174] linearizableReadLoop","detail":"{readStateIndex:8900; appliedIndex:8899; }","duration":"266.73805ms","start":"2026-04-02T18:02:20.11915Z","end":"2026-04-02T18:02:20.385888Z","steps":["trace[1969757174] 'read index received'  (duration: 171.220929ms)","trace[1969757174] 'applied index is now lower than readState.Index'  (duration: 95.515951ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:20.386056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.883603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:02:20.386094Z","caller":"traceutil/trace.go:171","msg":"trace[1736809676] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:8601; }","duration":"266.992866ms","start":"2026-04-02T18:02:20.11909Z","end":"2026-04-02T18:02:20.386083Z","steps":["trace[1736809676] 'agreement among raft nodes before linearized reading'  (duration: 266.898864ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:20.386159Z","caller":"traceutil/trace.go:171","msg":"trace[499128937] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"307.483212ms","start":"2026-04-02T18:02:20.078649Z","end":"2026-04-02T18:02:20.386132Z","steps":["trace[499128937] 'process raft request'  (duration: 211.711236ms)","trace[499128937] 'compare'  (duration: 95.376727ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-02T18:02:20.386308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:20.07862Z","time spent":"307.612255ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:8512 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:20.996728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.725776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:02:20.996807Z","caller":"traceutil/trace.go:171","msg":"trace[852588785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8602; }","duration":"134.84771ms","start":"2026-04-02T18:02:20.861941Z","end":"2026-04-02T18:02:20.996788Z","steps":["trace[852588785] 'range keys from in-memory index tree'  (duration: 134.631424ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:22.372942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.824527ms","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-02T18:02:22.372964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.746526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-04-02T18:02:22.372969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.623463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-04-02T18:02:22.373023Z","caller":"traceutil/trace.go:171","msg":"trace[330963010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8606; }","duration":"353.830418ms","start":"2026-04-02T18:02:22.019179Z","end":"2026-04-02T18:02:22.373009Z","steps":["trace[330963010] 'range keys from in-memory index tree'  (duration: 353.629183ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:22.373023Z","caller":"traceutil/trace.go:171","msg":"trace[1557572453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8606; }","duration":"353.93522ms","start":"2026-04-02T18:02:22.019067Z","end":"2026-04-02T18:02:22.373002Z","steps":["trace[1557572453] 'range keys from in-memory index tree'  (duration: 353.558251ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:22.373032Z","caller":"traceutil/trace.go:171","msg":"trace[1415840468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8606; }","duration":"353.705805ms","start":"2026-04-02T18:02:22.019312Z","end":"2026-04-02T18:02:22.373018Z","steps":["trace[1415840468] 'range keys from in-memory index tree'  (duration: 353.51312ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:22.373051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.019168Z","time spent":"353.877268ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-02T18:02:22.373027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.602952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-04-02T18:02:22.373065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.019055Z","time spent":"354.001152ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-02T18:02:22.372956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.957149ms","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-02T18:02:22.373103Z","caller":"traceutil/trace.go:171","msg":"trace[539790990] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8606; }","duration":"356.163724ms","start":"2026-04-02T18:02:22.01693Z","end":"2026-04-02T18:02:22.373093Z","steps":["trace[539790990] 'range keys from in-memory index tree'  (duration: 355.730213ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:22.373101Z","caller":"traceutil/trace.go:171","msg":"trace[802398896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8606; }","duration":"353.725035ms","start":"2026-04-02T18:02:22.019358Z","end":"2026-04-02T18:02:22.373083Z","steps":["trace[802398896] 'range keys from in-memory index tree'  (duration: 353.393988ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:22.373142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.016904Z","time spent":"356.230246ms","remote":"127.0.0.1:58644","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-02T18:02:22.373158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.019337Z","time spent":"353.812378ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-02T18:02:22.373068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.019307Z","time spent":"353.753556ms","remote":"127.0.0.1:58644","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-02T18:02:22.373536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.948369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d9jvw\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-04-02T18:02:22.373584Z","caller":"traceutil/trace.go:171","msg":"trace[862928419] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d9jvw; range_end:; response_count:1; response_revision:8606; }","duration":"351.013681ms","start":"2026-04-02T18:02:22.022558Z","end":"2026-04-02T18:02:22.373572Z","steps":["trace[862928419] 'range keys from in-memory index tree'  (duration: 350.845146ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:22.373613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.022548Z","time spent":"351.058152ms","remote":"127.0.0.1:58560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-d9jvw\" "}
{"level":"info","ts":"2026-04-02T18:02:22.61425Z","caller":"traceutil/trace.go:171","msg":"trace[508475687] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"236.819464ms","start":"2026-04-02T18:02:22.377401Z","end":"2026-04-02T18:02:22.61422Z","steps":["trace[508475687] 'process raft request'  (duration: 236.565848ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:23.089644Z","caller":"traceutil/trace.go:171","msg":"trace[343408503] transaction","detail":"{read_only:false; response_revision:8609; number_of_response:1; }","duration":"712.151783ms","start":"2026-04-02T18:02:22.377466Z","end":"2026-04-02T18:02:23.089618Z","steps":["trace[343408503] 'process raft request'  (duration: 711.983529ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:23.089761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.377444Z","time spent":"712.251516ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8600 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-02T18:02:23.089835Z","caller":"traceutil/trace.go:171","msg":"trace[652609407] linearizableReadLoop","detail":"{readStateIndex:8910; appliedIndex:8906; }","duration":"712.144023ms","start":"2026-04-02T18:02:22.377659Z","end":"2026-04-02T18:02:23.089803Z","steps":["trace[652609407] 'read index received'  (duration: 236.368803ms)","trace[652609407] 'applied index is now lower than readState.Index'  (duration: 475.77445ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:23.090007Z","caller":"traceutil/trace.go:171","msg":"trace[1786349181] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"708.612929ms","start":"2026-04-02T18:02:22.381342Z","end":"2026-04-02T18:02:23.089955Z","steps":["trace[1786349181] 'process raft request'  (duration: 708.410724ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:23.089505Z","caller":"traceutil/trace.go:171","msg":"trace[633775] transaction","detail":"{read_only:false; response_revision:8608; number_of_response:1; }","duration":"712.03152ms","start":"2026-04-02T18:02:22.377445Z","end":"2026-04-02T18:02:23.089476Z","steps":["trace[633775] 'process raft request'  (duration: 699.943291ms)","trace[633775] 'compare'  (duration: 11.893765ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:23.090034Z","caller":"traceutil/trace.go:171","msg":"trace[1409086244] transaction","detail":"{read_only:false; response_revision:8610; number_of_response:1; }","duration":"712.534292ms","start":"2026-04-02T18:02:22.377468Z","end":"2026-04-02T18:02:23.090002Z","steps":["trace[1409086244] 'process raft request'  (duration: 712.108362ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:23.09014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.377429Z","time spent":"712.683425ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8599 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:23.090255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.381334Z","time spent":"708.785703ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8596 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:23.090275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.377452Z","time spent":"712.739147ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8598 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-02T18:02:23.090351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.662475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228835"}
{"level":"info","ts":"2026-04-02T18:02:23.090452Z","caller":"traceutil/trace.go:171","msg":"trace[185122264] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8611; }","duration":"712.778587ms","start":"2026-04-02T18:02:22.377639Z","end":"2026-04-02T18:02:23.090417Z","steps":["trace[185122264] 'agreement among raft nodes before linearized reading'  (duration: 712.303676ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:23.090505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.377632Z","time spent":"712.86351ms","remote":"127.0.0.1:58560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":228857,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-04-02T18:02:23.162438Z","caller":"traceutil/trace.go:171","msg":"trace[1402477176] transaction","detail":"{read_only:false; response_revision:8612; number_of_response:1; }","duration":"185.090019ms","start":"2026-04-02T18:02:22.977315Z","end":"2026-04-02T18:02:23.162405Z","steps":["trace[1402477176] 'process raft request'  (duration: 184.889854ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:23.162529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.019828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:02:23.16261Z","caller":"traceutil/trace.go:171","msg":"trace[1262077806] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8612; }","duration":"301.148161ms","start":"2026-04-02T18:02:22.86144Z","end":"2026-04-02T18:02:23.162588Z","steps":["trace[1262077806] 'agreement among raft nodes before linearized reading'  (duration: 300.984377ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:23.162767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.861416Z","time spent":"301.334485ms","remote":"127.0.0.1:58384","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-02T18:02:23.162966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.346257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-02T18:02:23.163051Z","caller":"traceutil/trace.go:171","msg":"trace[229718734] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8612; }","duration":"317.746677ms","start":"2026-04-02T18:02:22.845289Z","end":"2026-04-02T18:02:23.163035Z","steps":["trace[229718734] 'agreement among raft nodes before linearized reading'  (duration: 317.072511ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:23.163126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:22.845227Z","time spent":"317.89115ms","remote":"127.0.0.1:58560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-04-02T18:02:31.109693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.393731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-02T18:02:31.109785Z","caller":"traceutil/trace.go:171","msg":"trace[1914893484] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8688; }","duration":"421.551435ms","start":"2026-04-02T18:02:30.688211Z","end":"2026-04-02T18:02:31.109762Z","steps":["trace[1914893484] 'count revisions from in-memory index tree'  (duration: 421.29394ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:31.109836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:30.688196Z","time spent":"421.628127ms","remote":"127.0.0.1:58604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-04-02T18:02:31.109998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.126705ms","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-02T18:02:31.110081Z","caller":"traceutil/trace.go:171","msg":"trace[1393481888] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8688; }","duration":"465.219597ms","start":"2026-04-02T18:02:30.644839Z","end":"2026-04-02T18:02:31.110059Z","steps":["trace[1393481888] 'range keys from in-memory index tree'  (duration: 464.882169ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:31.110104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.500424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-55c5c6885f-8q4tc.18a29c23ce20ab27\" ","response":"range_response_count:1 size:1134"}
{"level":"warn","ts":"2026-04-02T18:02:31.110145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:30.64481Z","time spent":"465.32463ms","remote":"127.0.0.1:58644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-02T18:02:31.110188Z","caller":"traceutil/trace.go:171","msg":"trace[1010701394] range","detail":"{range_begin:/registry/events/openstack/barbican-api-55c5c6885f-8q4tc.18a29c23ce20ab27; range_end:; response_count:1; response_revision:8688; }","duration":"372.636977ms","start":"2026-04-02T18:02:30.737531Z","end":"2026-04-02T18:02:31.110168Z","steps":["trace[1010701394] 'range keys from in-memory index tree'  (duration: 372.328319ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:31.110233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T18:02:30.737506Z","time spent":"372.717339ms","remote":"127.0.0.1:58448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1156,"request content":"key:\"/registry/events/openstack/barbican-api-55c5c6885f-8q4tc.18a29c23ce20ab27\" "}
{"level":"info","ts":"2026-04-02T18:02:31.380034Z","caller":"traceutil/trace.go:171","msg":"trace[684594213] transaction","detail":"{read_only:false; response_revision:8689; number_of_response:1; }","duration":"266.421082ms","start":"2026-04-02T18:02:31.113588Z","end":"2026-04-02T18:02:31.380009Z","steps":["trace[684594213] 'process raft request'  (duration: 266.160946ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:31.380253Z","caller":"traceutil/trace.go:171","msg":"trace[1479824412] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"265.335115ms","start":"2026-04-02T18:02:31.114901Z","end":"2026-04-02T18:02:31.380236Z","steps":["trace[1479824412] 'process raft request'  (duration: 265.030058ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:31.380401Z","caller":"traceutil/trace.go:171","msg":"trace[1030982560] linearizableReadLoop","detail":"{readStateIndex:8996; appliedIndex:8992; }","duration":"261.764579ms","start":"2026-04-02T18:02:31.11862Z","end":"2026-04-02T18:02:31.380384Z","steps":["trace[1030982560] 'read index received'  (duration: 180.609662ms)","trace[1030982560] 'applied index is now lower than readState.Index'  (duration: 81.153207ms)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:31.380422Z","caller":"traceutil/trace.go:171","msg":"trace[1506787892] transaction","detail":"{read_only:false; response_revision:8691; number_of_response:1; }","duration":"262.066637ms","start":"2026-04-02T18:02:31.118345Z","end":"2026-04-02T18:02:31.380411Z","steps":["trace[1506787892] 'process raft request'  (duration: 261.817691ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:31.380611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.344515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-02T18:02:31.380648Z","caller":"traceutil/trace.go:171","msg":"trace[579204936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8691; }","duration":"252.398466ms","start":"2026-04-02T18:02:31.128241Z","end":"2026-04-02T18:02:31.380639Z","steps":["trace[579204936] 'agreement among raft nodes before linearized reading'  (duration: 252.262113ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:31.380696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.781935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-d9jvw\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-04-02T18:02:31.380733Z","caller":"traceutil/trace.go:171","msg":"trace[704649524] range","detail":"{range_begin:/registry/pods/openstack/keepalived-d9jvw; range_end:; response_count:1; response_revision:8691; }","duration":"244.826305ms","start":"2026-04-02T18:02:31.135897Z","end":"2026-04-02T18:02:31.380723Z","steps":["trace[704649524] 'agreement among raft nodes before linearized reading'  (duration: 244.741523ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:31.380611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.973714ms","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-02T18:02:31.380827Z","caller":"traceutil/trace.go:171","msg":"trace[867004674] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8691; }","duration":"262.228642ms","start":"2026-04-02T18:02:31.11859Z","end":"2026-04-02T18:02:31.380819Z","steps":["trace[867004674] 'agreement among raft nodes before linearized reading'  (duration: 261.906583ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:31.38089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.245145ms","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-02T18:02:31.380969Z","caller":"traceutil/trace.go:171","msg":"trace[1328006491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8691; }","duration":"247.350987ms","start":"2026-04-02T18:02:31.1336Z","end":"2026-04-02T18:02:31.38095Z","steps":["trace[1328006491] 'agreement among raft nodes before linearized reading'  (duration: 247.129701ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:31.381072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.384893ms","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-02T18:02:31.38111Z","caller":"traceutil/trace.go:171","msg":"trace[45243250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8691; }","duration":"246.433714ms","start":"2026-04-02T18:02:31.134667Z","end":"2026-04-02T18:02:31.381101Z","steps":["trace[45243250] 'agreement among raft nodes before linearized reading'  (duration: 246.339562ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:31.650621Z","caller":"traceutil/trace.go:171","msg":"trace[2930583] transaction","detail":"{read_only:false; response_revision:8693; number_of_response:1; }","duration":"261.643897ms","start":"2026-04-02T18:02:31.388949Z","end":"2026-04-02T18:02:31.650593Z","steps":["trace[2930583] 'process raft request'  (duration: 261.33011ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:31.650834Z","caller":"traceutil/trace.go:171","msg":"trace[1600296195] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"261.768581ms","start":"2026-04-02T18:02:31.389045Z","end":"2026-04-02T18:02:31.650813Z","steps":["trace[1600296195] 'process raft request'  (duration: 261.502804ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:31.652964Z","caller":"traceutil/trace.go:171","msg":"trace[225302460] transaction","detail":"{read_only:false; response_revision:8696; number_of_response:1; }","duration":"263.879442ms","start":"2026-04-02T18:02:31.389064Z","end":"2026-04-02T18:02:31.652943Z","steps":["trace[225302460] 'process raft request'  (duration: 261.674969ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:31.653368Z","caller":"traceutil/trace.go:171","msg":"trace[1510881345] transaction","detail":"{read_only:false; response_revision:8697; number_of_response:1; }","duration":"262.710963ms","start":"2026-04-02T18:02:31.39063Z","end":"2026-04-02T18:02:31.653341Z","steps":["trace[1510881345] 'process raft request'  (duration: 262.256862ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:31.653552Z","caller":"traceutil/trace.go:171","msg":"trace[1137192295] transaction","detail":"{read_only:false; response_revision:8694; number_of_response:1; }","duration":"261.71502ms","start":"2026-04-02T18:02:31.38901Z","end":"2026-04-02T18:02:31.650725Z","steps":["trace[1137192295] 'process raft request'  (duration: 261.479634ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:31.675991Z","caller":"traceutil/trace.go:171","msg":"trace[1521395856] transaction","detail":"{read_only:false; response_revision:8698; number_of_response:1; }","duration":"111.546053ms","start":"2026-04-02T18:02:31.564419Z","end":"2026-04-02T18:02:31.675965Z","steps":["trace[1521395856] 'process raft request'  (duration: 111.351319ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:32.156326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.800914ms","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-02T18:02:32.156413Z","caller":"traceutil/trace.go:171","msg":"trace[2110559754] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:8704; }","duration":"164.950089ms","start":"2026-04-02T18:02:31.991445Z","end":"2026-04-02T18:02:32.156395Z","steps":["trace[2110559754] 'count revisions from in-memory index tree'  (duration: 164.724233ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:37.263809Z","caller":"traceutil/trace.go:171","msg":"trace[581736946] linearizableReadLoop","detail":"{readStateIndex:9052; appliedIndex:9051; }","duration":"182.811385ms","start":"2026-04-02T18:02:37.080976Z","end":"2026-04-02T18:02:37.263787Z","steps":["trace[581736946] 'read index received'  (duration: 182.60683ms)","trace[581736946] 'applied index is now lower than readState.Index'  (duration: 203.545µs)"],"step_count":2}
{"level":"info","ts":"2026-04-02T18:02:37.263883Z","caller":"traceutil/trace.go:171","msg":"trace[275648171] transaction","detail":"{read_only:false; response_revision:8746; number_of_response:1; }","duration":"229.891059ms","start":"2026-04-02T18:02:37.033961Z","end":"2026-04-02T18:02:37.263852Z","steps":["trace[275648171] 'process raft request'  (duration: 229.676463ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:37.263988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.50352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T18:02:37.264026Z","caller":"traceutil/trace.go:171","msg":"trace[427314327] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:8746; }","duration":"108.620744ms","start":"2026-04-02T18:02:37.155394Z","end":"2026-04-02T18:02:37.264014Z","steps":["trace[427314327] 'agreement among raft nodes before linearized reading'  (duration: 108.528942ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-02T18:02:37.264088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.01634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-02T18:02:37.264172Z","caller":"traceutil/trace.go:171","msg":"trace[1817093392] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:8746; }","duration":"183.235155ms","start":"2026-04-02T18:02:37.08092Z","end":"2026-04-02T18:02:37.264155Z","steps":["trace[1817093392] 'agreement among raft nodes before linearized reading'  (duration: 183.0004ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:44.275609Z","caller":"traceutil/trace.go:171","msg":"trace[676526395] transaction","detail":"{read_only:false; response_revision:8799; number_of_response:1; }","duration":"137.545595ms","start":"2026-04-02T18:02:44.13804Z","end":"2026-04-02T18:02:44.275586Z","steps":["trace[676526395] 'process raft request'  (duration: 137.347919ms)"],"step_count":1}
{"level":"info","ts":"2026-04-02T18:02:50.850086Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023e1.wal"}
{"level":"info","ts":"2026-04-02T18:04:20.242445Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-04-02T18:04:20.248848Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-04-02T18:04:20.248921Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-04-02T18:06:33.059603Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8302}
{"level":"info","ts":"2026-04-02T18:06:33.146269Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8302,"took":"82.854315ms","hash":3198879356,"current-db-size-bytes":57245696,"current-db-size":"57 MB","current-db-size-in-use-bytes":25698304,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-04-02T18:06:33.146359Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3198879356,"revision":8302,"compact-revision":6080}
{"level":"info","ts":"2026-04-02T18:11:33.06651Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10681}
{"level":"info","ts":"2026-04-02T18:11:33.153412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10681,"took":"84.619606ms","hash":1088357015,"current-db-size-bytes":57245696,"current-db-size":"57 MB","current-db-size-in-use-bytes":21094400,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-04-02T18:11:33.153473Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1088357015,"revision":10681,"compact-revision":8302}