{"level":"warn","ts":"2026-06-11T06:56:16.626924Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T06:56:16.62701Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.148: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.148:2380","--initial-cluster=instance=https://199.204.45.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.148: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-06-11T06:56:16.627072Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T06:56:16.62708Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.148:2380"]} {"level":"info","ts":"2026-06-11T06:56:16.627105Z","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-06-11T06:56:16.627713Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"]} {"level":"info","ts":"2026-06-11T06:56:16.627786Z","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.148:2380"],"listen-peer-urls":["https://199.204.45.148:2380"],"advertise-client-urls":["https://199.204.45.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.148: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-06-11T06:56:16.632225Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.232771ms"} {"level":"info","ts":"2026-06-11T06:56:16.637592Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8d200b79e0a2e7ca","cluster-id":"908374b13ab3ba47"} {"level":"info","ts":"2026-06-11T06:56:16.637675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=()"} {"level":"info","ts":"2026-06-11T06:56:16.6377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became follower at term 0"} {"level":"info","ts":"2026-06-11T06:56:16.637712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8d200b79e0a2e7ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-11T06:56:16.637726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became follower at term 1"} {"level":"info","ts":"2026-06-11T06:56:16.637766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=(10169140576690300874)"} {"level":"warn","ts":"2026-06-11T06:56:16.64501Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-11T06:56:16.646303Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-11T06:56:16.647434Z","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-06-11T06:56:16.65153Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8d200b79e0a2e7ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-11T06:56:16.651809Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8d200b79e0a2e7ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-11T06:56:16.652022Z","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-06-11T06:56:16.652246Z","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-06-11T06:56:16.652387Z","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-06-11T06:56:16.654216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=(10169140576690300874)"} {"level":"info","ts":"2026-06-11T06:56:16.654883Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"908374b13ab3ba47","local-member-id":"8d200b79e0a2e7ca","added-peer-id":"8d200b79e0a2e7ca","added-peer-peer-urls":["https://199.204.45.148:2380"]} {"level":"info","ts":"2026-06-11T06:56:16.656979Z","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-06-11T06:56:16.657139Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.148:2380"} {"level":"info","ts":"2026-06-11T06:56:16.657253Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.148:2380"} {"level":"info","ts":"2026-06-11T06:56:16.657442Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8d200b79e0a2e7ca","initial-advertise-peer-urls":["https://199.204.45.148:2380"],"listen-peer-urls":["https://199.204.45.148:2380"],"advertise-client-urls":["https://199.204.45.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-11T06:56:16.657481Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-11T06:56:17.338566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca is starting a new election at term 1"} {"level":"info","ts":"2026-06-11T06:56:17.338626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became pre-candidate at term 1"} {"level":"info","ts":"2026-06-11T06:56:17.338653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca received MsgPreVoteResp from 8d200b79e0a2e7ca at term 1"} {"level":"info","ts":"2026-06-11T06:56:17.338667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became candidate at term 2"} {"level":"info","ts":"2026-06-11T06:56:17.338671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca received MsgVoteResp from 8d200b79e0a2e7ca at term 2"} {"level":"info","ts":"2026-06-11T06:56:17.338679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became leader at term 2"} {"level":"info","ts":"2026-06-11T06:56:17.338686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8d200b79e0a2e7ca elected leader 8d200b79e0a2e7ca at term 2"} {"level":"info","ts":"2026-06-11T06:56:17.3396Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:56:17.340494Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T06:56:17.340493Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8d200b79e0a2e7ca","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.148:2379]}","request-path":"/0/members/8d200b79e0a2e7ca/attributes","cluster-id":"908374b13ab3ba47","publish-timeout":"7s"} {"level":"info","ts":"2026-06-11T06:56:17.340574Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T06:56:17.340945Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-11T06:56:17.341155Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-11T06:56:17.341283Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"908374b13ab3ba47","local-member-id":"8d200b79e0a2e7ca","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:56:17.341421Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:56:17.341452Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:56:17.342146Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.148:2379"} {"level":"info","ts":"2026-06-11T06:56:17.3434Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-11T06:57:00.48608Z","caller":"traceutil/trace.go:171","msg":"trace[1556289471] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"243.769043ms","start":"2026-06-11T06:57:00.242268Z","end":"2026-06-11T06:57:00.486037Z","steps":["trace[1556289471] 'process raft request' (duration: 243.539578ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:57:00.829594Z","caller":"traceutil/trace.go:171","msg":"trace[1101467436] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"373.626672ms","start":"2026-06-11T06:57:00.455928Z","end":"2026-06-11T06:57:00.829555Z","steps":["trace[1101467436] 'read index received' (duration: 29.893286ms)","trace[1101467436] 'applied index is now lower than readState.Index' (duration: 343.731886ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:57:00.829642Z","caller":"traceutil/trace.go:171","msg":"trace[520425287] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"498.212618ms","start":"2026-06-11T06:57:00.331385Z","end":"2026-06-11T06:57:00.829597Z","steps":["trace[520425287] 'process raft request' (duration: 497.33686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:57:00.829804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.845847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.148\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-11T06:57:00.829915Z","caller":"traceutil/trace.go:171","msg":"trace[1404525477] range","detail":"{range_begin:/registry/masterleases/199.204.45.148; range_end:; response_count:1; response_revision:638; }","duration":"374.013401ms","start":"2026-06-11T06:57:00.455879Z","end":"2026-06-11T06:57:00.829893Z","steps":["trace[1404525477] 'agreement among raft nodes before linearized reading' (duration: 373.804066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:57:00.82996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:00.455849Z","time spent":"374.103453ms","remote":"127.0.0.1:56836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.148\" "} {"level":"warn","ts":"2026-06-11T06:57:00.831167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:00.331351Z","time spent":"498.420413ms","remote":"127.0.0.1:56908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:57:01.328065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.271282ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:57:01.328255Z","caller":"traceutil/trace.go:171","msg":"trace[1642194033] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:663; }","duration":"341.278154ms","start":"2026-06-11T06:57:00.98696Z","end":"2026-06-11T06:57:01.328238Z","steps":["trace[1642194033] 'read index received' (duration: 97.98778ms)","trace[1642194033] 'applied index is now lower than readState.Index' (duration: 243.289564ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:57:01.328369Z","caller":"traceutil/trace.go:171","msg":"trace[348971525] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"435.844989ms","start":"2026-06-11T06:57:00.892489Z","end":"2026-06-11T06:57:01.328334Z","steps":["trace[348971525] 'process raft request' (duration: 435.680815ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:57:01.328457Z","caller":"traceutil/trace.go:171","msg":"trace[325064794] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"481.912375ms","start":"2026-06-11T06:57:00.846499Z","end":"2026-06-11T06:57:01.328411Z","steps":["trace[325064794] 'process raft request' (duration: 238.434158ms)","trace[325064794] 'compare' (duration: 242.088748ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:57:01.328506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:00.892465Z","time spent":"435.979291ms","remote":"127.0.0.1:57148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T06:57:01.328635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:00.846474Z","time spent":"482.068909ms","remote":"127.0.0.1:56836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:57:01.329014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.06051ms","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-06-11T06:57:01.329061Z","caller":"traceutil/trace.go:171","msg":"trace[787354547] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:640; }","duration":"342.149812ms","start":"2026-06-11T06:57:00.986901Z","end":"2026-06-11T06:57:01.329051Z","steps":["trace[787354547] 'agreement among raft nodes before linearized reading' (duration: 341.425837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:57:01.32909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:00.986875Z","time spent":"342.207813ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:57:01.329148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.551643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x8hx5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-11T06:57:01.329226Z","caller":"traceutil/trace.go:171","msg":"trace[283705543] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x8hx5; range_end:; response_count:1; response_revision:640; }","duration":"197.701448ms","start":"2026-06-11T06:57:01.131515Z","end":"2026-06-11T06:57:01.329216Z","steps":["trace[283705543] 'agreement among raft nodes before linearized reading' (duration: 197.444431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:57:01.963742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.881648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:57:01.96422Z","caller":"traceutil/trace.go:171","msg":"trace[504659186] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"550.481408ms","start":"2026-06-11T06:57:01.413681Z","end":"2026-06-11T06:57:01.964162Z","steps":["trace[504659186] 'read index received' (duration: 330.045119ms)","trace[504659186] 'applied index is now lower than readState.Index' (duration: 220.434279ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:57:01.964298Z","caller":"traceutil/trace.go:171","msg":"trace[1059549285] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"618.203604ms","start":"2026-06-11T06:57:01.345969Z","end":"2026-06-11T06:57:01.964173Z","steps":["trace[1059549285] 'process raft request' (duration: 397.738505ms)","trace[1059549285] 'compare' (duration: 219.57795ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:57:01.964451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:01.345945Z","time spent":"618.415828ms","remote":"127.0.0.1:56992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:57:01.964554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.624319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-11T06:57:01.964666Z","caller":"traceutil/trace.go:171","msg":"trace[2048606816] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:642; }","duration":"548.842433ms","start":"2026-06-11T06:57:01.415795Z","end":"2026-06-11T06:57:01.964638Z","steps":["trace[2048606816] 'agreement among raft nodes before linearized reading' (duration: 548.612898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:57:01.964713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.735228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-11T06:57:01.964775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:01.415771Z","time spent":"548.993107ms","remote":"127.0.0.1:57060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-06-11T06:57:01.964818Z","caller":"traceutil/trace.go:171","msg":"trace[1401363720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"436.918092ms","start":"2026-06-11T06:57:01.527876Z","end":"2026-06-11T06:57:01.964794Z","steps":["trace[1401363720] 'agreement among raft nodes before linearized reading' (duration: 436.666187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:57:01.964886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:01.527855Z","time spent":"437.022044ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:57:01.964641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.431401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:57:01.965062Z","caller":"traceutil/trace.go:171","msg":"trace[1941472154] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:642; }","duration":"621.069585ms","start":"2026-06-11T06:57:01.343974Z","end":"2026-06-11T06:57:01.965043Z","steps":["trace[1941472154] 'agreement among raft nodes before linearized reading' (duration: 620.296198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:57:01.965105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:57:01.343963Z","time spent":"621.130188ms","remote":"127.0.0.1:57300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-06-11T06:57:03.363444Z","caller":"traceutil/trace.go:171","msg":"trace[668317775] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"104.539912ms","start":"2026-06-11T06:57:03.258852Z","end":"2026-06-11T06:57:03.363392Z","steps":["trace[668317775] 'process raft request' (duration: 104.284847ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:58:31.233816Z","caller":"traceutil/trace.go:171","msg":"trace[1076508618] linearizableReadLoop","detail":"{readStateIndex:1954; appliedIndex:1953; }","duration":"225.189391ms","start":"2026-06-11T06:58:31.008592Z","end":"2026-06-11T06:58:31.233781Z","steps":["trace[1076508618] 'read index received' (duration: 224.849492ms)","trace[1076508618] 'applied index is now lower than readState.Index' (duration: 338.369µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:58:31.233889Z","caller":"traceutil/trace.go:171","msg":"trace[1602929402] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"282.893315ms","start":"2026-06-11T06:58:30.950951Z","end":"2026-06-11T06:58:31.233844Z","steps":["trace[1602929402] 'process raft request' (duration: 282.473415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:58:31.234178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.557968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bf1d2a10-0fe4-4235-b6f2-470e8b9462f8\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-11T06:58:31.234247Z","caller":"traceutil/trace.go:171","msg":"trace[1129177301] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bf1d2a10-0fe4-4235-b6f2-470e8b9462f8; range_end:; response_count:1; response_revision:1882; }","duration":"225.710631ms","start":"2026-06-11T06:58:31.00851Z","end":"2026-06-11T06:58:31.23422Z","steps":["trace[1129177301] 'agreement among raft nodes before linearized reading' (duration: 225.459356ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:58:44.483405Z","caller":"traceutil/trace.go:171","msg":"trace[689065221] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"106.094999ms","start":"2026-06-11T06:58:44.377267Z","end":"2026-06-11T06:58:44.483362Z","steps":["trace[689065221] 'process raft request' (duration: 105.806502ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:59:20.954608Z","caller":"traceutil/trace.go:171","msg":"trace[1698499255] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"100.666792ms","start":"2026-06-11T06:59:20.853905Z","end":"2026-06-11T06:59:20.954572Z","steps":["trace[1698499255] 'process raft request' (duration: 100.290854ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:59:21.116055Z","caller":"traceutil/trace.go:171","msg":"trace[1287532616] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"157.041784ms","start":"2026-06-11T06:59:20.958984Z","end":"2026-06-11T06:59:21.116026Z","steps":["trace[1287532616] 'process raft request' (duration: 144.379346ms)","trace[1287532616] 'compare' (duration: 12.535315ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:59:21.124491Z","caller":"traceutil/trace.go:171","msg":"trace[586832727] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"165.357266ms","start":"2026-06-11T06:59:20.959109Z","end":"2026-06-11T06:59:21.124466Z","steps":["trace[586832727] 'process raft request' (duration: 164.806305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:59:27.040659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.623211ms","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-06-11T06:59:27.040751Z","caller":"traceutil/trace.go:171","msg":"trace[34250180] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2233; }","duration":"207.760703ms","start":"2026-06-11T06:59:26.832973Z","end":"2026-06-11T06:59:27.040733Z","steps":["trace[34250180] 'range keys from in-memory index tree' (duration: 207.419036ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:59:27.44619Z","caller":"traceutil/trace.go:171","msg":"trace[1622724322] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"217.724112ms","start":"2026-06-11T06:59:27.228434Z","end":"2026-06-11T06:59:27.446158Z","steps":["trace[1622724322] 'process raft request' (duration: 144.015699ms)","trace[1622724322] 'compare' (duration: 73.57993ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:00:12.603358Z","caller":"traceutil/trace.go:171","msg":"trace[141066437] transaction","detail":"{read_only:false; response_revision:2653; number_of_response:1; }","duration":"146.484421ms","start":"2026-06-11T07:00:12.45685Z","end":"2026-06-11T07:00:12.603334Z","steps":["trace[141066437] 'process raft request' (duration: 145.789966ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:00:44.584494Z","caller":"traceutil/trace.go:171","msg":"trace[556883663] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"101.914245ms","start":"2026-06-11T07:00:44.482555Z","end":"2026-06-11T07:00:44.584469Z","steps":["trace[556883663] 'process raft request' (duration: 45.957897ms)","trace[556883663] 'compare' (duration: 55.826244ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:00:44.75343Z","caller":"traceutil/trace.go:171","msg":"trace[216942769] linearizableReadLoop","detail":"{readStateIndex:2954; appliedIndex:2953; }","duration":"168.952007ms","start":"2026-06-11T07:00:44.584439Z","end":"2026-06-11T07:00:44.753391Z","steps":["trace[216942769] 'read index received' (duration: 105.35482ms)","trace[216942769] 'applied index is now lower than readState.Index' (duration: 63.595487ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:00:44.753522Z","caller":"traceutil/trace.go:171","msg":"trace[29774327] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"186.841884ms","start":"2026-06-11T07:00:44.566646Z","end":"2026-06-11T07:00:44.753488Z","steps":["trace[29774327] 'process raft request' (duration: 123.179675ms)","trace[29774327] 'compare' (duration: 63.372683ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:00:44.75374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.004032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T07:00:44.753798Z","caller":"traceutil/trace.go:171","msg":"trace[888711357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2847; }","duration":"227.210177ms","start":"2026-06-11T07:00:44.526571Z","end":"2026-06-11T07:00:44.753781Z","steps":["trace[888711357] 'agreement among raft nodes before linearized reading' (duration: 227.003742ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:00:44.75753Z","caller":"traceutil/trace.go:171","msg":"trace[364068124] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"169.276694ms","start":"2026-06-11T07:00:44.588233Z","end":"2026-06-11T07:00:44.757509Z","steps":["trace[364068124] 'process raft request' (duration: 169.148662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:00:44.762026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.601033ms","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-06-11T07:00:44.762116Z","caller":"traceutil/trace.go:171","msg":"trace[1181329628] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2849; }","duration":"169.719016ms","start":"2026-06-11T07:00:44.592378Z","end":"2026-06-11T07:00:44.762097Z","steps":["trace[1181329628] 'agreement among raft nodes before linearized reading' (duration: 169.572222ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:00:50.064978Z","caller":"traceutil/trace.go:171","msg":"trace[217174092] transaction","detail":"{read_only:false; response_revision:2877; number_of_response:1; }","duration":"129.406112ms","start":"2026-06-11T07:00:49.935547Z","end":"2026-06-11T07:00:50.064953Z","steps":["trace[217174092] 'process raft request' (duration: 129.246479ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:03:10.390225Z","caller":"traceutil/trace.go:171","msg":"trace[669958669] transaction","detail":"{read_only:false; response_revision:3819; number_of_response:1; }","duration":"155.742322ms","start":"2026-06-11T07:03:10.234464Z","end":"2026-06-11T07:03:10.390206Z","steps":["trace[669958669] 'process raft request' (duration: 155.614458ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:03:10.489563Z","caller":"traceutil/trace.go:171","msg":"trace[457092329] transaction","detail":"{read_only:false; response_revision:3820; number_of_response:1; }","duration":"237.765853ms","start":"2026-06-11T07:03:10.251748Z","end":"2026-06-11T07:03:10.489514Z","steps":["trace[457092329] 'process raft request' (duration: 235.768409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:39.132165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.958976ms","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-06-11T07:04:39.132313Z","caller":"traceutil/trace.go:171","msg":"trace[1565759265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5024; }","duration":"162.096939ms","start":"2026-06-11T07:04:38.970131Z","end":"2026-06-11T07:04:39.132228Z","steps":["trace[1565759265] 'range keys from in-memory index tree' (duration: 161.573157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:39.134075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.615349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-06-11T07:04:39.134149Z","caller":"traceutil/trace.go:171","msg":"trace[1647401107] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5024; }","duration":"124.730222ms","start":"2026-06-11T07:04:39.009401Z","end":"2026-06-11T07:04:39.134132Z","steps":["trace[1647401107] 'range keys from in-memory index tree' (duration: 122.213087ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:39.331475Z","caller":"traceutil/trace.go:171","msg":"trace[274983204] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"195.921829ms","start":"2026-06-11T07:04:39.135533Z","end":"2026-06-11T07:04:39.331455Z","steps":["trace[274983204] 'process raft request' (duration: 195.780496ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:39.349859Z","caller":"traceutil/trace.go:171","msg":"trace[81152745] linearizableReadLoop","detail":"{readStateIndex:5215; appliedIndex:5213; }","duration":"207.883777ms","start":"2026-06-11T07:04:39.141952Z","end":"2026-06-11T07:04:39.349836Z","steps":["trace[81152745] 'read index received' (duration: 189.443039ms)","trace[81152745] 'applied index is now lower than readState.Index' (duration: 18.439748ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:04:39.349931Z","caller":"traceutil/trace.go:171","msg":"trace[1329129261] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"213.932158ms","start":"2026-06-11T07:04:39.135965Z","end":"2026-06-11T07:04:39.349898Z","steps":["trace[1329129261] 'process raft request' (duration: 201.658493ms)","trace[1329129261] 'compare' (duration: 12.116062ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:04:39.350108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.043605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-11T07:04:39.350148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.185184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a470d95-b3fd-4397-8126-b36a599353cc\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-06-11T07:04:39.350149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.540193ms","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-06-11T07:04:39.350169Z","caller":"traceutil/trace.go:171","msg":"trace[590357393] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:5026; }","duration":"192.143347ms","start":"2026-06-11T07:04:39.15801Z","end":"2026-06-11T07:04:39.350153Z","steps":["trace[590357393] 'agreement among raft nodes before linearized reading' (duration: 192.027494ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:39.350192Z","caller":"traceutil/trace.go:171","msg":"trace[1352637753] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7a470d95-b3fd-4397-8126-b36a599353cc; range_end:; response_count:1; response_revision:5026; }","duration":"208.283956ms","start":"2026-06-11T07:04:39.141896Z","end":"2026-06-11T07:04:39.35018Z","steps":["trace[1352637753] 'agreement among raft nodes before linearized reading' (duration: 208.122783ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:39.350204Z","caller":"traceutil/trace.go:171","msg":"trace[1484288881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5026; }","duration":"171.616904ms","start":"2026-06-11T07:04:39.178571Z","end":"2026-06-11T07:04:39.350188Z","steps":["trace[1484288881] 'agreement among raft nodes before linearized reading' (duration: 171.484522ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:41.26235Z","caller":"traceutil/trace.go:171","msg":"trace[400348037] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"100.593791ms","start":"2026-06-11T07:04:41.161729Z","end":"2026-06-11T07:04:41.262322Z","steps":["trace[400348037] 'process raft request' (duration: 96.759679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:52.478736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.586189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T07:04:52.478859Z","caller":"traceutil/trace.go:171","msg":"trace[49570830] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:5276; }","duration":"275.725492ms","start":"2026-06-11T07:04:52.203109Z","end":"2026-06-11T07:04:52.478834Z","steps":["trace[49570830] 'count revisions from in-memory index tree' (duration: 275.479966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:52.479631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.960883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T07:04:52.479761Z","caller":"traceutil/trace.go:171","msg":"trace[1247828594] linearizableReadLoop","detail":"{readStateIndex:5475; appliedIndex:5474; }","duration":"167.774042ms","start":"2026-06-11T07:04:52.311974Z","end":"2026-06-11T07:04:52.479748Z","steps":["trace[1247828594] 'read index received' (duration: 49.291µs)","trace[1247828594] 'applied index is now lower than readState.Index' (duration: 167.723501ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:04:52.479812Z","caller":"traceutil/trace.go:171","msg":"trace[736885399] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"239.244234ms","start":"2026-06-11T07:04:52.240561Z","end":"2026-06-11T07:04:52.479805Z","steps":["trace[736885399] 'process raft request' (duration: 41.028455ms)","trace[736885399] 'compare' (duration: 197.626826ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:04:52.480109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.116859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-11T07:04:52.480203Z","caller":"traceutil/trace.go:171","msg":"trace[1524428499] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5277; }","duration":"168.211281ms","start":"2026-06-11T07:04:52.311965Z","end":"2026-06-11T07:04:52.480177Z","steps":["trace[1524428499] 'agreement among raft nodes before linearized reading' (duration: 167.867634ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:52.685147Z","caller":"traceutil/trace.go:171","msg":"trace[694651949] linearizableReadLoop","detail":"{readStateIndex:5476; appliedIndex:5475; }","duration":"205.339653ms","start":"2026-06-11T07:04:52.479778Z","end":"2026-06-11T07:04:52.685118Z","steps":["trace[694651949] 'read index received' (duration: 141.163698ms)","trace[694651949] 'applied index is now lower than readState.Index' (duration: 64.174965ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:04:52.685209Z","caller":"traceutil/trace.go:171","msg":"trace[1882254111] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"250.295423ms","start":"2026-06-11T07:04:52.434867Z","end":"2026-06-11T07:04:52.685162Z","steps":["trace[1882254111] 'process raft request' (duration: 186.034036ms)","trace[1882254111] 'compare' (duration: 64.088523ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:04:52.68542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.54229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-11T07:04:52.685471Z","caller":"traceutil/trace.go:171","msg":"trace[1611070442] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5278; }","duration":"201.637923ms","start":"2026-06-11T07:04:52.483821Z","end":"2026-06-11T07:04:52.685458Z","steps":["trace[1611070442] 'agreement among raft nodes before linearized reading' (duration: 201.443538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:52.685438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.38363ms","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-06-11T07:04:52.685542Z","caller":"traceutil/trace.go:171","msg":"trace[697786336] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5278; }","duration":"373.550254ms","start":"2026-06-11T07:04:52.311962Z","end":"2026-06-11T07:04:52.685512Z","steps":["trace[697786336] 'agreement among raft nodes before linearized reading' (duration: 373.289408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:52.685534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.697978ms","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-06-11T07:04:52.6856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:04:52.311945Z","time spent":"373.643575ms","remote":"127.0.0.1:57032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-06-11T07:04:52.685605Z","caller":"traceutil/trace.go:171","msg":"trace[1053988715] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5278; }","duration":"260.890741ms","start":"2026-06-11T07:04:52.424698Z","end":"2026-06-11T07:04:52.685588Z","steps":["trace[1053988715] 'agreement among raft nodes before linearized reading' (duration: 260.448082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:52.686439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.401614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8dh9x\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-11T07:04:52.686477Z","caller":"traceutil/trace.go:171","msg":"trace[2033990650] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8dh9x; range_end:; response_count:1; response_revision:5278; }","duration":"300.484276ms","start":"2026-06-11T07:04:52.385985Z","end":"2026-06-11T07:04:52.686469Z","steps":["trace[2033990650] 'agreement among raft nodes before linearized reading' (duration: 300.112928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:52.686496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:04:52.385964Z","time spent":"300.526686ms","remote":"127.0.0.1:56992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6475,"request content":"key:\"/registry/pods/openstack/keepalived-8dh9x\" "} {"level":"info","ts":"2026-06-11T07:04:59.790277Z","caller":"traceutil/trace.go:171","msg":"trace[1331181727] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"150.036449ms","start":"2026-06-11T07:04:59.640209Z","end":"2026-06-11T07:04:59.790246Z","steps":["trace[1331181727] 'process raft request' (duration: 149.798964ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:59.819623Z","caller":"traceutil/trace.go:171","msg":"trace[2092625335] linearizableReadLoop","detail":"{readStateIndex:5647; appliedIndex:5645; }","duration":"109.3442ms","start":"2026-06-11T07:04:59.710253Z","end":"2026-06-11T07:04:59.819598Z","steps":["trace[2092625335] 'read index received' (duration: 79.835424ms)","trace[2092625335] 'applied index is now lower than readState.Index' (duration: 29.507636ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:04:59.819754Z","caller":"traceutil/trace.go:171","msg":"trace[1524521761] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"142.456344ms","start":"2026-06-11T07:04:59.677272Z","end":"2026-06-11T07:04:59.819728Z","steps":["trace[1524521761] 'process raft request' (duration: 142.180558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:04:59.819914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.637256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-11T07:04:59.819975Z","caller":"traceutil/trace.go:171","msg":"trace[1742099619] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5444; }","duration":"109.749699ms","start":"2026-06-11T07:04:59.71021Z","end":"2026-06-11T07:04:59.819959Z","steps":["trace[1742099619] 'agreement among raft nodes before linearized reading' (duration: 109.518474ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:59.989317Z","caller":"traceutil/trace.go:171","msg":"trace[1563547970] linearizableReadLoop","detail":"{readStateIndex:5656; appliedIndex:5654; }","duration":"128.711079ms","start":"2026-06-11T07:04:59.860584Z","end":"2026-06-11T07:04:59.989295Z","steps":["trace[1563547970] 'read index received' (duration: 71.76372ms)","trace[1563547970] 'applied index is now lower than readState.Index' (duration: 56.946329ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:04:59.989467Z","caller":"traceutil/trace.go:171","msg":"trace[1237579965] transaction","detail":"{read_only:false; response_revision:5452; number_of_response:1; }","duration":"136.971537ms","start":"2026-06-11T07:04:59.852478Z","end":"2026-06-11T07:04:59.98945Z","steps":["trace[1237579965] 'process raft request' (duration: 79.844174ms)","trace[1237579965] 'compare' (duration: 56.736805ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:04:59.989776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.264117ms","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-06-11T07:04:59.989808Z","caller":"traceutil/trace.go:171","msg":"trace[1883247129] transaction","detail":"{read_only:false; response_revision:5453; number_of_response:1; }","duration":"136.63098ms","start":"2026-06-11T07:04:59.853145Z","end":"2026-06-11T07:04:59.989776Z","steps":["trace[1883247129] 'process raft request' (duration: 136.062158ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:04:59.98984Z","caller":"traceutil/trace.go:171","msg":"trace[75355148] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5453; }","duration":"140.37147ms","start":"2026-06-11T07:04:59.849454Z","end":"2026-06-11T07:04:59.989826Z","steps":["trace[75355148] 'agreement among raft nodes before linearized reading' (duration: 140.136555ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:06:17.368397Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3028} {"level":"info","ts":"2026-06-11T07:06:17.45349Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3028,"took":"83.58794ms","hash":2054776053,"current-db-size-bytes":58994688,"current-db-size":"59 MB","current-db-size-in-use-bytes":32174080,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-11T07:06:17.453585Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2054776053,"revision":3028,"compact-revision":-1} {"level":"info","ts":"2026-06-11T07:11:17.374404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6154} {"level":"info","ts":"2026-06-11T07:11:17.477382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6154,"took":"101.482408ms","hash":2667744971,"current-db-size-bytes":58994688,"current-db-size":"59 MB","current-db-size-in-use-bytes":23384064,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-11T07:11:17.477434Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2667744971,"revision":6154,"compact-revision":3028} {"level":"warn","ts":"2026-06-11T07:11:20.270975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.544373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-11T07:11:20.271051Z","caller":"traceutil/trace.go:171","msg":"trace[1895390758] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8338; }","duration":"154.667245ms","start":"2026-06-11T07:11:20.116368Z","end":"2026-06-11T07:11:20.271036Z","steps":["trace[1895390758] 'range keys from in-memory index tree' (duration: 154.343839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:11:20.271077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.939757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-11T07:11:20.27115Z","caller":"traceutil/trace.go:171","msg":"trace[2016043198] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:8338; }","duration":"176.06878ms","start":"2026-06-11T07:11:20.095062Z","end":"2026-06-11T07:11:20.271131Z","steps":["trace[2016043198] 'range keys from in-memory index tree' (duration: 175.798194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:12:02.409833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.836862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T07:12:02.409982Z","caller":"traceutil/trace.go:171","msg":"trace[500456580] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8661; }","duration":"151.040967ms","start":"2026-06-11T07:12:02.258923Z","end":"2026-06-11T07:12:02.409964Z","steps":["trace[500456580] 'range keys from in-memory index tree' (duration: 150.675499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:12:02.410021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.81518ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T07:12:02.410263Z","caller":"traceutil/trace.go:171","msg":"trace[366123282] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"150.71552ms","start":"2026-06-11T07:12:02.259527Z","end":"2026-06-11T07:12:02.410243Z","steps":["trace[366123282] 'process raft request' (duration: 23.589573ms)","trace[366123282] 'compare' (duration: 126.699547ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:12:02.411146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.220386ms","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-06-11T07:12:02.411526Z","caller":"traceutil/trace.go:171","msg":"trace[639994541] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8661; }","duration":"160.542554ms","start":"2026-06-11T07:12:02.250868Z","end":"2026-06-11T07:12:02.411411Z","steps":["trace[639994541] 'range keys from in-memory index tree' (duration: 158.943329ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:12:03.675166Z","caller":"traceutil/trace.go:171","msg":"trace[1413938725] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"130.490649ms","start":"2026-06-11T07:12:03.544644Z","end":"2026-06-11T07:12:03.675135Z","steps":["trace[1413938725] 'process raft request' (duration: 123.110089ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:12:41.08678Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002480.wal"} {"level":"info","ts":"2026-06-11T07:13:17.810409Z","caller":"traceutil/trace.go:171","msg":"trace[407347935] transaction","detail":"{read_only:false; response_revision:9405; number_of_response:1; }","duration":"109.838541ms","start":"2026-06-11T07:13:17.700536Z","end":"2026-06-11T07:13:17.810375Z","steps":["trace[407347935] 'process raft request' (duration: 84.905678ms)","trace[407347935] 'compare' (duration: 24.760859ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:13:52.591447Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8d200b79e0a2e7ca","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-11T07:13:52.595652Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-11T07:13:52.595759Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-11T07:15:18.752453Z","caller":"traceutil/trace.go:171","msg":"trace[1138522492] transaction","detail":"{read_only:false; response_revision:10271; number_of_response:1; }","duration":"107.706315ms","start":"2026-06-11T07:15:18.644689Z","end":"2026-06-11T07:15:18.752395Z","steps":["trace[1138522492] 'process raft request' (duration: 107.389649ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:15:20.210277Z","caller":"traceutil/trace.go:171","msg":"trace[1777981881] linearizableReadLoop","detail":"{readStateIndex:10644; appliedIndex:10643; }","duration":"118.918648ms","start":"2026-06-11T07:15:20.091329Z","end":"2026-06-11T07:15:20.210248Z","steps":["trace[1777981881] 'read index received' (duration: 118.699154ms)","trace[1777981881] 'applied index is now lower than readState.Index' (duration: 218.354µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:15:20.210619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.274516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-65db47cf-6bc1-43c2-8e93-3cd587131df9\" ","response":"range_response_count:1 size:1318"} {"level":"info","ts":"2026-06-11T07:15:20.210733Z","caller":"traceutil/trace.go:171","msg":"trace[2137399715] range","detail":"{range_begin:/registry/persistentvolumes/pvc-65db47cf-6bc1-43c2-8e93-3cd587131df9; range_end:; response_count:1; response_revision:10287; }","duration":"119.412878ms","start":"2026-06-11T07:15:20.0913Z","end":"2026-06-11T07:15:20.210713Z","steps":["trace[2137399715] 'agreement among raft nodes before linearized reading' (duration: 119.150883ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:15:20.211257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.236497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T07:15:20.211385Z","caller":"traceutil/trace.go:171","msg":"trace[2035889543] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:10287; }","duration":"103.396539ms","start":"2026-06-11T07:15:20.107969Z","end":"2026-06-11T07:15:20.211365Z","steps":["trace[2035889543] 'agreement among raft nodes before linearized reading' (duration: 103.237026ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:15:20.211269Z","caller":"traceutil/trace.go:171","msg":"trace[886399518] transaction","detail":"{read_only:false; response_revision:10287; number_of_response:1; }","duration":"121.688539ms","start":"2026-06-11T07:15:20.089548Z","end":"2026-06-11T07:15:20.211236Z","steps":["trace[886399518] 'process raft request' (duration: 120.557204ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:15:20.536255Z","caller":"traceutil/trace.go:171","msg":"trace[874917517] linearizableReadLoop","detail":"{readStateIndex:10646; appliedIndex:10645; }","duration":"255.814898ms","start":"2026-06-11T07:15:20.280414Z","end":"2026-06-11T07:15:20.536229Z","steps":["trace[874917517] 'read index received' (duration: 254.743605ms)","trace[874917517] 'applied index is now lower than readState.Index' (duration: 1.069983ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:15:20.536301Z","caller":"traceutil/trace.go:171","msg":"trace[1107938538] transaction","detail":"{read_only:false; response_revision:10289; number_of_response:1; }","duration":"320.960336ms","start":"2026-06-11T07:15:20.215315Z","end":"2026-06-11T07:15:20.536275Z","steps":["trace[1107938538] 'process raft request' (duration: 319.935624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:15:20.536476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:15:20.215296Z","time spent":"321.082029ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:15:20.53657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.120315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8dh9x\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-11T07:15:20.536711Z","caller":"traceutil/trace.go:171","msg":"trace[1740340686] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8dh9x; range_end:; response_count:1; response_revision:10289; }","duration":"256.280209ms","start":"2026-06-11T07:15:20.280379Z","end":"2026-06-11T07:15:20.536659Z","steps":["trace[1740340686] 'agreement among raft nodes before linearized reading' (duration: 255.956631ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:16:17.38221Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8325} {"level":"info","ts":"2026-06-11T07:16:17.462736Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8325,"took":"77.707991ms","hash":862016577,"current-db-size-bytes":58994688,"current-db-size":"59 MB","current-db-size-in-use-bytes":25645056,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-11T07:16:17.462795Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":862016577,"revision":8325,"compact-revision":6154} {"level":"warn","ts":"2026-06-11T07:16:41.185998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.89048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:48 size:444965"} {"level":"info","ts":"2026-06-11T07:16:41.186086Z","caller":"traceutil/trace.go:171","msg":"trace[455119632] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:48; response_revision:11143; }","duration":"103.042383ms","start":"2026-06-11T07:16:41.083026Z","end":"2026-06-11T07:16:41.186068Z","steps":["trace[455119632] 'range keys from in-memory index tree' (duration: 102.347048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:17:04.267756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.67344ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T07:17:04.267918Z","caller":"traceutil/trace.go:171","msg":"trace[918542258] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:11267; }","duration":"195.835323ms","start":"2026-06-11T07:17:04.07205Z","end":"2026-06-11T07:17:04.267885Z","steps":["trace[918542258] 'range keys from in-memory index tree' (duration: 195.656509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:17:04.267986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.896838ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T07:17:04.268189Z","caller":"traceutil/trace.go:171","msg":"trace[3802298] transaction","detail":"{read_only:false; response_revision:11268; number_of_response:1; }","duration":"403.902131ms","start":"2026-06-11T07:17:03.864267Z","end":"2026-06-11T07:17:04.268169Z","steps":["trace[3802298] 'process raft request' (duration: 137.738368ms)","trace[3802298] 'compare' (duration: 265.776015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:17:04.268278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:17:03.864255Z","time spent":"403.979334ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:21:17.388215Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10819} {"level":"info","ts":"2026-06-11T07:21:17.466279Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10819,"took":"75.732506ms","hash":892406910,"current-db-size-bytes":58994688,"current-db-size":"59 MB","current-db-size-in-use-bytes":28028928,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-11T07:21:17.466377Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":892406910,"revision":10819,"compact-revision":8325} {"level":"info","ts":"2026-06-11T07:23:32.528962Z","caller":"traceutil/trace.go:171","msg":"trace[440352214] linearizableReadLoop","detail":"{readStateIndex:14353; appliedIndex:14352; }","duration":"164.679254ms","start":"2026-06-11T07:23:32.364262Z","end":"2026-06-11T07:23:32.528942Z","steps":["trace[440352214] 'read index received' (duration: 164.574432ms)","trace[440352214] 'applied index is now lower than readState.Index' (duration: 103.862µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:23:32.529045Z","caller":"traceutil/trace.go:171","msg":"trace[147538192] transaction","detail":"{read_only:false; response_revision:13879; number_of_response:1; }","duration":"182.652217ms","start":"2026-06-11T07:23:32.346364Z","end":"2026-06-11T07:23:32.529016Z","steps":["trace[147538192] 'process raft request' (duration: 182.444332ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:23:32.529163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.887458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8dh9x\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-11T07:23:32.529215Z","caller":"traceutil/trace.go:171","msg":"trace[86457598] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8dh9x; range_end:; response_count:1; response_revision:13879; }","duration":"164.971571ms","start":"2026-06-11T07:23:32.364233Z","end":"2026-06-11T07:23:32.529204Z","steps":["trace[86457598] 'agreement among raft nodes before linearized reading' (duration: 164.821047ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:23:32.555426Z","caller":"traceutil/trace.go:171","msg":"trace[1258638582] transaction","detail":"{read_only:false; response_revision:13880; number_of_response:1; }","duration":"139.159999ms","start":"2026-06-11T07:23:32.416252Z","end":"2026-06-11T07:23:32.555412Z","steps":["trace[1258638582] 'process raft request' (duration: 138.533505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:23:32.5556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.177942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-jjdlf\" ","response":"range_response_count:1 size:11628"} {"level":"info","ts":"2026-06-11T07:23:32.555635Z","caller":"traceutil/trace.go:171","msg":"trace[80068338] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-jjdlf; range_end:; response_count:1; response_revision:13880; }","duration":"156.237434ms","start":"2026-06-11T07:23:32.399389Z","end":"2026-06-11T07:23:32.555626Z","steps":["trace[80068338] 'agreement among raft nodes before linearized reading' (duration: 156.130482ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:23:32.79099Z","caller":"traceutil/trace.go:171","msg":"trace[1671443689] linearizableReadLoop","detail":"{readStateIndex:14355; appliedIndex:14354; }","duration":"235.994226ms","start":"2026-06-11T07:23:32.554977Z","end":"2026-06-11T07:23:32.790971Z","steps":["trace[1671443689] 'read index received' (duration: 172.366708ms)","trace[1671443689] 'applied index is now lower than readState.Index' (duration: 63.623668ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:23:32.791039Z","caller":"traceutil/trace.go:171","msg":"trace[1719038465] transaction","detail":"{read_only:false; response_revision:13881; number_of_response:1; }","duration":"253.513269ms","start":"2026-06-11T07:23:32.537494Z","end":"2026-06-11T07:23:32.791008Z","steps":["trace[1719038465] 'process raft request' (duration: 189.83692ms)","trace[1719038465] 'compare' (duration: 63.340132ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:23:32.791646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.215716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:63 size:590303"} {"level":"info","ts":"2026-06-11T07:23:32.791701Z","caller":"traceutil/trace.go:171","msg":"trace[496899421] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:63; response_revision:13881; }","duration":"248.302148ms","start":"2026-06-11T07:23:32.543386Z","end":"2026-06-11T07:23:32.791689Z","steps":["trace[496899421] 'agreement among raft nodes before linearized reading' (duration: 247.673875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:23:32.793262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.252119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T07:23:32.793293Z","caller":"traceutil/trace.go:171","msg":"trace[1235363886] transaction","detail":"{read_only:false; response_revision:13882; number_of_response:1; }","duration":"224.654974ms","start":"2026-06-11T07:23:32.568624Z","end":"2026-06-11T07:23:32.793279Z","steps":["trace[1235363886] 'process raft request' (duration: 224.448228ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:23:32.793315Z","caller":"traceutil/trace.go:171","msg":"trace[1612218701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13882; }","duration":"235.327181ms","start":"2026-06-11T07:23:32.557975Z","end":"2026-06-11T07:23:32.793302Z","steps":["trace[1612218701] 'agreement among raft nodes before linearized reading' (duration: 235.237909ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:23:53.875424Z","caller":"traceutil/trace.go:171","msg":"trace[1891279823] transaction","detail":"{read_only:false; response_revision:14185; number_of_response:1; }","duration":"241.053902ms","start":"2026-06-11T07:23:53.634355Z","end":"2026-06-11T07:23:53.875409Z","steps":["trace[1891279823] 'process raft request' (duration: 240.872188ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:23:53.8754Z","caller":"traceutil/trace.go:171","msg":"trace[105036515] linearizableReadLoop","detail":"{readStateIndex:14671; appliedIndex:14670; }","duration":"238.510648ms","start":"2026-06-11T07:23:53.636865Z","end":"2026-06-11T07:23:53.875375Z","steps":["trace[105036515] 'read index received' (duration: 238.282304ms)","trace[105036515] 'applied index is now lower than readState.Index' (duration: 224.524µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:23:53.87558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.693952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7037da32-c951-421b-940f-83bfc115597a\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-11T07:23:53.875817Z","caller":"traceutil/trace.go:171","msg":"trace[1728995918] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7037da32-c951-421b-940f-83bfc115597a; range_end:; response_count:1; response_revision:14185; }","duration":"238.971167ms","start":"2026-06-11T07:23:53.636834Z","end":"2026-06-11T07:23:53.875805Z","steps":["trace[1728995918] 'agreement among raft nodes before linearized reading' (duration: 238.62546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:23:53.875846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.073513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7037da32-c951-421b-940f-83bfc115597a\" ","response":"range_response_count:1 size:3637"} {"level":"warn","ts":"2026-06-11T07:23:53.875759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.67355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T07:23:53.875942Z","caller":"traceutil/trace.go:171","msg":"trace[1703748194] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7037da32-c951-421b-940f-83bfc115597a; range_end:; response_count:1; response_revision:14185; }","duration":"196.221147ms","start":"2026-06-11T07:23:53.679695Z","end":"2026-06-11T07:23:53.875916Z","steps":["trace[1703748194] 'agreement among raft nodes before linearized reading' (duration: 195.959911ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:23:53.876008Z","caller":"traceutil/trace.go:171","msg":"trace[21655762] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:14185; }","duration":"177.919986ms","start":"2026-06-11T07:23:53.698049Z","end":"2026-06-11T07:23:53.875969Z","steps":["trace[21655762] 'agreement among raft nodes before linearized reading' (duration: 177.64775ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:25:19.244894Z","caller":"traceutil/trace.go:171","msg":"trace[842298179] transaction","detail":"{read_only:false; response_revision:14991; number_of_response:1; }","duration":"104.688789ms","start":"2026-06-11T07:25:19.140172Z","end":"2026-06-11T07:25:19.24486Z","steps":["trace[842298179] 'process raft request' (duration: 104.558276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:25:19.490913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.897599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-06-11T07:25:19.490988Z","caller":"traceutil/trace.go:171","msg":"trace[2021891893] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:14991; }","duration":"120.020042ms","start":"2026-06-11T07:25:19.37095Z","end":"2026-06-11T07:25:19.49097Z","steps":["trace[2021891893] 'range keys from in-memory index tree' (duration: 119.714545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:25:19.957859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.535189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T07:25:19.958183Z","caller":"traceutil/trace.go:171","msg":"trace[585511283] transaction","detail":"{read_only:false; response_revision:14993; number_of_response:1; }","duration":"167.329308ms","start":"2026-06-11T07:25:19.790773Z","end":"2026-06-11T07:25:19.958102Z","steps":["trace[585511283] 'process raft request' (duration: 54.457311ms)","trace[585511283] 'compare' (duration: 112.379246ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:26:17.394152Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12979} {"level":"info","ts":"2026-06-11T07:26:17.472449Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12979,"took":"75.872006ms","hash":2833943291,"current-db-size-bytes":58994688,"current-db-size":"59 MB","current-db-size-in-use-bytes":30466048,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-11T07:26:17.472499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2833943291,"revision":12979,"compact-revision":10819} {"level":"warn","ts":"2026-06-11T07:31:10.684321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.86452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:31:10.684417Z","caller":"traceutil/trace.go:171","msg":"trace[1256351546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17593; }","duration":"156.097933ms","start":"2026-06-11T07:31:10.528299Z","end":"2026-06-11T07:31:10.684397Z","steps":["trace[1256351546] 'range keys from in-memory index tree' (duration: 155.609857ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:31:17.544963Z","caller":"traceutil/trace.go:171","msg":"trace[306372263] transaction","detail":"{read_only:false; response_revision:17630; number_of_response:1; }","duration":"149.077641ms","start":"2026-06-11T07:31:17.395859Z","end":"2026-06-11T07:31:17.544936Z","steps":["trace[306372263] 'process raft request' (duration: 148.789777ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:31:17.847492Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15355} {"level":"info","ts":"2026-06-11T07:31:17.847612Z","caller":"traceutil/trace.go:171","msg":"trace[710289858] compact","detail":"{revision:15355; response_revision:17630; }","duration":"301.412445ms","start":"2026-06-11T07:31:17.546168Z","end":"2026-06-11T07:31:17.847581Z","steps":["trace[710289858] 'process raft request' (duration: 205.662672ms)","trace[710289858] 'check and update compact revision' (duration: 95.52427ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:31:17.847695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:31:17.546127Z","time spent":"301.565307ms","remote":"127.0.0.1:56820","response type":"/etcdserverpb.KV/Compact","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-11T07:31:17.847792Z","caller":"traceutil/trace.go:171","msg":"trace[177826976] linearizableReadLoop","detail":"{readStateIndex:18226; appliedIndex:18225; }","duration":"301.311234ms","start":"2026-06-11T07:31:17.54644Z","end":"2026-06-11T07:31:17.847752Z","steps":["trace[177826976] 'read index received' (duration: 205.333709ms)","trace[177826976] 'applied index is now lower than readState.Index' (duration: 95.974965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:31:17.847977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.508917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:31:17.848067Z","caller":"traceutil/trace.go:171","msg":"trace[8217811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17630; }","duration":"301.627019ms","start":"2026-06-11T07:31:17.546417Z","end":"2026-06-11T07:31:17.848044Z","steps":["trace[8217811] 'agreement among raft nodes before linearized reading' (duration: 301.480597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:31:17.848128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:31:17.546408Z","time spent":"301.70569ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-11T07:31:17.851164Z","caller":"traceutil/trace.go:171","msg":"trace[1171812701] transaction","detail":"{read_only:false; response_revision:17631; number_of_response:1; }","duration":"144.112896ms","start":"2026-06-11T07:31:17.707036Z","end":"2026-06-11T07:31:17.851148Z","steps":["trace[1171812701] 'process raft request' (duration: 142.268161ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:31:17.851311Z","caller":"traceutil/trace.go:171","msg":"trace[1499907520] transaction","detail":"{read_only:false; response_revision:17632; number_of_response:1; }","duration":"140.284124ms","start":"2026-06-11T07:31:17.711013Z","end":"2026-06-11T07:31:17.851298Z","steps":["trace[1499907520] 'process raft request' (duration: 140.123812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:31:17.886885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.879727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T07:31:17.886988Z","caller":"traceutil/trace.go:171","msg":"trace[1291425178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17633; }","duration":"310.004429ms","start":"2026-06-11T07:31:17.576959Z","end":"2026-06-11T07:31:17.886963Z","steps":["trace[1291425178] 'agreement among raft nodes before linearized reading' (duration: 309.782216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:31:17.887042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:31:17.576943Z","time spent":"310.08614ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-11T07:31:17.887153Z","caller":"traceutil/trace.go:171","msg":"trace[1465769209] transaction","detail":"{read_only:false; response_revision:17633; number_of_response:1; }","duration":"124.626276ms","start":"2026-06-11T07:31:17.762509Z","end":"2026-06-11T07:31:17.887135Z","steps":["trace[1465769209] 'process raft request' (duration: 96.058496ms)","trace[1465769209] 'compare' (duration: 28.032602ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:31:17.887339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.786793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-11T07:31:17.887491Z","caller":"traceutil/trace.go:171","msg":"trace[1486112554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17633; }","duration":"238.930916ms","start":"2026-06-11T07:31:17.648501Z","end":"2026-06-11T07:31:17.887431Z","steps":["trace[1486112554] 'agreement among raft nodes before linearized reading' (duration: 238.647162ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:31:18.013942Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15355,"took":"162.664172ms","hash":190486876,"current-db-size-bytes":58994688,"current-db-size":"59 MB","current-db-size-in-use-bytes":31797248,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-11T07:31:18.014191Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":190486876,"revision":15355,"compact-revision":12979} {"level":"info","ts":"2026-06-11T07:34:48.517304Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8d200b79e0a2e7ca","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-11T07:34:48.522079Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-11T07:34:48.522227Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-11T07:36:17.854546Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17630} {"level":"info","ts":"2026-06-11T07:36:17.949396Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17630,"took":"92.502377ms","hash":292505470,"current-db-size-bytes":58994688,"current-db-size":"59 MB","current-db-size-in-use-bytes":33796096,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-11T07:36:17.949477Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":292505470,"revision":17630,"compact-revision":15355} {"level":"info","ts":"2026-06-11T07:37:01.400123Z","caller":"traceutil/trace.go:171","msg":"trace[292480170] transaction","detail":"{read_only:false; response_revision:20300; number_of_response:1; }","duration":"255.216724ms","start":"2026-06-11T07:37:01.144885Z","end":"2026-06-11T07:37:01.400102Z","steps":["trace[292480170] 'process raft request' (duration: 255.04907ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:37:01.453742Z","caller":"traceutil/trace.go:171","msg":"trace[171836507] transaction","detail":"{read_only:false; response_revision:20301; number_of_response:1; }","duration":"308.286875ms","start":"2026-06-11T07:37:01.145429Z","end":"2026-06-11T07:37:01.453716Z","steps":["trace[171836507] 'process raft request' (duration: 308.128932ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:37:01.453881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:37:01.145421Z","time spent":"308.389307ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:37:01.453992Z","caller":"traceutil/trace.go:171","msg":"trace[224896047] transaction","detail":"{read_only:false; response_revision:20302; number_of_response:1; }","duration":"306.586179ms","start":"2026-06-11T07:37:01.14737Z","end":"2026-06-11T07:37:01.453957Z","steps":["trace[224896047] 'process raft request' (duration: 306.304543ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:37:01.454068Z","caller":"traceutil/trace.go:171","msg":"trace[726807187] linearizableReadLoop","detail":"{readStateIndex:20988; appliedIndex:20985; }","duration":"297.297185ms","start":"2026-06-11T07:37:01.156636Z","end":"2026-06-11T07:37:01.453934Z","steps":["trace[726807187] 'read index received' (duration: 243.358136ms)","trace[726807187] 'applied index is now lower than readState.Index' (duration: 53.936849ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:37:01.454176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:37:01.147355Z","time spent":"306.727882ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:37:01.454232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.55486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:37:01.454347Z","caller":"traceutil/trace.go:171","msg":"trace[700282325] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:20302; }","duration":"297.700093ms","start":"2026-06-11T07:37:01.156604Z","end":"2026-06-11T07:37:01.454305Z","steps":["trace[700282325] 'agreement among raft nodes before linearized reading' (duration: 297.497959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:37:01.454483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.67224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-11T07:37:01.454517Z","caller":"traceutil/trace.go:171","msg":"trace[181723345] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:20302; }","duration":"177.749842ms","start":"2026-06-11T07:37:01.276758Z","end":"2026-06-11T07:37:01.454508Z","steps":["trace[181723345] 'agreement among raft nodes before linearized reading' (duration: 177.515427ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:37:01.743704Z","caller":"traceutil/trace.go:171","msg":"trace[1050834273] transaction","detail":"{read_only:false; response_revision:20303; number_of_response:1; }","duration":"106.09329ms","start":"2026-06-11T07:37:01.637586Z","end":"2026-06-11T07:37:01.743679Z","steps":["trace[1050834273] 'process raft request' (duration: 105.930137ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:37:01.864477Z","caller":"traceutil/trace.go:171","msg":"trace[1757868725] transaction","detail":"{read_only:false; response_revision:20304; number_of_response:1; }","duration":"225.998653ms","start":"2026-06-11T07:37:01.638443Z","end":"2026-06-11T07:37:01.864442Z","steps":["trace[1757868725] 'process raft request' (duration: 184.847941ms)","trace[1757868725] 'compare' (duration: 40.813724ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:37:01.864726Z","caller":"traceutil/trace.go:171","msg":"trace[1491636524] transaction","detail":"{read_only:false; response_revision:20305; number_of_response:1; }","duration":"221.099579ms","start":"2026-06-11T07:37:01.643567Z","end":"2026-06-11T07:37:01.864666Z","steps":["trace[1491636524] 'process raft request' (duration: 220.731192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:37:02.16089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.976167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:37:02.160964Z","caller":"traceutil/trace.go:171","msg":"trace[1201899891] linearizableReadLoop","detail":"{readStateIndex:20992; appliedIndex:20991; }","duration":"261.845892ms","start":"2026-06-11T07:37:01.899106Z","end":"2026-06-11T07:37:02.160952Z","steps":["trace[1201899891] 'read index received' (duration: 125.565239ms)","trace[1201899891] 'applied index is now lower than readState.Index' (duration: 136.279603ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:37:02.161062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.967105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-11T07:37:02.161083Z","caller":"traceutil/trace.go:171","msg":"trace[1079058368] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20306; }","duration":"262.031076ms","start":"2026-06-11T07:37:01.899045Z","end":"2026-06-11T07:37:02.161076Z","steps":["trace[1079058368] 'agreement among raft nodes before linearized reading' (duration: 261.943034ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:37:02.161291Z","caller":"traceutil/trace.go:171","msg":"trace[409652619] transaction","detail":"{read_only:false; response_revision:20306; number_of_response:1; }","duration":"292.421143ms","start":"2026-06-11T07:37:01.868817Z","end":"2026-06-11T07:37:02.161238Z","steps":["trace[409652619] 'process raft request' (duration: 155.842023ms)","trace[409652619] 'compare' (duration: 135.871675ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:40:52.008276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.963818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-06-11T07:40:52.008388Z","caller":"traceutil/trace.go:171","msg":"trace[747116616] range","detail":"{range_begin:/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi; range_end:; response_count:1; response_revision:22730; }","duration":"262.111652ms","start":"2026-06-11T07:40:51.746253Z","end":"2026-06-11T07:40:52.008365Z","steps":["trace[747116616] 'range keys from in-memory index tree' (duration: 261.759204ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:40:52.009241Z","caller":"traceutil/trace.go:171","msg":"trace[515335207] transaction","detail":"{read_only:false; response_revision:22731; number_of_response:1; }","duration":"177.597843ms","start":"2026-06-11T07:40:51.831618Z","end":"2026-06-11T07:40:52.009216Z","steps":["trace[515335207] 'process raft request' (duration: 175.474398ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:41:17.861911Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20076} {"level":"info","ts":"2026-06-11T07:41:17.977175Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20076,"took":"111.345321ms","hash":3394288183,"current-db-size-bytes":58994688,"current-db-size":"59 MB","current-db-size-in-use-bytes":40902656,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-06-11T07:41:17.977312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3394288183,"revision":20076,"compact-revision":17630} {"level":"info","ts":"2026-06-11T07:44:25.530104Z","caller":"traceutil/trace.go:171","msg":"trace[1627188130] transaction","detail":"{read_only:false; response_revision:24850; number_of_response:1; }","duration":"127.633766ms","start":"2026-06-11T07:44:25.402449Z","end":"2026-06-11T07:44:25.530083Z","steps":["trace[1627188130] 'process raft request' (duration: 127.511403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:25.7885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.088166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-11T07:44:25.788575Z","caller":"traceutil/trace.go:171","msg":"trace[1008992498] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:24850; }","duration":"152.213259ms","start":"2026-06-11T07:44:25.636345Z","end":"2026-06-11T07:44:25.788558Z","steps":["trace[1008992498] 'count revisions from in-memory index tree' (duration: 151.964762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:25.995801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.204637ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-11T07:44:25.996078Z","caller":"traceutil/trace.go:171","msg":"trace[1111212238] linearizableReadLoop","detail":"{readStateIndex:25663; appliedIndex:25662; }","duration":"254.959237ms","start":"2026-06-11T07:44:25.741098Z","end":"2026-06-11T07:44:25.996057Z","steps":["trace[1111212238] 'read index received' (duration: 1.404162ms)","trace[1111212238] 'applied index is now lower than readState.Index' (duration: 253.553375ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:25.996215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.10286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:25.9963Z","caller":"traceutil/trace.go:171","msg":"trace[1835813721] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:24850; }","duration":"255.250113ms","start":"2026-06-11T07:44:25.741029Z","end":"2026-06-11T07:44:25.99628Z","steps":["trace[1835813721] 'agreement among raft nodes before linearized reading' (duration: 255.10535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:25.996448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.199941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T07:44:25.996499Z","caller":"traceutil/trace.go:171","msg":"trace[1196124566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24851; }","duration":"134.284003ms","start":"2026-06-11T07:44:25.862203Z","end":"2026-06-11T07:44:25.996487Z","steps":["trace[1196124566] 'agreement among raft nodes before linearized reading' (duration: 134.107949ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:25.996544Z","caller":"traceutil/trace.go:171","msg":"trace[217361675] transaction","detail":"{read_only:false; response_revision:24851; number_of_response:1; }","duration":"167.465175ms","start":"2026-06-11T07:44:25.82907Z","end":"2026-06-11T07:44:25.996535Z","steps":["trace[217361675] 'process raft request' (duration: 166.834341ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:26.132576Z","caller":"traceutil/trace.go:171","msg":"trace[1848831754] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"128.70467ms","start":"2026-06-11T07:44:26.003839Z","end":"2026-06-11T07:44:26.132544Z","steps":["trace[1848831754] 'process raft request' (duration: 127.430092ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:26.132711Z","caller":"traceutil/trace.go:171","msg":"trace[138629336] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"109.665579ms","start":"2026-06-11T07:44:26.022998Z","end":"2026-06-11T07:44:26.132664Z","steps":["trace[138629336] 'process raft request' (duration: 109.476525ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:30.278544Z","caller":"traceutil/trace.go:171","msg":"trace[919909124] linearizableReadLoop","detail":"{readStateIndex:25702; appliedIndex:25701; }","duration":"112.003671ms","start":"2026-06-11T07:44:30.166508Z","end":"2026-06-11T07:44:30.278512Z","steps":["trace[919909124] 'read index received' (duration: 111.703094ms)","trace[919909124] 'applied index is now lower than readState.Index' (duration: 298.807µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:30.278603Z","caller":"traceutil/trace.go:171","msg":"trace[121427895] transaction","detail":"{read_only:false; response_revision:24889; number_of_response:1; }","duration":"125.846267ms","start":"2026-06-11T07:44:30.15273Z","end":"2026-06-11T07:44:30.278577Z","steps":["trace[121427895] 'process raft request' (duration: 125.552481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:30.278734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.215016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-11T07:44:30.278794Z","caller":"traceutil/trace.go:171","msg":"trace[1220727443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24889; }","duration":"112.318218ms","start":"2026-06-11T07:44:30.166462Z","end":"2026-06-11T07:44:30.27878Z","steps":["trace[1220727443] 'agreement among raft nodes before linearized reading' (duration: 112.157224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:30.278907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.272727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-11T07:44:30.278951Z","caller":"traceutil/trace.go:171","msg":"trace[1404332697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24889; }","duration":"112.450121ms","start":"2026-06-11T07:44:30.166488Z","end":"2026-06-11T07:44:30.278939Z","steps":["trace[1404332697] 'agreement among raft nodes before linearized reading' (duration: 112.200486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:30.567158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.034309ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:30.567265Z","caller":"traceutil/trace.go:171","msg":"trace[820619092] transaction","detail":"{read_only:false; response_revision:24890; number_of_response:1; }","duration":"285.581772ms","start":"2026-06-11T07:44:30.281664Z","end":"2026-06-11T07:44:30.567246Z","steps":["trace[820619092] 'process raft request' (duration: 174.383399ms)","trace[820619092] 'compare' (duration: 110.788644ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:30.569806Z","caller":"traceutil/trace.go:171","msg":"trace[379432147] linearizableReadLoop","detail":"{readStateIndex:25704; appliedIndex:25702; }","duration":"249.470184ms","start":"2026-06-11T07:44:30.320283Z","end":"2026-06-11T07:44:30.569753Z","steps":["trace[379432147] 'read index received' (duration: 135.778006ms)","trace[379432147] 'applied index is now lower than readState.Index' (duration: 113.691128ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:30.570096Z","caller":"traceutil/trace.go:171","msg":"trace[832168526] transaction","detail":"{read_only:false; response_revision:24891; number_of_response:1; }","duration":"288.386733ms","start":"2026-06-11T07:44:30.281698Z","end":"2026-06-11T07:44:30.570085Z","steps":["trace[832168526] 'process raft request' (duration: 287.921183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:30.570453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.18666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-11T07:44:30.570494Z","caller":"traceutil/trace.go:171","msg":"trace[1143859910] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24891; }","duration":"250.277282ms","start":"2026-06-11T07:44:30.320205Z","end":"2026-06-11T07:44:30.570482Z","steps":["trace[1143859910] 'agreement among raft nodes before linearized reading' (duration: 250.140309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:30.570515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.446853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:30.57056Z","caller":"traceutil/trace.go:171","msg":"trace[778618476] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:24891; }","duration":"220.526745ms","start":"2026-06-11T07:44:30.35002Z","end":"2026-06-11T07:44:30.570547Z","steps":["trace[778618476] 'agreement among raft nodes before linearized reading' (duration: 220.444233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:30.57096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.749624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-11T07:44:30.570991Z","caller":"traceutil/trace.go:171","msg":"trace[1947677330] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24891; }","duration":"197.818295ms","start":"2026-06-11T07:44:30.373163Z","end":"2026-06-11T07:44:30.570981Z","steps":["trace[1947677330] 'agreement among raft nodes before linearized reading' (duration: 197.682032ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:30.850669Z","caller":"traceutil/trace.go:171","msg":"trace[1295565901] linearizableReadLoop","detail":"{readStateIndex:25706; appliedIndex:25705; }","duration":"215.76302ms","start":"2026-06-11T07:44:30.634881Z","end":"2026-06-11T07:44:30.850644Z","steps":["trace[1295565901] 'read index received' (duration: 125.397447ms)","trace[1295565901] 'applied index is now lower than readState.Index' (duration: 90.364293ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:30.850759Z","caller":"traceutil/trace.go:171","msg":"trace[1259478599] transaction","detail":"{read_only:false; response_revision:24893; number_of_response:1; }","duration":"276.544961ms","start":"2026-06-11T07:44:30.574188Z","end":"2026-06-11T07:44:30.850733Z","steps":["trace[1259478599] 'process raft request' (duration: 186.093726ms)","trace[1259478599] 'compare' (duration: 90.125508ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:30.850946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.050028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.148\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-11T07:44:30.85098Z","caller":"traceutil/trace.go:171","msg":"trace[1936540436] range","detail":"{range_begin:/registry/masterleases/199.204.45.148; range_end:; response_count:1; response_revision:24893; }","duration":"216.14413ms","start":"2026-06-11T07:44:30.634826Z","end":"2026-06-11T07:44:30.85097Z","steps":["trace[1936540436] 'agreement among raft nodes before linearized reading' (duration: 215.926894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:30.871615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.370759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-11T07:44:30.871692Z","caller":"traceutil/trace.go:171","msg":"trace[920027586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24894; }","duration":"228.462501ms","start":"2026-06-11T07:44:30.643211Z","end":"2026-06-11T07:44:30.871673Z","steps":["trace[920027586] 'agreement among raft nodes before linearized reading' (duration: 228.290177ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:30.871618Z","caller":"traceutil/trace.go:171","msg":"trace[1281326450] transaction","detail":"{read_only:false; response_revision:24894; number_of_response:1; }","duration":"210.328271ms","start":"2026-06-11T07:44:30.661253Z","end":"2026-06-11T07:44:30.871582Z","steps":["trace[1281326450] 'process raft request' (duration: 210.135197ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:31.205138Z","caller":"traceutil/trace.go:171","msg":"trace[1670461416] transaction","detail":"{read_only:false; response_revision:24895; number_of_response:1; }","duration":"329.770006ms","start":"2026-06-11T07:44:30.875342Z","end":"2026-06-11T07:44:31.205112Z","steps":["trace[1670461416] 'process raft request' (duration: 329.596462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:31.205319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:30.875319Z","time spent":"329.91763ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:31.373145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.92495ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:31.373497Z","caller":"traceutil/trace.go:171","msg":"trace[1687627198] transaction","detail":"{read_only:false; response_revision:24896; number_of_response:1; }","duration":"428.360752ms","start":"2026-06-11T07:44:30.945101Z","end":"2026-06-11T07:44:31.373462Z","steps":["trace[1687627198] 'process raft request' (duration: 296.016412ms)","trace[1687627198] 'compare' (duration: 131.814968ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:31.373673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:30.945088Z","time spent":"428.495395ms","remote":"127.0.0.1:56836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:31.373669Z","caller":"traceutil/trace.go:171","msg":"trace[278571578] transaction","detail":"{read_only:false; response_revision:24897; number_of_response:1; }","duration":"363.50571ms","start":"2026-06-11T07:44:31.010132Z","end":"2026-06-11T07:44:31.373638Z","steps":["trace[278571578] 'process raft request' (duration: 363.132932ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:31.373775Z","caller":"traceutil/trace.go:171","msg":"trace[1566430933] transaction","detail":"{read_only:false; response_revision:24898; number_of_response:1; }","duration":"319.085941ms","start":"2026-06-11T07:44:31.054657Z","end":"2026-06-11T07:44:31.373743Z","steps":["trace[1566430933] 'process raft request' (duration: 318.825375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:31.373928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:31.010114Z","time spent":"363.688785ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:31.373933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:31.054617Z","time spent":"319.239104ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:31.374003Z","caller":"traceutil/trace.go:171","msg":"trace[248135739] transaction","detail":"{read_only:false; response_revision:24899; number_of_response:1; }","duration":"252.600503ms","start":"2026-06-11T07:44:31.121382Z","end":"2026-06-11T07:44:31.373983Z","steps":["trace[248135739] 'process raft request' (duration: 252.167483ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:31.374108Z","caller":"traceutil/trace.go:171","msg":"trace[1238238883] transaction","detail":"{read_only:false; response_revision:24900; number_of_response:1; }","duration":"248.647905ms","start":"2026-06-11T07:44:31.125435Z","end":"2026-06-11T07:44:31.374083Z","steps":["trace[1238238883] 'process raft request' (duration: 248.470591ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:31.687779Z","caller":"traceutil/trace.go:171","msg":"trace[2030718374] transaction","detail":"{read_only:false; response_revision:24901; number_of_response:1; }","duration":"183.256473ms","start":"2026-06-11T07:44:31.504497Z","end":"2026-06-11T07:44:31.687754Z","steps":["trace[2030718374] 'process raft request' (duration: 183.11058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:31.938914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.094759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:31.938983Z","caller":"traceutil/trace.go:171","msg":"trace[1331586623] linearizableReadLoop","detail":"{readStateIndex:25716; appliedIndex:25714; }","duration":"278.504864ms","start":"2026-06-11T07:44:31.660466Z","end":"2026-06-11T07:44:31.938971Z","steps":["trace[1331586623] 'read index received' (duration: 27.177809ms)","trace[1331586623] 'applied index is now lower than readState.Index' (duration: 251.326055ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:31.939031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.577456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:31.939049Z","caller":"traceutil/trace.go:171","msg":"trace[1924288034] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:24902; }","duration":"278.595287ms","start":"2026-06-11T07:44:31.660445Z","end":"2026-06-11T07:44:31.939041Z","steps":["trace[1924288034] 'agreement among raft nodes before linearized reading' (duration: 278.554216ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:31.939033Z","caller":"traceutil/trace.go:171","msg":"trace[2093628230] transaction","detail":"{read_only:false; response_revision:24902; number_of_response:1; }","duration":"391.179062ms","start":"2026-06-11T07:44:31.547815Z","end":"2026-06-11T07:44:31.938994Z","steps":["trace[2093628230] 'process raft request' (duration: 246.928199ms)","trace[2093628230] 'compare' (duration: 143.858054ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:31.939164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:31.54779Z","time spent":"391.302094ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:32.395877Z","caller":"traceutil/trace.go:171","msg":"trace[564590255] transaction","detail":"{read_only:false; response_revision:24904; number_of_response:1; }","duration":"112.632075ms","start":"2026-06-11T07:44:32.283222Z","end":"2026-06-11T07:44:32.395855Z","steps":["trace[564590255] 'process raft request' (duration: 112.501953ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:32.849288Z","caller":"traceutil/trace.go:171","msg":"trace[1023799728] linearizableReadLoop","detail":"{readStateIndex:25720; appliedIndex:25719; }","duration":"243.595545ms","start":"2026-06-11T07:44:32.605666Z","end":"2026-06-11T07:44:32.849261Z","steps":["trace[1023799728] 'read index received' (duration: 143.762282ms)","trace[1023799728] 'applied index is now lower than readState.Index' (duration: 99.831853ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:32.849412Z","caller":"traceutil/trace.go:171","msg":"trace[1487655394] transaction","detail":"{read_only:false; response_revision:24906; number_of_response:1; }","duration":"269.078257ms","start":"2026-06-11T07:44:32.580292Z","end":"2026-06-11T07:44:32.84937Z","steps":["trace[1487655394] 'process raft request' (duration: 169.242984ms)","trace[1487655394] 'compare' (duration: 99.568107ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:32.849491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.806409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-11T07:44:32.849523Z","caller":"traceutil/trace.go:171","msg":"trace[1706011060] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24906; }","duration":"243.882971ms","start":"2026-06-11T07:44:32.60563Z","end":"2026-06-11T07:44:32.849513Z","steps":["trace[1706011060] 'agreement among raft nodes before linearized reading' (duration: 243.725298ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:33.110267Z","caller":"traceutil/trace.go:171","msg":"trace[1304123871] transaction","detail":"{read_only:false; response_revision:24907; number_of_response:1; }","duration":"255.755403ms","start":"2026-06-11T07:44:32.854493Z","end":"2026-06-11T07:44:33.110249Z","steps":["trace[1304123871] 'process raft request' (duration: 255.6215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.408483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.807903ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:33.408668Z","caller":"traceutil/trace.go:171","msg":"trace[619403421] linearizableReadLoop","detail":"{readStateIndex:25723; appliedIndex:25720; }","duration":"316.736229ms","start":"2026-06-11T07:44:33.091915Z","end":"2026-06-11T07:44:33.408652Z","steps":["trace[619403421] 'read index received' (duration: 18.268073ms)","trace[619403421] 'applied index is now lower than readState.Index' (duration: 298.466986ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:33.408796Z","caller":"traceutil/trace.go:171","msg":"trace[1415161262] transaction","detail":"{read_only:false; response_revision:24908; number_of_response:1; }","duration":"550.66297ms","start":"2026-06-11T07:44:32.858119Z","end":"2026-06-11T07:44:33.408782Z","steps":["trace[1415161262] 'process raft request' (duration: 391.433227ms)","trace[1415161262] 'compare' (duration: 158.701741ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:33.408873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:32.858104Z","time spent":"550.723502ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:33.409106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.155629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:33.409211Z","caller":"traceutil/trace.go:171","msg":"trace[830656539] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24909; }","duration":"317.320122ms","start":"2026-06-11T07:44:33.091865Z","end":"2026-06-11T07:44:33.409185Z","steps":["trace[830656539] 'agreement among raft nodes before linearized reading' (duration: 317.047446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.409274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:33.091848Z","time spent":"317.410104ms","remote":"127.0.0.1:40760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"info","ts":"2026-06-11T07:44:33.409357Z","caller":"traceutil/trace.go:171","msg":"trace[1200325443] transaction","detail":"{read_only:false; response_revision:24909; number_of_response:1; }","duration":"531.791494ms","start":"2026-06-11T07:44:32.877052Z","end":"2026-06-11T07:44:33.408844Z","steps":["trace[1200325443] 'process raft request' (duration: 531.534088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.40963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:32.877028Z","time spent":"532.460829ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:33.74788Z","caller":"traceutil/trace.go:171","msg":"trace[155479245] transaction","detail":"{read_only:false; response_revision:24911; number_of_response:1; }","duration":"368.267916ms","start":"2026-06-11T07:44:33.379586Z","end":"2026-06-11T07:44:33.747854Z","steps":["trace[155479245] 'process raft request' (duration: 368.042981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.748056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:33.37956Z","time spent":"368.40853ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:33.748135Z","caller":"traceutil/trace.go:171","msg":"trace[1942051291] linearizableReadLoop","detail":"{readStateIndex:25727; appliedIndex:25723; }","duration":"339.366298ms","start":"2026-06-11T07:44:33.40875Z","end":"2026-06-11T07:44:33.748116Z","steps":["trace[1942051291] 'read index received' (duration: 40.875311ms)","trace[1942051291] 'applied index is now lower than readState.Index' (duration: 298.490107ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:33.748195Z","caller":"traceutil/trace.go:171","msg":"trace[1486564635] transaction","detail":"{read_only:false; response_revision:24913; number_of_response:1; }","duration":"367.935829ms","start":"2026-06-11T07:44:33.380244Z","end":"2026-06-11T07:44:33.74818Z","steps":["trace[1486564635] 'process raft request' (duration: 367.764655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.748326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:33.380234Z","time spent":"368.00629ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:33.748376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.29539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-11T07:44:33.748409Z","caller":"traceutil/trace.go:171","msg":"trace[1754429605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24913; }","duration":"539.385352ms","start":"2026-06-11T07:44:33.209018Z","end":"2026-06-11T07:44:33.748403Z","steps":["trace[1754429605] 'agreement among raft nodes before linearized reading' (duration: 539.212578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.748429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:33.208996Z","time spent":"539.428772ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-11T07:44:33.74846Z","caller":"traceutil/trace.go:171","msg":"trace[100916963] transaction","detail":"{read_only:false; response_revision:24912; number_of_response:1; }","duration":"368.815998ms","start":"2026-06-11T07:44:33.379626Z","end":"2026-06-11T07:44:33.748442Z","steps":["trace[100916963] 'process raft request' (duration: 368.163544ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.748575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.150391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-11T07:44:33.748593Z","caller":"traceutil/trace.go:171","msg":"trace[483925551] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:24913; }","duration":"570.212422ms","start":"2026-06-11T07:44:33.178376Z","end":"2026-06-11T07:44:33.748589Z","steps":["trace[483925551] 'agreement among raft nodes before linearized reading' (duration: 570.12044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.748548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:33.379606Z","time spent":"368.89839ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:33.748605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:33.178352Z","time spent":"570.249323ms","remote":"127.0.0.1:57140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":125,"response size":32,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-06-11T07:44:33.748777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.180794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:33.748801Z","caller":"traceutil/trace.go:171","msg":"trace[773906201] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24913; }","duration":"334.203274ms","start":"2026-06-11T07:44:33.414591Z","end":"2026-06-11T07:44:33.748794Z","steps":["trace[773906201] 'agreement among raft nodes before linearized reading' (duration: 334.163694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.748818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:33.414553Z","time spent":"334.260025ms","remote":"127.0.0.1:56998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"warn","ts":"2026-06-11T07:44:33.748929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.791492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:33.748951Z","caller":"traceutil/trace.go:171","msg":"trace[1999604074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24913; }","duration":"220.868394ms","start":"2026-06-11T07:44:33.528077Z","end":"2026-06-11T07:44:33.748946Z","steps":["trace[1999604074] 'agreement among raft nodes before linearized reading' (duration: 220.831143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.748906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.819097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-11T07:44:33.749052Z","caller":"traceutil/trace.go:171","msg":"trace[1028071950] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:24913; }","duration":"504.002141ms","start":"2026-06-11T07:44:33.245024Z","end":"2026-06-11T07:44:33.749026Z","steps":["trace[1028071950] 'agreement among raft nodes before linearized reading' (duration: 503.153572ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:33.749136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:33.245001Z","time spent":"504.119984ms","remote":"127.0.0.1:57284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":39,"response size":32,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-06-11T07:44:34.061578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.651575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:34.061655Z","caller":"traceutil/trace.go:171","msg":"trace[588593529] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24914; }","duration":"184.775548ms","start":"2026-06-11T07:44:33.876861Z","end":"2026-06-11T07:44:34.061636Z","steps":["trace[588593529] 'range keys from in-memory index tree' (duration: 184.549942ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:34.064347Z","caller":"traceutil/trace.go:171","msg":"trace[546334494] transaction","detail":"{read_only:false; response_revision:24915; number_of_response:1; }","duration":"119.854955ms","start":"2026-06-11T07:44:33.94447Z","end":"2026-06-11T07:44:34.064325Z","steps":["trace[546334494] 'process raft request' (duration: 119.539658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:34.370698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.8119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:34.370786Z","caller":"traceutil/trace.go:171","msg":"trace[732450277] transaction","detail":"{read_only:false; response_revision:24916; number_of_response:1; }","duration":"261.623422ms","start":"2026-06-11T07:44:34.109148Z","end":"2026-06-11T07:44:34.370772Z","steps":["trace[732450277] 'process raft request' (duration: 119.66671ms)","trace[732450277] 'compare' (duration: 141.701186ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:34.535088Z","caller":"traceutil/trace.go:171","msg":"trace[1132597316] transaction","detail":"{read_only:false; response_revision:24917; number_of_response:1; }","duration":"208.936001ms","start":"2026-06-11T07:44:34.326132Z","end":"2026-06-11T07:44:34.535068Z","steps":["trace[1132597316] 'process raft request' (duration: 208.805778ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:34.551009Z","caller":"traceutil/trace.go:171","msg":"trace[342725950] transaction","detail":"{read_only:false; response_revision:24918; number_of_response:1; }","duration":"149.609031ms","start":"2026-06-11T07:44:34.401382Z","end":"2026-06-11T07:44:34.550991Z","steps":["trace[342725950] 'process raft request' (duration: 149.493339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:34.905523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.372049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:34.905741Z","caller":"traceutil/trace.go:171","msg":"trace[806161469] transaction","detail":"{read_only:false; response_revision:24919; number_of_response:1; }","duration":"292.988135ms","start":"2026-06-11T07:44:34.612722Z","end":"2026-06-11T07:44:34.90571Z","steps":["trace[806161469] 'process raft request' (duration: 136.921981ms)","trace[806161469] 'compare' (duration: 154.93194ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:35.197001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.602107ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:35.198063Z","caller":"traceutil/trace.go:171","msg":"trace[1214768237] transaction","detail":"{read_only:false; response_revision:24920; number_of_response:1; }","duration":"287.066423ms","start":"2026-06-11T07:44:34.910157Z","end":"2026-06-11T07:44:35.197224Z","steps":["trace[1214768237] 'process raft request' (duration: 139.144049ms)","trace[1214768237] 'compare' (duration: 146.937783ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:35.532037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.597138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-11T07:44:35.532244Z","caller":"traceutil/trace.go:171","msg":"trace[1057348948] transaction","detail":"{read_only:false; response_revision:24922; number_of_response:1; }","duration":"117.026102ms","start":"2026-06-11T07:44:35.415193Z","end":"2026-06-11T07:44:35.532219Z","steps":["trace[1057348948] 'process raft request' (duration: 114.109048ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:35.532491Z","caller":"traceutil/trace.go:171","msg":"trace[1791751007] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24921; }","duration":"118.813482ms","start":"2026-06-11T07:44:35.413377Z","end":"2026-06-11T07:44:35.532191Z","steps":["trace[1791751007] 'range keys from in-memory index tree' (duration: 118.446504ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:35.756581Z","caller":"traceutil/trace.go:171","msg":"trace[35090877] linearizableReadLoop","detail":"{readStateIndex:25737; appliedIndex:25735; }","duration":"228.273597ms","start":"2026-06-11T07:44:35.528281Z","end":"2026-06-11T07:44:35.756554Z","steps":["trace[35090877] 'read index received' (duration: 1.093025ms)","trace[35090877] 'applied index is now lower than readState.Index' (duration: 227.179082ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:35.756733Z","caller":"traceutil/trace.go:171","msg":"trace[1872266576] transaction","detail":"{read_only:false; response_revision:24923; number_of_response:1; }","duration":"302.437893ms","start":"2026-06-11T07:44:35.45427Z","end":"2026-06-11T07:44:35.756708Z","steps":["trace[1872266576] 'process raft request' (duration: 302.088006ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:35.756787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.494431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:35.757086Z","caller":"traceutil/trace.go:171","msg":"trace[1540155282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24923; }","duration":"228.813079ms","start":"2026-06-11T07:44:35.52824Z","end":"2026-06-11T07:44:35.757053Z","steps":["trace[1540155282] 'agreement among raft nodes before linearized reading' (duration: 228.487212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:35.757266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:35.454253Z","time spent":"302.713069ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:35.978848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.521479ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:35.978983Z","caller":"traceutil/trace.go:171","msg":"trace[472364320] transaction","detail":"{read_only:false; response_revision:24924; number_of_response:1; }","duration":"442.32666ms","start":"2026-06-11T07:44:35.536638Z","end":"2026-06-11T07:44:35.978965Z","steps":["trace[472364320] 'process raft request' (duration: 321.609167ms)","trace[472364320] 'compare' (duration: 120.418607ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:35.979042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:35.536614Z","time spent":"442.400131ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:36.162863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.921049ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-11T07:44:36.163507Z","caller":"traceutil/trace.go:171","msg":"trace[1255553001] transaction","detail":"{read_only:false; response_revision:24925; number_of_response:1; }","duration":"409.353113ms","start":"2026-06-11T07:44:35.754131Z","end":"2026-06-11T07:44:36.163485Z","steps":["trace[1255553001] 'process raft request' (duration: 408.797501ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.163831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:35.754099Z","time spent":"409.527746ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:36.314737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.160825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:36.31498Z","caller":"traceutil/trace.go:171","msg":"trace[184377913] linearizableReadLoop","detail":"{readStateIndex:25742; appliedIndex:25737; }","duration":"556.938329ms","start":"2026-06-11T07:44:35.758022Z","end":"2026-06-11T07:44:36.31496Z","steps":["trace[184377913] 'read index received' (duration: 100.15436ms)","trace[184377913] 'applied index is now lower than readState.Index' (duration: 456.782929ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:36.315128Z","caller":"traceutil/trace.go:171","msg":"trace[836169186] transaction","detail":"{read_only:false; response_revision:24927; number_of_response:1; }","duration":"560.706962ms","start":"2026-06-11T07:44:35.754402Z","end":"2026-06-11T07:44:36.315109Z","steps":["trace[836169186] 'process raft request' (duration: 560.443556ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:36.315128Z","caller":"traceutil/trace.go:171","msg":"trace[1474101880] transaction","detail":"{read_only:false; response_revision:24926; number_of_response:1; }","duration":"560.664421ms","start":"2026-06-11T07:44:35.754352Z","end":"2026-06-11T07:44:36.315016Z","steps":["trace[1474101880] 'process raft request' (duration: 409.114797ms)","trace[1474101880] 'compare' (duration: 150.9018ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:36.31562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:35.754326Z","time spent":"561.178681ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:36.315215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:35.754382Z","time spent":"560.786763ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:36.315224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.178814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:36.3158Z","caller":"traceutil/trace.go:171","msg":"trace[554443932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24927; }","duration":"557.758397ms","start":"2026-06-11T07:44:35.757983Z","end":"2026-06-11T07:44:36.315742Z","steps":["trace[554443932] 'agreement among raft nodes before linearized reading' (duration: 557.115113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.316128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:35.757969Z","time spent":"558.137164ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T07:44:36.37562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.564298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:36.375685Z","caller":"traceutil/trace.go:171","msg":"trace[985459959] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:24928; }","duration":"332.677771ms","start":"2026-06-11T07:44:36.042992Z","end":"2026-06-11T07:44:36.37567Z","steps":["trace[985459959] 'agreement among raft nodes before linearized reading' (duration: 332.542918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.375726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:36.042969Z","time spent":"332.746453ms","remote":"127.0.0.1:49230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true "} {"level":"warn","ts":"2026-06-11T07:44:36.37573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.477676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-11T07:44:36.375782Z","caller":"traceutil/trace.go:171","msg":"trace[436144349] transaction","detail":"{read_only:false; response_revision:24928; number_of_response:1; }","duration":"305.547462ms","start":"2026-06-11T07:44:36.070221Z","end":"2026-06-11T07:44:36.375768Z","steps":["trace[436144349] 'process raft request' (duration: 305.185904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.375761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.106022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:36.375854Z","caller":"traceutil/trace.go:171","msg":"trace[172764256] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:24928; }","duration":"537.249974ms","start":"2026-06-11T07:44:35.838584Z","end":"2026-06-11T07:44:36.375834Z","steps":["trace[172764256] 'agreement among raft nodes before linearized reading' (duration: 537.092081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.37588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:36.070203Z","time spent":"305.622433ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:36.375898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:35.838566Z","time spent":"537.320986ms","remote":"127.0.0.1:40516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":30,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true "} {"level":"warn","ts":"2026-06-11T07:44:36.375627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.28153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:36.375949Z","caller":"traceutil/trace.go:171","msg":"trace[1665751322] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:24928; }","duration":"360.652888ms","start":"2026-06-11T07:44:36.015287Z","end":"2026-06-11T07:44:36.37594Z","steps":["trace[1665751322] 'agreement among raft nodes before linearized reading' (duration: 360.265899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.375995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:36.015266Z","time spent":"360.716259ms","remote":"127.0.0.1:56520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-06-11T07:44:36.375798Z","caller":"traceutil/trace.go:171","msg":"trace[494767852] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24928; }","duration":"560.597819ms","start":"2026-06-11T07:44:35.815186Z","end":"2026-06-11T07:44:36.375784Z","steps":["trace[494767852] 'agreement among raft nodes before linearized reading' (duration: 560.386325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.376107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:35.815167Z","time spent":"560.912036ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-11T07:44:36.62258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.825146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:36.622776Z","caller":"traceutil/trace.go:171","msg":"trace[1341352743] linearizableReadLoop","detail":"{readStateIndex:25745; appliedIndex:25743; }","duration":"168.766853ms","start":"2026-06-11T07:44:36.453995Z","end":"2026-06-11T07:44:36.622762Z","steps":["trace[1341352743] 'read index received' (duration: 23.768464ms)","trace[1341352743] 'applied index is now lower than readState.Index' (duration: 144.997319ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:36.622798Z","caller":"traceutil/trace.go:171","msg":"trace[1889233324] transaction","detail":"{read_only:false; response_revision:24929; number_of_response:1; }","duration":"246.745614ms","start":"2026-06-11T07:44:36.376018Z","end":"2026-06-11T07:44:36.622764Z","steps":["trace[1889233324] 'process raft request' (duration: 101.656093ms)","trace[1889233324] 'compare' (duration: 144.614231ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:36.622958Z","caller":"traceutil/trace.go:171","msg":"trace[1506981494] transaction","detail":"{read_only:false; response_revision:24930; number_of_response:1; }","duration":"243.252648ms","start":"2026-06-11T07:44:36.379671Z","end":"2026-06-11T07:44:36.622924Z","steps":["trace[1506981494] 'process raft request' (duration: 243.013913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.623038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.029299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:36.623083Z","caller":"traceutil/trace.go:171","msg":"trace[1175536309] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:24930; }","duration":"169.131901ms","start":"2026-06-11T07:44:36.453941Z","end":"2026-06-11T07:44:36.623072Z","steps":["trace[1175536309] 'agreement among raft nodes before linearized reading' (duration: 169.042229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:36.650649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.410887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:36.65074Z","caller":"traceutil/trace.go:171","msg":"trace[989036333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24931; }","duration":"120.55158ms","start":"2026-06-11T07:44:36.530161Z","end":"2026-06-11T07:44:36.650713Z","steps":["trace[989036333] 'agreement among raft nodes before linearized reading' (duration: 120.401787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:44.14596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.149729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-11T07:44:44.146062Z","caller":"traceutil/trace.go:171","msg":"trace[50972417] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:24985; }","duration":"158.309473ms","start":"2026-06-11T07:44:43.987731Z","end":"2026-06-11T07:44:44.14604Z","steps":["trace[50972417] 'count revisions from in-memory index tree' (duration: 158.058797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:44.146055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.248425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:44.146122Z","caller":"traceutil/trace.go:171","msg":"trace[1250670140] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24985; }","duration":"276.352497ms","start":"2026-06-11T07:44:43.86975Z","end":"2026-06-11T07:44:44.146102Z","steps":["trace[1250670140] 'range keys from in-memory index tree' (duration: 276.189594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:44.146106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.338865ms","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-06-11T07:44:44.146127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.951385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:44.146175Z","caller":"traceutil/trace.go:171","msg":"trace[556866506] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24985; }","duration":"130.421638ms","start":"2026-06-11T07:44:44.015736Z","end":"2026-06-11T07:44:44.146158Z","steps":["trace[556866506] 'range keys from in-memory index tree' (duration: 130.211353ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:44.146218Z","caller":"traceutil/trace.go:171","msg":"trace[391026403] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:24985; }","duration":"211.062348ms","start":"2026-06-11T07:44:43.935133Z","end":"2026-06-11T07:44:44.146195Z","steps":["trace[391026403] 'count revisions from in-memory index tree' (duration: 210.859972ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:44.454026Z","caller":"traceutil/trace.go:171","msg":"trace[229219910] linearizableReadLoop","detail":"{readStateIndex:25803; appliedIndex:25802; }","duration":"218.845289ms","start":"2026-06-11T07:44:44.235149Z","end":"2026-06-11T07:44:44.453995Z","steps":["trace[229219910] 'read index received' (duration: 217.029739ms)","trace[229219910] 'applied index is now lower than readState.Index' (duration: 1.80957ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:44.454028Z","caller":"traceutil/trace.go:171","msg":"trace[1397617280] transaction","detail":"{read_only:false; response_revision:24987; number_of_response:1; }","duration":"259.910744ms","start":"2026-06-11T07:44:44.194084Z","end":"2026-06-11T07:44:44.453995Z","steps":["trace[1397617280] 'process raft request' (duration: 257.90354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:44.454174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.999602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:44.454248Z","caller":"traceutil/trace.go:171","msg":"trace[609807935] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24987; }","duration":"219.107795ms","start":"2026-06-11T07:44:44.235119Z","end":"2026-06-11T07:44:44.454226Z","steps":["trace[609807935] 'agreement among raft nodes before linearized reading' (duration: 218.987282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.060233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.302185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:45.060525Z","caller":"traceutil/trace.go:171","msg":"trace[803124001] transaction","detail":"{read_only:false; response_revision:24992; number_of_response:1; }","duration":"384.120205ms","start":"2026-06-11T07:44:44.676387Z","end":"2026-06-11T07:44:45.060507Z","steps":["trace[803124001] 'process raft request' (duration: 384.066853ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:45.060553Z","caller":"traceutil/trace.go:171","msg":"trace[551805926] linearizableReadLoop","detail":"{readStateIndex:25806; appliedIndex:25803; }","duration":"602.80666ms","start":"2026-06-11T07:44:44.45773Z","end":"2026-06-11T07:44:45.060537Z","steps":["trace[551805926] 'read index received' (duration: 298.124468ms)","trace[551805926] 'applied index is now lower than readState.Index' (duration: 304.680242ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:45.060564Z","caller":"traceutil/trace.go:171","msg":"trace[804896736] transaction","detail":"{read_only:false; response_revision:24988; number_of_response:1; }","duration":"722.327838ms","start":"2026-06-11T07:44:44.33822Z","end":"2026-06-11T07:44:45.060548Z","steps":["trace[804896736] 'process raft request' (duration: 417.630155ms)","trace[804896736] 'compare' (duration: 304.189292ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:45.060536Z","caller":"traceutil/trace.go:171","msg":"trace[1630050995] transaction","detail":"{read_only:false; response_revision:24989; number_of_response:1; }","duration":"718.732109ms","start":"2026-06-11T07:44:44.341742Z","end":"2026-06-11T07:44:45.060474Z","steps":["trace[1630050995] 'process raft request' (duration: 718.582916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.060598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.676362Z","time spent":"384.203027ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:45.060618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.338198Z","time spent":"722.390559ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:45.060594Z","caller":"traceutil/trace.go:171","msg":"trace[1326812751] transaction","detail":"{read_only:false; response_revision:24990; number_of_response:1; }","duration":"636.871042ms","start":"2026-06-11T07:44:44.423689Z","end":"2026-06-11T07:44:45.06056Z","steps":["trace[1326812751] 'process raft request' (duration: 636.684928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.060741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.341733Z","time spent":"718.877552ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:45.060749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.994794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-11T07:44:45.060757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.612511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-11T07:44:45.060785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.423666Z","time spent":"637.041646ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:45.060816Z","caller":"traceutil/trace.go:171","msg":"trace[223634689] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24992; }","duration":"401.702643ms","start":"2026-06-11T07:44:44.659106Z","end":"2026-06-11T07:44:45.060809Z","steps":["trace[223634689] 'agreement among raft nodes before linearized reading' (duration: 401.54108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.060785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.309967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:45.060614Z","caller":"traceutil/trace.go:171","msg":"trace[387982947] transaction","detail":"{read_only:false; response_revision:24991; number_of_response:1; }","duration":"406.659273ms","start":"2026-06-11T07:44:44.65391Z","end":"2026-06-11T07:44:45.060569Z","steps":["trace[387982947] 'process raft request' (duration: 406.50564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.060842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.659092Z","time spent":"401.743384ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-11T07:44:45.06085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.842992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-11T07:44:45.06084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.895343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:45.060876Z","caller":"traceutil/trace.go:171","msg":"trace[329068129] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:24992; }","duration":"562.43362ms","start":"2026-06-11T07:44:44.498416Z","end":"2026-06-11T07:44:45.06085Z","steps":["trace[329068129] 'agreement among raft nodes before linearized reading' (duration: 562.227566ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:45.060936Z","caller":"traceutil/trace.go:171","msg":"trace[1837396942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24992; }","duration":"108.949193ms","start":"2026-06-11T07:44:44.95196Z","end":"2026-06-11T07:44:45.060909Z","steps":["trace[1837396942] 'agreement among raft nodes before linearized reading' (duration: 108.773139ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:45.060948Z","caller":"traceutil/trace.go:171","msg":"trace[611138697] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:24992; }","duration":"477.077067ms","start":"2026-06-11T07:44:44.583847Z","end":"2026-06-11T07:44:45.060924Z","steps":["trace[611138697] 'agreement among raft nodes before linearized reading' (duration: 476.859412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.060989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.4984Z","time spent":"562.566903ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-06-11T07:44:45.061002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.583825Z","time spent":"477.166888ms","remote":"127.0.0.1:54992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-06-11T07:44:45.060797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.152983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:45.061051Z","caller":"traceutil/trace.go:171","msg":"trace[1855614363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24992; }","duration":"533.46285ms","start":"2026-06-11T07:44:44.527577Z","end":"2026-06-11T07:44:45.06104Z","steps":["trace[1855614363] 'agreement among raft nodes before linearized reading' (duration: 533.143933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.061077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.527556Z","time spent":"533.513891ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T07:44:45.061069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.653877Z","time spent":"407.01947ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:45.060817Z","caller":"traceutil/trace.go:171","msg":"trace[2004142993] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24992; }","duration":"603.104767ms","start":"2026-06-11T07:44:44.457697Z","end":"2026-06-11T07:44:45.060802Z","steps":["trace[2004142993] 'agreement among raft nodes before linearized reading' (duration: 602.934073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.061174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:44.457681Z","time spent":"603.480005ms","remote":"127.0.0.1:56998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-11T07:44:45.354754Z","caller":"traceutil/trace.go:171","msg":"trace[1422825030] transaction","detail":"{read_only:false; response_revision:24993; number_of_response:1; }","duration":"289.262293ms","start":"2026-06-11T07:44:45.065428Z","end":"2026-06-11T07:44:45.35469Z","steps":["trace[1422825030] 'process raft request' (duration: 198.344856ms)","trace[1422825030] 'compare' (duration: 90.769324ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:45.65908Z","caller":"traceutil/trace.go:171","msg":"trace[1875408190] transaction","detail":"{read_only:false; response_revision:24994; number_of_response:1; }","duration":"593.342472ms","start":"2026-06-11T07:44:45.065706Z","end":"2026-06-11T07:44:45.659049Z","steps":["trace[1875408190] 'process raft request' (duration: 572.584894ms)","trace[1875408190] 'compare' (duration: 20.554243ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:45.65923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:45.065689Z","time spent":"593.462805ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:45.659231Z","caller":"traceutil/trace.go:171","msg":"trace[1042931816] linearizableReadLoop","detail":"{readStateIndex:25810; appliedIndex:25808; }","duration":"593.168278ms","start":"2026-06-11T07:44:45.066036Z","end":"2026-06-11T07:44:45.659204Z","steps":["trace[1042931816] 'read index received' (duration: 197.801043ms)","trace[1042931816] 'applied index is now lower than readState.Index' (duration: 395.365625ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:45.659813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.335882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-11T07:44:45.659837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.95816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:45.659881Z","caller":"traceutil/trace.go:171","msg":"trace[213074085] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:24995; }","duration":"215.443743ms","start":"2026-06-11T07:44:45.44442Z","end":"2026-06-11T07:44:45.659863Z","steps":["trace[213074085] 'agreement among raft nodes before linearized reading' (duration: 215.325851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.659875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.273225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-11T07:44:45.65992Z","caller":"traceutil/trace.go:171","msg":"trace[1015695463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24995; }","duration":"131.084213ms","start":"2026-06-11T07:44:45.528814Z","end":"2026-06-11T07:44:45.659898Z","steps":["trace[1015695463] 'agreement among raft nodes before linearized reading' (duration: 130.95631ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:45.659936Z","caller":"traceutil/trace.go:171","msg":"trace[1001211262] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:24995; }","duration":"426.365677ms","start":"2026-06-11T07:44:45.233554Z","end":"2026-06-11T07:44:45.65992Z","steps":["trace[1001211262] 'agreement among raft nodes before linearized reading' (duration: 426.178313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.659983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:45.233538Z","time spent":"426.435338ms","remote":"127.0.0.1:57042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":77,"response size":32,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-06-11T07:44:45.65987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.29669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-11T07:44:45.660041Z","caller":"traceutil/trace.go:171","msg":"trace[281794593] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24995; }","duration":"389.474604ms","start":"2026-06-11T07:44:45.270549Z","end":"2026-06-11T07:44:45.660024Z","steps":["trace[281794593] 'agreement among raft nodes before linearized reading' (duration: 389.199438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.660146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:45.270516Z","time spent":"389.581415ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T07:44:45.660367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.337194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-11T07:44:45.660407Z","caller":"traceutil/trace.go:171","msg":"trace[1642653924] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24995; }","duration":"594.435136ms","start":"2026-06-11T07:44:45.065962Z","end":"2026-06-11T07:44:45.660397Z","steps":["trace[1642653924] 'agreement among raft nodes before linearized reading' (duration: 593.353082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.660435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:45.06594Z","time spent":"594.488746ms","remote":"127.0.0.1:56992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12241,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-11T07:44:45.661004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.976628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-11T07:44:45.661166Z","caller":"traceutil/trace.go:171","msg":"trace[591625671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24995; }","duration":"421.621872ms","start":"2026-06-11T07:44:45.239523Z","end":"2026-06-11T07:44:45.661145Z","steps":["trace[591625671] 'agreement among raft nodes before linearized reading' (duration: 420.252632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:45.661311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:45.239503Z","time spent":"421.767576ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T07:44:46.030263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.039094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:46.030326Z","caller":"traceutil/trace.go:171","msg":"trace[1550810424] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:24997; }","duration":"244.146337ms","start":"2026-06-11T07:44:45.78616Z","end":"2026-06-11T07:44:46.030306Z","steps":["trace[1550810424] 'count revisions from in-memory index tree' (duration: 243.82198ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:46.030304Z","caller":"traceutil/trace.go:171","msg":"trace[1551217913] transaction","detail":"{read_only:false; response_revision:24998; number_of_response:1; }","duration":"161.296088ms","start":"2026-06-11T07:44:45.868987Z","end":"2026-06-11T07:44:46.030283Z","steps":["trace[1551217913] 'process raft request' (duration: 156.150865ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:49.319225Z","caller":"traceutil/trace.go:171","msg":"trace[501966425] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"239.964585ms","start":"2026-06-11T07:44:49.079228Z","end":"2026-06-11T07:44:49.319192Z","steps":["trace[501966425] 'process raft request' (duration: 239.23569ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:49.319289Z","caller":"traceutil/trace.go:171","msg":"trace[1360423177] linearizableReadLoop","detail":"{readStateIndex:25897; appliedIndex:25893; }","duration":"116.121042ms","start":"2026-06-11T07:44:49.203144Z","end":"2026-06-11T07:44:49.319265Z","steps":["trace[1360423177] 'read index received' (duration: 115.261763ms)","trace[1360423177] 'applied index is now lower than readState.Index' (duration: 858.399µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:49.319445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.276125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:49.319486Z","caller":"traceutil/trace.go:171","msg":"trace[885785867] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:25079; }","duration":"116.361696ms","start":"2026-06-11T07:44:49.203112Z","end":"2026-06-11T07:44:49.319474Z","steps":["trace[885785867] 'agreement among raft nodes before linearized reading' (duration: 116.255324ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:49.319713Z","caller":"traceutil/trace.go:171","msg":"trace[1937907868] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"239.31489ms","start":"2026-06-11T07:44:49.080384Z","end":"2026-06-11T07:44:49.319699Z","steps":["trace[1937907868] 'process raft request' (duration: 238.84242ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:49.319751Z","caller":"traceutil/trace.go:171","msg":"trace[473574896] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"240.402575ms","start":"2026-06-11T07:44:49.079305Z","end":"2026-06-11T07:44:49.319708Z","steps":["trace[473574896] 'process raft request' (duration: 239.781731ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:49.319759Z","caller":"traceutil/trace.go:171","msg":"trace[1474044031] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"239.463813ms","start":"2026-06-11T07:44:49.080233Z","end":"2026-06-11T07:44:49.319697Z","steps":["trace[1474044031] 'process raft request' (duration: 238.956762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:54.403699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.411548ms","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:8"} {"level":"info","ts":"2026-06-11T07:44:54.4038Z","caller":"traceutil/trace.go:171","msg":"trace[1988306883] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:25139; }","duration":"169.595152ms","start":"2026-06-11T07:44:54.234179Z","end":"2026-06-11T07:44:54.403774Z","steps":["trace[1988306883] 'count revisions from in-memory index tree' (duration: 169.206663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:54.403811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.822995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-11T07:44:54.403863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.513997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:54.403946Z","caller":"traceutil/trace.go:171","msg":"trace[1459404326] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25139; }","duration":"158.799133ms","start":"2026-06-11T07:44:54.245126Z","end":"2026-06-11T07:44:54.403925Z","steps":["trace[1459404326] 'count revisions from in-memory index tree' (duration: 158.402164ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:54.404044Z","caller":"traceutil/trace.go:171","msg":"trace[2112136053] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25139; }","duration":"202.977628ms","start":"2026-06-11T07:44:54.200924Z","end":"2026-06-11T07:44:54.403902Z","steps":["trace[2112136053] 'range keys from in-memory index tree' (duration: 202.663051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:54.404011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.939355ms","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-06-11T07:44:54.404139Z","caller":"traceutil/trace.go:171","msg":"trace[242148913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25139; }","duration":"187.129669ms","start":"2026-06-11T07:44:54.216987Z","end":"2026-06-11T07:44:54.404117Z","steps":["trace[242148913] 'range keys from in-memory index tree' (duration: 186.751569ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:54.548942Z","caller":"traceutil/trace.go:171","msg":"trace[1640148982] linearizableReadLoop","detail":"{readStateIndex:25960; appliedIndex:25959; }","duration":"137.946363ms","start":"2026-06-11T07:44:54.410961Z","end":"2026-06-11T07:44:54.548908Z","steps":["trace[1640148982] 'read index received' (duration: 137.362401ms)","trace[1640148982] 'applied index is now lower than readState.Index' (duration: 582.412µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:54.549081Z","caller":"traceutil/trace.go:171","msg":"trace[941175276] transaction","detail":"{read_only:false; response_revision:25140; number_of_response:1; }","duration":"139.805225ms","start":"2026-06-11T07:44:54.409246Z","end":"2026-06-11T07:44:54.549051Z","steps":["trace[941175276] 'process raft request' (duration: 139.07829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:54.549172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.187999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:54.549253Z","caller":"traceutil/trace.go:171","msg":"trace[584008934] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25140; }","duration":"138.339232ms","start":"2026-06-11T07:44:54.410899Z","end":"2026-06-11T07:44:54.549238Z","steps":["trace[584008934] 'agreement among raft nodes before linearized reading' (duration: 138.155908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:54.847608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.25376ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:54.847696Z","caller":"traceutil/trace.go:171","msg":"trace[2036017850] linearizableReadLoop","detail":"{readStateIndex:25961; appliedIndex:25960; }","duration":"298.65095ms","start":"2026-06-11T07:44:54.549031Z","end":"2026-06-11T07:44:54.847682Z","steps":["trace[2036017850] 'read index received' (duration: 136.170985ms)","trace[2036017850] 'applied index is now lower than readState.Index' (duration: 162.479205ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:54.847809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.326859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:44:54.847834Z","caller":"traceutil/trace.go:171","msg":"trace[682003039] transaction","detail":"{read_only:false; response_revision:25141; number_of_response:1; }","duration":"359.810419ms","start":"2026-06-11T07:44:54.487985Z","end":"2026-06-11T07:44:54.847796Z","steps":["trace[682003039] 'process raft request' (duration: 197.296473ms)","trace[682003039] 'compare' (duration: 162.082777ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:44:54.847889Z","caller":"traceutil/trace.go:171","msg":"trace[230656914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25141; }","duration":"320.463472ms","start":"2026-06-11T07:44:54.527408Z","end":"2026-06-11T07:44:54.847872Z","steps":["trace[230656914] 'agreement among raft nodes before linearized reading' (duration: 320.334969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:54.847935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:54.527385Z","time spent":"320.541123ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T07:44:54.847979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:54.487953Z","time spent":"359.945572ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:44:58.870958Z","caller":"traceutil/trace.go:171","msg":"trace[1763870980] transaction","detail":"{read_only:false; response_revision:25173; number_of_response:1; }","duration":"305.380808ms","start":"2026-06-11T07:44:58.565557Z","end":"2026-06-11T07:44:58.870938Z","steps":["trace[1763870980] 'process raft request' (duration: 305.219035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:44:58.87109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:58.565541Z","time spent":"305.4805ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:44:59.009234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.31939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:44:59.009435Z","caller":"traceutil/trace.go:171","msg":"trace[433536530] transaction","detail":"{read_only:false; response_revision:25175; number_of_response:1; }","duration":"148.327293ms","start":"2026-06-11T07:44:58.861087Z","end":"2026-06-11T07:44:59.009414Z","steps":["trace[433536530] 'process raft request' (duration: 148.251902ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:44:59.009471Z","caller":"traceutil/trace.go:171","msg":"trace[930225594] transaction","detail":"{read_only:false; response_revision:25174; number_of_response:1; }","duration":"383.899451ms","start":"2026-06-11T07:44:58.625544Z","end":"2026-06-11T07:44:59.009444Z","steps":["trace[930225594] 'process raft request' (duration: 275.283534ms)","trace[930225594] 'compare' (duration: 108.163407ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:44:59.009619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:44:58.625522Z","time spent":"384.015133ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:45:00.316116Z","caller":"traceutil/trace.go:171","msg":"trace[383061001] transaction","detail":"{read_only:false; response_revision:25186; number_of_response:1; }","duration":"209.611365ms","start":"2026-06-11T07:45:00.106466Z","end":"2026-06-11T07:45:00.316077Z","steps":["trace[383061001] 'process raft request' (duration: 209.487992ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:00.41591Z","caller":"traceutil/trace.go:171","msg":"trace[968799174] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"208.873498ms","start":"2026-06-11T07:45:00.207005Z","end":"2026-06-11T07:45:00.415878Z","steps":["trace[968799174] 'process raft request' (duration: 208.809647ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:00.415979Z","caller":"traceutil/trace.go:171","msg":"trace[739404497] transaction","detail":"{read_only:false; response_revision:25187; number_of_response:1; }","duration":"282.870352ms","start":"2026-06-11T07:45:00.133074Z","end":"2026-06-11T07:45:00.415945Z","steps":["trace[739404497] 'process raft request' (duration: 235.65805ms)","trace[739404497] 'compare' (duration: 46.931856ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:00.431569Z","caller":"traceutil/trace.go:171","msg":"trace[1319759788] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"110.606811ms","start":"2026-06-11T07:45:00.320937Z","end":"2026-06-11T07:45:00.431543Z","steps":["trace[1319759788] 'process raft request' (duration: 110.275264ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:00.431687Z","caller":"traceutil/trace.go:171","msg":"trace[1214278808] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"110.186381ms","start":"2026-06-11T07:45:00.321481Z","end":"2026-06-11T07:45:00.431668Z","steps":["trace[1214278808] 'process raft request' (duration: 109.861414ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:00.431869Z","caller":"traceutil/trace.go:171","msg":"trace[1805022034] transaction","detail":"{read_only:false; response_revision:25191; number_of_response:1; }","duration":"108.118316ms","start":"2026-06-11T07:45:00.323739Z","end":"2026-06-11T07:45:00.431857Z","steps":["trace[1805022034] 'process raft request' (duration: 107.84673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:03.664485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.803074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-11T07:45:03.665358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.720247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:45:03.665429Z","caller":"traceutil/trace.go:171","msg":"trace[982184334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25227; }","duration":"136.83735ms","start":"2026-06-11T07:45:03.528573Z","end":"2026-06-11T07:45:03.66541Z","steps":["trace[982184334] 'range keys from in-memory index tree' (duration: 136.597994ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:03.664583Z","caller":"traceutil/trace.go:171","msg":"trace[1490302859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25227; }","duration":"187.949807ms","start":"2026-06-11T07:45:03.476612Z","end":"2026-06-11T07:45:03.664562Z","steps":["trace[1490302859] 'range keys from in-memory index tree' (duration: 187.659831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:08.735245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.383877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-11T07:45:08.73536Z","caller":"traceutil/trace.go:171","msg":"trace[1656570557] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25268; }","duration":"101.548991ms","start":"2026-06-11T07:45:08.633782Z","end":"2026-06-11T07:45:08.735331Z","steps":["trace[1656570557] 'range keys from in-memory index tree' (duration: 101.187833ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:10.726989Z","caller":"traceutil/trace.go:171","msg":"trace[1207872379] transaction","detail":"{read_only:false; response_revision:25289; number_of_response:1; }","duration":"195.146976ms","start":"2026-06-11T07:45:10.531815Z","end":"2026-06-11T07:45:10.726962Z","steps":["trace[1207872379] 'process raft request' (duration: 194.687116ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:18.969998Z","caller":"traceutil/trace.go:171","msg":"trace[2109253060] transaction","detail":"{read_only:false; response_revision:25369; number_of_response:1; }","duration":"219.688927ms","start":"2026-06-11T07:45:18.750284Z","end":"2026-06-11T07:45:18.969972Z","steps":["trace[2109253060] 'process raft request' (duration: 219.521123ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:19.0873Z","caller":"traceutil/trace.go:171","msg":"trace[587434159] transaction","detail":"{read_only:false; response_revision:25370; number_of_response:1; }","duration":"101.701263ms","start":"2026-06-11T07:45:18.985555Z","end":"2026-06-11T07:45:19.087257Z","steps":["trace[587434159] 'process raft request' (duration: 64.472072ms)","trace[587434159] 'compare' (duration: 37.105229ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:45:19.347116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.808848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:45:19.34727Z","caller":"traceutil/trace.go:171","msg":"trace[1206013096] transaction","detail":"{read_only:false; response_revision:25372; number_of_response:1; }","duration":"107.770167ms","start":"2026-06-11T07:45:19.239485Z","end":"2026-06-11T07:45:19.347255Z","steps":["trace[1206013096] 'process raft request' (duration: 107.720266ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:19.347279Z","caller":"traceutil/trace.go:171","msg":"trace[907578900] linearizableReadLoop","detail":"{readStateIndex:26196; appliedIndex:26195; }","duration":"242.158202ms","start":"2026-06-11T07:45:19.105099Z","end":"2026-06-11T07:45:19.347257Z","steps":["trace[907578900] 'read index received' (duration: 86.075008ms)","trace[907578900] 'applied index is now lower than readState.Index' (duration: 156.081824ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:19.347367Z","caller":"traceutil/trace.go:171","msg":"trace[1375207289] transaction","detail":"{read_only:false; response_revision:25371; number_of_response:1; }","duration":"256.424918ms","start":"2026-06-11T07:45:19.090933Z","end":"2026-06-11T07:45:19.347358Z","steps":["trace[1375207289] 'process raft request' (duration: 100.288422ms)","trace[1375207289] 'compare' (duration: 155.40017ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:45:19.347509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.403778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:45:19.347545Z","caller":"traceutil/trace.go:171","msg":"trace[1905875653] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:25372; }","duration":"242.482119ms","start":"2026-06-11T07:45:19.105054Z","end":"2026-06-11T07:45:19.347536Z","steps":["trace[1905875653] 'agreement among raft nodes before linearized reading' (duration: 242.422828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:19.363293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.83622ms","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:6"} {"level":"info","ts":"2026-06-11T07:45:19.363385Z","caller":"traceutil/trace.go:171","msg":"trace[698624584] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25373; }","duration":"141.953113ms","start":"2026-06-11T07:45:19.221397Z","end":"2026-06-11T07:45:19.36335Z","steps":["trace[698624584] 'agreement among raft nodes before linearized reading' (duration: 141.471552ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:19.654421Z","caller":"traceutil/trace.go:171","msg":"trace[1805182974] transaction","detail":"{read_only:false; response_revision:25374; number_of_response:1; }","duration":"237.569652ms","start":"2026-06-11T07:45:19.416832Z","end":"2026-06-11T07:45:19.654402Z","steps":["trace[1805182974] 'process raft request' (duration: 237.384798ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:19.702949Z","caller":"traceutil/trace.go:171","msg":"trace[1529476199] transaction","detail":"{read_only:false; response_revision:25375; number_of_response:1; }","duration":"284.127359ms","start":"2026-06-11T07:45:19.418801Z","end":"2026-06-11T07:45:19.702928Z","steps":["trace[1529476199] 'process raft request' (duration: 283.983766ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:19.703115Z","caller":"traceutil/trace.go:171","msg":"trace[2083238762] transaction","detail":"{read_only:false; response_revision:25376; number_of_response:1; }","duration":"279.881115ms","start":"2026-06-11T07:45:19.423226Z","end":"2026-06-11T07:45:19.703107Z","steps":["trace[2083238762] 'process raft request' (duration: 279.672421ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:19.703215Z","caller":"traceutil/trace.go:171","msg":"trace[1761321687] linearizableReadLoop","detail":"{readStateIndex:26202; appliedIndex:26198; }","duration":"175.566323ms","start":"2026-06-11T07:45:19.527643Z","end":"2026-06-11T07:45:19.703209Z","steps":["trace[1761321687] 'read index received' (duration: 126.643534ms)","trace[1761321687] 'applied index is now lower than readState.Index' (duration: 48.922309ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:45:19.703272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.617754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:45:19.703291Z","caller":"traceutil/trace.go:171","msg":"trace[600718748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25377; }","duration":"175.684086ms","start":"2026-06-11T07:45:19.527601Z","end":"2026-06-11T07:45:19.703285Z","steps":["trace[600718748] 'agreement among raft nodes before linearized reading' (duration: 175.627545ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:19.703352Z","caller":"traceutil/trace.go:171","msg":"trace[1903169605] transaction","detail":"{read_only:false; response_revision:25377; number_of_response:1; }","duration":"262.012141ms","start":"2026-06-11T07:45:19.441316Z","end":"2026-06-11T07:45:19.703328Z","steps":["trace[1903169605] 'process raft request' (duration: 261.765986ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:19.987636Z","caller":"traceutil/trace.go:171","msg":"trace[686922914] linearizableReadLoop","detail":"{readStateIndex:26204; appliedIndex:26203; }","duration":"164.648683ms","start":"2026-06-11T07:45:19.822959Z","end":"2026-06-11T07:45:19.987608Z","steps":["trace[686922914] 'read index received' (duration: 164.434258ms)","trace[686922914] 'applied index is now lower than readState.Index' (duration: 213.605µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:19.987722Z","caller":"traceutil/trace.go:171","msg":"trace[70194024] transaction","detail":"{read_only:false; response_revision:25379; number_of_response:1; }","duration":"179.154053ms","start":"2026-06-11T07:45:19.808522Z","end":"2026-06-11T07:45:19.987676Z","steps":["trace[70194024] 'process raft request' (duration: 178.934839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:19.987879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.908329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-11T07:45:19.987925Z","caller":"traceutil/trace.go:171","msg":"trace[504809376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25379; }","duration":"164.99993ms","start":"2026-06-11T07:45:19.822912Z","end":"2026-06-11T07:45:19.987912Z","steps":["trace[504809376] 'agreement among raft nodes before linearized reading' (duration: 164.825857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:19.988049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.789338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-11T07:45:19.988155Z","caller":"traceutil/trace.go:171","msg":"trace[440684728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25379; }","duration":"155.978852ms","start":"2026-06-11T07:45:19.832155Z","end":"2026-06-11T07:45:19.988134Z","steps":["trace[440684728] 'agreement among raft nodes before linearized reading' (duration: 155.666605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:19.98817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.805235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T07:45:19.98823Z","caller":"traceutil/trace.go:171","msg":"trace[518255057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25379; }","duration":"105.898697ms","start":"2026-06-11T07:45:19.882317Z","end":"2026-06-11T07:45:19.988216Z","steps":["trace[518255057] 'agreement among raft nodes before linearized reading' (duration: 105.761844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:19.988054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.629501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-11T07:45:19.98832Z","caller":"traceutil/trace.go:171","msg":"trace[334784998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25379; }","duration":"105.931528ms","start":"2026-06-11T07:45:19.882378Z","end":"2026-06-11T07:45:19.988309Z","steps":["trace[334784998] 'agreement among raft nodes before linearized reading' (duration: 105.535309ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:20.18218Z","caller":"traceutil/trace.go:171","msg":"trace[489033609] transaction","detail":"{read_only:false; response_revision:25381; number_of_response:1; }","duration":"185.84355ms","start":"2026-06-11T07:45:19.996311Z","end":"2026-06-11T07:45:20.182154Z","steps":["trace[489033609] 'process raft request' (duration: 118.282429ms)","trace[489033609] 'compare' (duration: 67.266915ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:20.182198Z","caller":"traceutil/trace.go:171","msg":"trace[1608071795] transaction","detail":"{read_only:false; response_revision:25382; number_of_response:1; }","duration":"185.721747ms","start":"2026-06-11T07:45:19.996453Z","end":"2026-06-11T07:45:20.182175Z","steps":["trace[1608071795] 'process raft request' (duration: 185.583094ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:20.182322Z","caller":"traceutil/trace.go:171","msg":"trace[77587197] transaction","detail":"{read_only:false; response_revision:25383; number_of_response:1; }","duration":"184.376678ms","start":"2026-06-11T07:45:19.997936Z","end":"2026-06-11T07:45:20.182313Z","steps":["trace[77587197] 'process raft request' (duration: 184.207645ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:22.52923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.141501ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:45:22.529659Z","caller":"traceutil/trace.go:171","msg":"trace[1523251137] transaction","detail":"{read_only:false; response_revision:25399; number_of_response:1; }","duration":"339.971271ms","start":"2026-06-11T07:45:22.189646Z","end":"2026-06-11T07:45:22.529617Z","steps":["trace[1523251137] 'process raft request' (duration: 205.36163ms)","trace[1523251137] 'compare' (duration: 134.044179ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:45:22.529797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:22.18963Z","time spent":"340.095114ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:45:22.529835Z","caller":"traceutil/trace.go:171","msg":"trace[810536639] transaction","detail":"{read_only:false; response_revision:25400; number_of_response:1; }","duration":"340.142085ms","start":"2026-06-11T07:45:22.189659Z","end":"2026-06-11T07:45:22.529801Z","steps":["trace[810536639] 'process raft request' (duration: 339.637094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:22.53002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:22.189623Z","time spent":"340.299398ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:45:22.87322Z","caller":"traceutil/trace.go:171","msg":"trace[665568393] linearizableReadLoop","detail":"{readStateIndex:26227; appliedIndex:26226; }","duration":"169.47033ms","start":"2026-06-11T07:45:22.703729Z","end":"2026-06-11T07:45:22.873199Z","steps":["trace[665568393] 'read index received' (duration: 169.279486ms)","trace[665568393] 'applied index is now lower than readState.Index' (duration: 189.764µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:22.873167Z","caller":"traceutil/trace.go:171","msg":"trace[874161295] transaction","detail":"{read_only:false; response_revision:25401; number_of_response:1; }","duration":"169.829348ms","start":"2026-06-11T07:45:22.703307Z","end":"2026-06-11T07:45:22.873136Z","steps":["trace[874161295] 'process raft request' (duration: 169.566122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:22.873328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.571352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:45:22.873758Z","caller":"traceutil/trace.go:171","msg":"trace[916499022] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:25401; }","duration":"169.837038ms","start":"2026-06-11T07:45:22.703686Z","end":"2026-06-11T07:45:22.873523Z","steps":["trace[916499022] 'agreement among raft nodes before linearized reading' (duration: 169.560812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:38.388109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.137122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-11T07:45:38.38823Z","caller":"traceutil/trace.go:171","msg":"trace[1635094327] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25511; }","duration":"261.259725ms","start":"2026-06-11T07:45:38.126944Z","end":"2026-06-11T07:45:38.388204Z","steps":["trace[1635094327] 'range keys from in-memory index tree' (duration: 260.987378ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:38.585811Z","caller":"traceutil/trace.go:171","msg":"trace[1392681328] transaction","detail":"{read_only:false; response_revision:25512; number_of_response:1; }","duration":"193.93033ms","start":"2026-06-11T07:45:38.391853Z","end":"2026-06-11T07:45:38.585783Z","steps":["trace[1392681328] 'process raft request' (duration: 193.773227ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:39.026489Z","caller":"traceutil/trace.go:171","msg":"trace[1948260556] linearizableReadLoop","detail":"{readStateIndex:26342; appliedIndex:26340; }","duration":"577.631525ms","start":"2026-06-11T07:45:38.448825Z","end":"2026-06-11T07:45:39.026457Z","steps":["trace[1948260556] 'read index received' (duration: 136.816919ms)","trace[1948260556] 'applied index is now lower than readState.Index' (duration: 440.813386ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:39.02652Z","caller":"traceutil/trace.go:171","msg":"trace[1674164463] transaction","detail":"{read_only:false; response_revision:25513; number_of_response:1; }","duration":"632.454365ms","start":"2026-06-11T07:45:38.394046Z","end":"2026-06-11T07:45:39.026501Z","steps":["trace[1674164463] 'process raft request' (duration: 632.25399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.026605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.763138ms","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:6"} {"level":"info","ts":"2026-06-11T07:45:39.026634Z","caller":"traceutil/trace.go:171","msg":"trace[1404379067] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:25513; }","duration":"577.83084ms","start":"2026-06-11T07:45:38.448794Z","end":"2026-06-11T07:45:39.026625Z","steps":["trace[1404379067] 'agreement among raft nodes before linearized reading' (duration: 577.762178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.026662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:38.448768Z","time spent":"577.888021ms","remote":"127.0.0.1:43230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-06-11T07:45:39.026676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:38.394025Z","time spent":"632.571338ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:45:39.026781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.755965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:45:39.026855Z","caller":"traceutil/trace.go:171","msg":"trace[2140004902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25513; }","duration":"498.873087ms","start":"2026-06-11T07:45:38.527961Z","end":"2026-06-11T07:45:39.026834Z","steps":["trace[2140004902] 'agreement among raft nodes before linearized reading' (duration: 498.752394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.026901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:38.527945Z","time spent":"498.949189ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T07:45:39.026945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.982847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-11T07:45:39.026981Z","caller":"traceutil/trace.go:171","msg":"trace[1503032962] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25513; }","duration":"260.050458ms","start":"2026-06-11T07:45:38.766919Z","end":"2026-06-11T07:45:39.026969Z","steps":["trace[1503032962] 'agreement among raft nodes before linearized reading' (duration: 259.929505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.027062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.76623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-11T07:45:39.027165Z","caller":"traceutil/trace.go:171","msg":"trace[2062329216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25513; }","duration":"428.907614ms","start":"2026-06-11T07:45:38.59823Z","end":"2026-06-11T07:45:39.027137Z","steps":["trace[2062329216] 'agreement among raft nodes before linearized reading' (duration: 428.623997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.027226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:38.598213Z","time spent":"428.998475ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T07:45:39.027021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.502451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-11T07:45:39.027348Z","caller":"traceutil/trace.go:171","msg":"trace[303177737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25513; }","duration":"426.965561ms","start":"2026-06-11T07:45:38.600363Z","end":"2026-06-11T07:45:39.027329Z","steps":["trace[303177737] 'agreement among raft nodes before linearized reading' (duration: 426.379778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.027391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:38.600353Z","time spent":"427.025522ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T07:45:39.500497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.999706ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-11T07:45:39.500651Z","caller":"traceutil/trace.go:171","msg":"trace[277555787] linearizableReadLoop","detail":"{readStateIndex:26346; appliedIndex:26343; }","duration":"322.847413ms","start":"2026-06-11T07:45:39.177792Z","end":"2026-06-11T07:45:39.500639Z","steps":["trace[277555787] 'read index received' (duration: 53.111µs)","trace[277555787] 'applied index is now lower than readState.Index' (duration: 322.793702ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:39.500658Z","caller":"traceutil/trace.go:171","msg":"trace[611642402] transaction","detail":"{read_only:false; response_revision:25515; number_of_response:1; }","duration":"467.615858ms","start":"2026-06-11T07:45:39.033022Z","end":"2026-06-11T07:45:39.500638Z","steps":["trace[611642402] 'process raft request' (duration: 135.410239ms)","trace[611642402] 'compare' (duration: 331.882222ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:39.500723Z","caller":"traceutil/trace.go:171","msg":"trace[688315455] transaction","detail":"{read_only:false; response_revision:25516; number_of_response:1; }","duration":"467.053185ms","start":"2026-06-11T07:45:39.033603Z","end":"2026-06-11T07:45:39.500656Z","steps":["trace[688315455] 'process raft request' (duration: 466.967723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.500837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.063988ms","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-06-11T07:45:39.500863Z","caller":"traceutil/trace.go:171","msg":"trace[423114768] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25517; }","duration":"323.13778ms","start":"2026-06-11T07:45:39.177717Z","end":"2026-06-11T07:45:39.500855Z","steps":["trace[423114768] 'agreement among raft nodes before linearized reading' (duration: 323.026538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.500856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.033581Z","time spent":"467.212699ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:45:39.500866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.033006Z","time spent":"467.755971ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:45:39.500882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.177695Z","time spent":"323.18252ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-11T07:45:39.500729Z","caller":"traceutil/trace.go:171","msg":"trace[1581766498] transaction","detail":"{read_only:false; response_revision:25517; number_of_response:1; }","duration":"466.983293ms","start":"2026-06-11T07:45:39.033739Z","end":"2026-06-11T07:45:39.500723Z","steps":["trace[1581766498] 'process raft request' (duration: 466.868881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.501062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.033727Z","time spent":"467.29408ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:45:39.519293Z","caller":"traceutil/trace.go:171","msg":"trace[226791474] transaction","detail":"{read_only:false; response_revision:25518; number_of_response:1; }","duration":"103.893832ms","start":"2026-06-11T07:45:39.415371Z","end":"2026-06-11T07:45:39.519265Z","steps":["trace[226791474] 'process raft request' (duration: 103.77241ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:39.801276Z","caller":"traceutil/trace.go:171","msg":"trace[1519831186] linearizableReadLoop","detail":"{readStateIndex:26348; appliedIndex:26346; }","duration":"300.554502ms","start":"2026-06-11T07:45:39.500698Z","end":"2026-06-11T07:45:39.801252Z","steps":["trace[1519831186] 'read index received' (duration: 18.518968ms)","trace[1519831186] 'applied index is now lower than readState.Index' (duration: 282.034464ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:39.80133Z","caller":"traceutil/trace.go:171","msg":"trace[1051293] transaction","detail":"{read_only:false; response_revision:25520; number_of_response:1; }","duration":"295.896389ms","start":"2026-06-11T07:45:39.505407Z","end":"2026-06-11T07:45:39.801304Z","steps":["trace[1051293] 'process raft request' (duration: 295.751006ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:39.801313Z","caller":"traceutil/trace.go:171","msg":"trace[1621973014] transaction","detail":"{read_only:false; response_revision:25519; number_of_response:1; }","duration":"381.296974ms","start":"2026-06-11T07:45:39.419966Z","end":"2026-06-11T07:45:39.801263Z","steps":["trace[1621973014] 'process raft request' (duration: 381.036528ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:39.801308Z","caller":"traceutil/trace.go:171","msg":"trace[262926389] transaction","detail":"{read_only:false; response_revision:25521; number_of_response:1; }","duration":"282.900262ms","start":"2026-06-11T07:45:39.518385Z","end":"2026-06-11T07:45:39.801285Z","steps":["trace[262926389] 'process raft request' (duration: 282.816801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.801494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.419949Z","time spent":"381.444017ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:45:39.801464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.588502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-11T07:45:39.801521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.424042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-06-11T07:45:39.801566Z","caller":"traceutil/trace.go:171","msg":"trace[1781687120] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:25521; }","duration":"440.739765ms","start":"2026-06-11T07:45:39.360805Z","end":"2026-06-11T07:45:39.801545Z","steps":["trace[1781687120] 'agreement among raft nodes before linearized reading' (duration: 440.545781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.801628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.360782Z","time spent":"440.830187ms","remote":"127.0.0.1:56616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"info","ts":"2026-06-11T07:45:39.80157Z","caller":"traceutil/trace.go:171","msg":"trace[2140635078] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25521; }","duration":"592.506364ms","start":"2026-06-11T07:45:39.209048Z","end":"2026-06-11T07:45:39.801554Z","steps":["trace[2140635078] 'agreement among raft nodes before linearized reading' (duration: 592.32084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:39.801764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.209031Z","time spent":"592.712578ms","remote":"127.0.0.1:56918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":381,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"info","ts":"2026-06-11T07:45:40.087642Z","caller":"traceutil/trace.go:171","msg":"trace[1576631580] linearizableReadLoop","detail":"{readStateIndex:26354; appliedIndex:26350; }","duration":"286.280986ms","start":"2026-06-11T07:45:39.801344Z","end":"2026-06-11T07:45:40.087625Z","steps":["trace[1576631580] 'read index received' (duration: 286.00128ms)","trace[1576631580] 'applied index is now lower than readState.Index' (duration: 278.926µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:40.087688Z","caller":"traceutil/trace.go:171","msg":"trace[2094099723] transaction","detail":"{read_only:false; response_revision:25524; number_of_response:1; }","duration":"309.151752ms","start":"2026-06-11T07:45:39.778518Z","end":"2026-06-11T07:45:40.08767Z","steps":["trace[2094099723] 'process raft request' (duration: 309.035479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:40.087766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.276502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-11T07:45:40.087783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.778508Z","time spent":"309.209463ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:45:40.087805Z","caller":"traceutil/trace.go:171","msg":"trace[692524375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25525; }","duration":"560.335344ms","start":"2026-06-11T07:45:39.527457Z","end":"2026-06-11T07:45:40.087792Z","steps":["trace[692524375] 'agreement among raft nodes before linearized reading' (duration: 560.253882ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:40.087811Z","caller":"traceutil/trace.go:171","msg":"trace[1074402567] transaction","detail":"{read_only:false; response_revision:25523; number_of_response:1; }","duration":"310.395639ms","start":"2026-06-11T07:45:39.777401Z","end":"2026-06-11T07:45:40.087797Z","steps":["trace[1074402567] 'process raft request' (duration: 310.115983ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:40.087791Z","caller":"traceutil/trace.go:171","msg":"trace[28341020] transaction","detail":"{read_only:false; response_revision:25525; number_of_response:1; }","duration":"308.789743ms","start":"2026-06-11T07:45:39.778964Z","end":"2026-06-11T07:45:40.087754Z","steps":["trace[28341020] 'process raft request' (duration: 308.623609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:40.087832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.527444Z","time spent":"560.380884ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T07:45:40.087869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.777373Z","time spent":"310.4679ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:45:40.087859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.899328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-11T07:45:40.087941Z","caller":"traceutil/trace.go:171","msg":"trace[133468143] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:25525; }","duration":"344.045331ms","start":"2026-06-11T07:45:39.743876Z","end":"2026-06-11T07:45:40.087921Z","steps":["trace[133468143] 'agreement among raft nodes before linearized reading' (duration: 343.828847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:40.087954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.77894Z","time spent":"308.922835ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T07:45:40.087941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.5782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-11T07:45:40.088014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.743863Z","time spent":"344.138083ms","remote":"127.0.0.1:57300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":6,"response size":32,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-11T07:45:40.088063Z","caller":"traceutil/trace.go:171","msg":"trace[1683274843] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:25525; }","duration":"391.756524ms","start":"2026-06-11T07:45:39.696278Z","end":"2026-06-11T07:45:40.088035Z","steps":["trace[1683274843] 'agreement among raft nodes before linearized reading' (duration: 391.543589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:40.088134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.696259Z","time spent":"391.857466ms","remote":"127.0.0.1:56506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-06-11T07:45:40.088652Z","caller":"traceutil/trace.go:171","msg":"trace[797986542] transaction","detail":"{read_only:false; response_revision:25522; number_of_response:1; }","duration":"370.7492ms","start":"2026-06-11T07:45:39.717872Z","end":"2026-06-11T07:45:40.088621Z","steps":["trace[797986542] 'process raft request' (duration: 369.515243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:40.088861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:39.717854Z","time spent":"370.917024ms","remote":"127.0.0.1:57058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T07:45:40.214423Z","caller":"traceutil/trace.go:171","msg":"trace[1365359105] linearizableReadLoop","detail":"{readStateIndex:26355; appliedIndex:26354; }","duration":"125.810766ms","start":"2026-06-11T07:45:40.088582Z","end":"2026-06-11T07:45:40.214392Z","steps":["trace[1365359105] 'read index received' (duration: 124.220361ms)","trace[1365359105] 'applied index is now lower than readState.Index' (duration: 1.588855ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:40.214485Z","caller":"traceutil/trace.go:171","msg":"trace[424480803] transaction","detail":"{read_only:false; response_revision:25526; number_of_response:1; }","duration":"129.18544ms","start":"2026-06-11T07:45:40.08527Z","end":"2026-06-11T07:45:40.214455Z","steps":["trace[424480803] 'process raft request' (duration: 127.518594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:40.214605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.99824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:45:40.214768Z","caller":"traceutil/trace.go:171","msg":"trace[1721531460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25526; }","duration":"126.201695ms","start":"2026-06-11T07:45:40.088553Z","end":"2026-06-11T07:45:40.214755Z","steps":["trace[1721531460] 'agreement among raft nodes before linearized reading' (duration: 125.9925ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:45.72409Z","caller":"traceutil/trace.go:171","msg":"trace[1214489159] linearizableReadLoop","detail":"{readStateIndex:26405; appliedIndex:26403; }","duration":"182.692271ms","start":"2026-06-11T07:45:45.541372Z","end":"2026-06-11T07:45:45.724064Z","steps":["trace[1214489159] 'read index received' (duration: 31.206808ms)","trace[1214489159] 'applied index is now lower than readState.Index' (duration: 151.484473ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:45.724263Z","caller":"traceutil/trace.go:171","msg":"trace[19778539] transaction","detail":"{read_only:false; response_revision:25575; number_of_response:1; }","duration":"183.606442ms","start":"2026-06-11T07:45:45.540632Z","end":"2026-06-11T07:45:45.724239Z","steps":["trace[19778539] 'process raft request' (duration: 108.571516ms)","trace[19778539] 'compare' (duration: 74.730209ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:45:45.724471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.026048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-11T07:45:45.724519Z","caller":"traceutil/trace.go:171","msg":"trace[1067362604] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25575; }","duration":"183.176191ms","start":"2026-06-11T07:45:45.541332Z","end":"2026-06-11T07:45:45.724508Z","steps":["trace[1067362604] 'agreement among raft nodes before linearized reading' (duration: 182.823884ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:46.009323Z","caller":"traceutil/trace.go:171","msg":"trace[1250314978] transaction","detail":"{read_only:false; response_revision:25577; number_of_response:1; }","duration":"182.802274ms","start":"2026-06-11T07:45:45.826495Z","end":"2026-06-11T07:45:46.009297Z","steps":["trace[1250314978] 'process raft request' (duration: 182.641101ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:46.128092Z","caller":"traceutil/trace.go:171","msg":"trace[1662089420] linearizableReadLoop","detail":"{readStateIndex:26408; appliedIndex:26406; }","duration":"295.704274ms","start":"2026-06-11T07:45:45.832366Z","end":"2026-06-11T07:45:46.12807Z","steps":["trace[1662089420] 'read index received' (duration: 176.718609ms)","trace[1662089420] 'applied index is now lower than readState.Index' (duration: 118.984635ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:45:46.128474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.107333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-11T07:45:46.128518Z","caller":"traceutil/trace.go:171","msg":"trace[530026033] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25577; }","duration":"296.189555ms","start":"2026-06-11T07:45:45.832306Z","end":"2026-06-11T07:45:46.128496Z","steps":["trace[530026033] 'agreement among raft nodes before linearized reading' (duration: 296.058692ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:46.398305Z","caller":"traceutil/trace.go:171","msg":"trace[979464541] linearizableReadLoop","detail":"{readStateIndex:26412; appliedIndex:26410; }","duration":"270.130501ms","start":"2026-06-11T07:45:46.128153Z","end":"2026-06-11T07:45:46.398284Z","steps":["trace[979464541] 'read index received' (duration: 55.957855ms)","trace[979464541] 'applied index is now lower than readState.Index' (duration: 214.171226ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:46.398384Z","caller":"traceutil/trace.go:171","msg":"trace[160822659] transaction","detail":"{read_only:false; response_revision:25581; number_of_response:1; }","duration":"280.057309ms","start":"2026-06-11T07:45:46.118297Z","end":"2026-06-11T07:45:46.398354Z","steps":["trace[160822659] 'process raft request' (duration: 279.886444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:46.398521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.627205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-06-11T07:45:46.398529Z","caller":"traceutil/trace.go:171","msg":"trace[1169632097] transaction","detail":"{read_only:false; response_revision:25580; number_of_response:1; }","duration":"285.196633ms","start":"2026-06-11T07:45:46.113322Z","end":"2026-06-11T07:45:46.398519Z","steps":["trace[1169632097] 'process raft request' (duration: 203.837427ms)","trace[1169632097] 'compare' (duration: 80.748991ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:46.398565Z","caller":"traceutil/trace.go:171","msg":"trace[819066978] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:25582; }","duration":"388.714777ms","start":"2026-06-11T07:45:46.009837Z","end":"2026-06-11T07:45:46.398552Z","steps":["trace[819066978] 'agreement among raft nodes before linearized reading' (duration: 388.538303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:46.398608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:46.00981Z","time spent":"388.788478ms","remote":"127.0.0.1:56966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1960,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-06-11T07:45:46.398805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.25279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:45:46.398855Z","caller":"traceutil/trace.go:171","msg":"trace[1157663860] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:25582; }","duration":"341.345992ms","start":"2026-06-11T07:45:46.057495Z","end":"2026-06-11T07:45:46.398841Z","steps":["trace[1157663860] 'agreement among raft nodes before linearized reading' (duration: 341.25315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T07:45:46.398903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T07:45:46.057469Z","time spent":"341.412853ms","remote":"127.0.0.1:40402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true "} {"level":"info","ts":"2026-06-11T07:45:46.398863Z","caller":"traceutil/trace.go:171","msg":"trace[26388209] transaction","detail":"{read_only:false; response_revision:25582; number_of_response:1; }","duration":"267.039443ms","start":"2026-06-11T07:45:46.131776Z","end":"2026-06-11T07:45:46.398815Z","steps":["trace[26388209] 'process raft request' (duration: 266.464141ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:46.465497Z","caller":"traceutil/trace.go:171","msg":"trace[1870751385] transaction","detail":"{read_only:false; response_revision:25583; number_of_response:1; }","duration":"233.590915ms","start":"2026-06-11T07:45:46.231871Z","end":"2026-06-11T07:45:46.465462Z","steps":["trace[1870751385] 'process raft request' (duration: 233.310378ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:47.270689Z","caller":"traceutil/trace.go:171","msg":"trace[1407242663] linearizableReadLoop","detail":"{readStateIndex:26418; appliedIndex:26417; }","duration":"104.071236ms","start":"2026-06-11T07:45:47.166595Z","end":"2026-06-11T07:45:47.270667Z","steps":["trace[1407242663] 'read index received' (duration: 29.228084ms)","trace[1407242663] 'applied index is now lower than readState.Index' (duration: 74.842322ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:45:47.270776Z","caller":"traceutil/trace.go:171","msg":"trace[1345586572] transaction","detail":"{read_only:false; response_revision:25587; number_of_response:1; }","duration":"174.661083ms","start":"2026-06-11T07:45:47.096082Z","end":"2026-06-11T07:45:47.270743Z","steps":["trace[1345586572] 'process raft request' (duration: 99.822182ms)","trace[1345586572] 'compare' (duration: 74.657708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:45:47.270863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.246281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-11T07:45:47.270888Z","caller":"traceutil/trace.go:171","msg":"trace[709322780] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25587; }","duration":"104.319402ms","start":"2026-06-11T07:45:47.166562Z","end":"2026-06-11T07:45:47.270881Z","steps":["trace[709322780] 'agreement among raft nodes before linearized reading' (duration: 104.186979ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:45:47.755675Z","caller":"traceutil/trace.go:171","msg":"trace[1785502246] transaction","detail":"{read_only:false; response_revision:25588; number_of_response:1; }","duration":"176.719758ms","start":"2026-06-11T07:45:47.578925Z","end":"2026-06-11T07:45:47.755645Z","steps":["trace[1785502246] 'process raft request' (duration: 176.166166ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:46:17.866593Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22977} {"level":"info","ts":"2026-06-11T07:46:17.994811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22977,"took":"123.093636ms","hash":2690102100,"current-db-size-bytes":60702720,"current-db-size":"61 MB","current-db-size-in-use-bytes":35463168,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-06-11T07:46:17.994902Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2690102100,"revision":22977,"compact-revision":20076} {"level":"info","ts":"2026-06-11T07:47:04.555859Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a38.wal"} {"level":"info","ts":"2026-06-11T07:48:02.345399Z","caller":"traceutil/trace.go:171","msg":"trace[1570596187] transaction","detail":"{read_only:false; response_revision:26883; number_of_response:1; }","duration":"123.761862ms","start":"2026-06-11T07:48:02.221609Z","end":"2026-06-11T07:48:02.345371Z","steps":["trace[1570596187] 'process raft request' (duration: 123.538877ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:48:26.63084Z","caller":"traceutil/trace.go:171","msg":"trace[388636799] linearizableReadLoop","detail":"{readStateIndex:27973; appliedIndex:27972; }","duration":"105.162666ms","start":"2026-06-11T07:48:26.525623Z","end":"2026-06-11T07:48:26.630786Z","steps":["trace[388636799] 'read index received' (duration: 85.012487ms)","trace[388636799] 'applied index is now lower than readState.Index' (duration: 20.148379ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T07:48:26.631136Z","caller":"traceutil/trace.go:171","msg":"trace[560288937] transaction","detail":"{read_only:false; response_revision:27105; number_of_response:1; }","duration":"115.665711ms","start":"2026-06-11T07:48:26.515434Z","end":"2026-06-11T07:48:26.6311Z","steps":["trace[560288937] 'process raft request' (duration: 95.244806ms)","trace[560288937] 'compare' (duration: 19.909714ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T07:48:26.631708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.052316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-11T07:48:26.631786Z","caller":"traceutil/trace.go:171","msg":"trace[599669958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27105; }","duration":"106.188918ms","start":"2026-06-11T07:48:26.525579Z","end":"2026-06-11T07:48:26.631768Z","steps":["trace[599669958] 'agreement among raft nodes before linearized reading' (duration: 105.563785ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T07:51:17.872126Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25978} {"level":"info","ts":"2026-06-11T07:51:18.014187Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25978,"took":"137.713929ms","hash":546269056,"current-db-size-bytes":60702720,"current-db-size":"61 MB","current-db-size-in-use-bytes":35123200,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-11T07:51:18.01424Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":546269056,"revision":25978,"compact-revision":22977} {"level":"info","ts":"2026-06-11T07:52:09.852389Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8d200b79e0a2e7ca","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-11T07:52:09.868844Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-11T07:52:09.868948Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-11T07:56:17.879079Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28697} {"level":"info","ts":"2026-06-11T07:56:18.021552Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28697,"took":"139.583913ms","hash":2559205475,"current-db-size-bytes":60702720,"current-db-size":"61 MB","current-db-size-in-use-bytes":30142464,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-11T07:56:18.021624Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2559205475,"revision":28697,"compact-revision":25978} {"level":"info","ts":"2026-06-11T08:01:17.885665Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30918} {"level":"info","ts":"2026-06-11T08:01:18.001442Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30918,"took":"111.64529ms","hash":1170967079,"current-db-size-bytes":60702720,"current-db-size":"61 MB","current-db-size-in-use-bytes":31531008,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-11T08:01:18.001522Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1170967079,"revision":30918,"compact-revision":28697} {"level":"info","ts":"2026-06-11T08:06:17.893639Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33254} {"level":"info","ts":"2026-06-11T08:06:18.059216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33254,"took":"159.967739ms","hash":1952592926,"current-db-size-bytes":61747200,"current-db-size":"62 MB","current-db-size-in-use-bytes":31911936,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-11T08:06:18.059279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1952592926,"revision":33254,"compact-revision":30918} {"level":"info","ts":"2026-06-11T08:11:17.899828Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35580} {"level":"info","ts":"2026-06-11T08:11:18.050363Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35580,"took":"146.105602ms","hash":2637157927,"current-db-size-bytes":63078400,"current-db-size":"63 MB","current-db-size-in-use-bytes":31932416,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-11T08:11:18.050444Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2637157927,"revision":35580,"compact-revision":33254} {"level":"info","ts":"2026-06-11T08:13:27.541012Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8d200b79e0a2e7ca","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-11T08:13:27.54593Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-11T08:13:27.546021Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-11T08:16:17.906576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37810} {"level":"info","ts":"2026-06-11T08:16:18.02988Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37810,"took":"120.027097ms","hash":2349577757,"current-db-size-bytes":63078400,"current-db-size":"63 MB","current-db-size-in-use-bytes":31469568,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-11T08:16:18.029937Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2349577757,"revision":37810,"compact-revision":35580}