{"level":"warn","ts":"2026-06-10T08:33:52.052834Z","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-10T08:33:52.052941Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216: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-10T08:33:52.053012Z","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-10T08:33:52.053023Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]}
{"level":"info","ts":"2026-06-10T08:33:52.053043Z","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-10T08:33:52.053634Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]}
{"level":"info","ts":"2026-06-10T08:33:52.053717Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216: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-10T08:33:52.057987Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.049497ms"}
{"level":"info","ts":"2026-06-10T08:33:52.063466Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"}
{"level":"info","ts":"2026-06-10T08:33:52.063549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"}
{"level":"info","ts":"2026-06-10T08:33:52.063581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"}
{"level":"info","ts":"2026-06-10T08:33:52.063616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-06-10T08:33:52.063629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"}
{"level":"info","ts":"2026-06-10T08:33:52.063678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"}
{"level":"warn","ts":"2026-06-10T08:33:52.069617Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-06-10T08:33:52.071106Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-06-10T08:33:52.072427Z","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-10T08:33:52.074543Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-06-10T08:33:52.074782Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-06-10T08:33:52.074886Z","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-10T08:33:52.07499Z","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-10T08:33:52.075014Z","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-10T08:33:52.076203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"}
{"level":"info","ts":"2026-06-10T08:33:52.077294Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]}
{"level":"info","ts":"2026-06-10T08:33:52.079365Z","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-10T08:33:52.079478Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"}
{"level":"info","ts":"2026-06-10T08:33:52.079494Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"}
{"level":"info","ts":"2026-06-10T08:33:52.079794Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-06-10T08:33:52.079836Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-06-10T08:33:52.164576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"}
{"level":"info","ts":"2026-06-10T08:33:52.164657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"}
{"level":"info","ts":"2026-06-10T08:33:52.1647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"}
{"level":"info","ts":"2026-06-10T08:33:52.164722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"}
{"level":"info","ts":"2026-06-10T08:33:52.164734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"}
{"level":"info","ts":"2026-06-10T08:33:52.164757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"}
{"level":"info","ts":"2026-06-10T08:33:52.164771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"}
{"level":"info","ts":"2026-06-10T08:33:52.165841Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-06-10T08:33:52.165844Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"}
{"level":"info","ts":"2026-06-10T08:33:52.165854Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-10T08:33:52.165884Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-06-10T08:33:52.166171Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-06-10T08:33:52.166235Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-06-10T08:33:52.166624Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-10T08:33:52.166768Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-10T08:33:52.166801Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-06-10T08:33:52.16852Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-06-10T08:33:52.169486Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"}
{"level":"info","ts":"2026-06-10T08:34:32.634829Z","caller":"traceutil/trace.go:171","msg":"trace[770205355] transaction","detail":"{read_only:false; number_of_response:0; response_revision:544; }","duration":"100.219918ms","start":"2026-06-10T08:34:32.534564Z","end":"2026-06-10T08:34:32.634784Z","steps":["trace[770205355] 'process raft request'  (duration: 100.008384ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:34:38.749033Z","caller":"traceutil/trace.go:171","msg":"trace[1581596184] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"153.494463ms","start":"2026-06-10T08:34:38.595508Z","end":"2026-06-10T08:34:38.749003Z","steps":["trace[1581596184] 'process raft request'  (duration: 108.771321ms)","trace[1581596184] 'compare'  (duration: 44.576899ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:34:39.375721Z","caller":"traceutil/trace.go:171","msg":"trace[975752054] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"332.819518ms","start":"2026-06-10T08:34:39.042873Z","end":"2026-06-10T08:34:39.375693Z","steps":["trace[975752054] 'read index received'  (duration: 332.673505ms)","trace[975752054] 'applied index is now lower than readState.Index'  (duration: 145.033µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:34:39.375773Z","caller":"traceutil/trace.go:171","msg":"trace[705637005] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"363.500743ms","start":"2026-06-10T08:34:39.01224Z","end":"2026-06-10T08:34:39.375741Z","steps":["trace[705637005] 'process raft request'  (duration: 363.237718ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:34:39.375881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.991221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-06-10T08:34:39.375955Z","caller":"traceutil/trace.go:171","msg":"trace[905916069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"333.113674ms","start":"2026-06-10T08:34:39.04283Z","end":"2026-06-10T08:34:39.375944Z","steps":["trace[905916069] 'agreement among raft nodes before linearized reading'  (duration: 332.996482ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:34:39.375989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:34:39.042811Z","time spent":"333.170215ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-06-10T08:34:39.376246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:34:39.012224Z","time spent":"363.618105ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:625 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-06-10T08:34:39.383248Z","caller":"traceutil/trace.go:171","msg":"trace[98951753] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"217.272067ms","start":"2026-06-10T08:34:39.16595Z","end":"2026-06-10T08:34:39.383222Z","steps":["trace[98951753] 'process raft request'  (duration: 216.647015ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:34:39.383346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.032347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-06-10T08:34:39.383431Z","caller":"traceutil/trace.go:171","msg":"trace[2044012076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"213.150179ms","start":"2026-06-10T08:34:39.170262Z","end":"2026-06-10T08:34:39.383412Z","steps":["trace[2044012076] 'agreement among raft nodes before linearized reading'  (duration: 212.935605ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:34:39.383432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.053778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-06-10T08:34:39.383488Z","caller":"traceutil/trace.go:171","msg":"trace[1603852560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"213.16042ms","start":"2026-06-10T08:34:39.170312Z","end":"2026-06-10T08:34:39.383473Z","steps":["trace[1603852560] 'agreement among raft nodes before linearized reading'  (duration: 212.962086ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:34:54.458388Z","caller":"traceutil/trace.go:171","msg":"trace[1979251794] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"117.701421ms","start":"2026-06-10T08:34:54.340652Z","end":"2026-06-10T08:34:54.458353Z","steps":["trace[1979251794] 'process raft request'  (duration: 117.490307ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:34:54.633694Z","caller":"traceutil/trace.go:171","msg":"trace[765184158] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"168.242324ms","start":"2026-06-10T08:34:54.465432Z","end":"2026-06-10T08:34:54.633674Z","steps":["trace[765184158] 'process raft request'  (duration: 168.129732ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:35:21.724104Z","caller":"traceutil/trace.go:171","msg":"trace[1127881129] linearizableReadLoop","detail":"{readStateIndex:1231; appliedIndex:1230; }","duration":"131.844291ms","start":"2026-06-10T08:35:21.592233Z","end":"2026-06-10T08:35:21.724077Z","steps":["trace[1127881129] 'read index received'  (duration: 131.718938ms)","trace[1127881129] 'applied index is now lower than readState.Index'  (duration: 124.603µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:35:21.724185Z","caller":"traceutil/trace.go:171","msg":"trace[220901845] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"132.905971ms","start":"2026-06-10T08:35:21.591246Z","end":"2026-06-10T08:35:21.724152Z","steps":["trace[220901845] 'process raft request'  (duration: 132.671487ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:35:21.724433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.170627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-06-10T08:35:21.724532Z","caller":"traceutil/trace.go:171","msg":"trace[616491985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1193; }","duration":"132.30542ms","start":"2026-06-10T08:35:21.592206Z","end":"2026-06-10T08:35:21.724512Z","steps":["trace[616491985] 'agreement among raft nodes before linearized reading'  (duration: 131.995034ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:35:21.724748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.420442ms","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-10T08:35:21.724811Z","caller":"traceutil/trace.go:171","msg":"trace[994386099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1193; }","duration":"132.538804ms","start":"2026-06-10T08:35:21.592257Z","end":"2026-06-10T08:35:21.724796Z","steps":["trace[994386099] 'agreement among raft nodes before linearized reading'  (duration: 132.296829ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:36:05.874377Z","caller":"traceutil/trace.go:171","msg":"trace[1191740881] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"116.231198ms","start":"2026-06-10T08:36:05.758119Z","end":"2026-06-10T08:36:05.87435Z","steps":["trace[1191740881] 'read index received'  (duration: 107.474672ms)","trace[1191740881] 'applied index is now lower than readState.Index'  (duration: 8.754806ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:36:05.874474Z","caller":"traceutil/trace.go:171","msg":"trace[875212452] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"117.094665ms","start":"2026-06-10T08:36:05.757352Z","end":"2026-06-10T08:36:05.874446Z","steps":["trace[875212452] 'process raft request'  (duration: 108.349569ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:36:05.874764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.569294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7a6912db-cd01-4410-aeff-a99c35c40088\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-06-10T08:36:05.874886Z","caller":"traceutil/trace.go:171","msg":"trace[91284477] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7a6912db-cd01-4410-aeff-a99c35c40088; range_end:; response_count:1; response_revision:1853; }","duration":"116.769977ms","start":"2026-06-10T08:36:05.758093Z","end":"2026-06-10T08:36:05.874863Z","steps":["trace[91284477] 'agreement among raft nodes before linearized reading'  (duration: 116.36352ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:36:54.314631Z","caller":"traceutil/trace.go:171","msg":"trace[1015535369] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"195.705777ms","start":"2026-06-10T08:36:54.118894Z","end":"2026-06-10T08:36:54.3146Z","steps":["trace[1015535369] 'process raft request'  (duration: 194.468293ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:36:54.314776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.384429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-06-10T08:36:54.31462Z","caller":"traceutil/trace.go:171","msg":"trace[865988896] linearizableReadLoop","detail":"{readStateIndex:2250; appliedIndex:2248; }","duration":"145.201605ms","start":"2026-06-10T08:36:54.169381Z","end":"2026-06-10T08:36:54.314583Z","steps":["trace[865988896] 'read index received'  (duration: 38.260219ms)","trace[865988896] 'applied index is now lower than readState.Index'  (duration: 106.940016ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:36:54.314854Z","caller":"traceutil/trace.go:171","msg":"trace[460949478] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2164; }","duration":"145.507281ms","start":"2026-06-10T08:36:54.169334Z","end":"2026-06-10T08:36:54.314842Z","steps":["trace[460949478] 'agreement among raft nodes before linearized reading'  (duration: 145.319627ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:09.846938Z","caller":"traceutil/trace.go:171","msg":"trace[611970350] transaction","detail":"{read_only:false; response_revision:4686; number_of_response:1; }","duration":"117.155521ms","start":"2026-06-10T08:42:09.729746Z","end":"2026-06-10T08:42:09.846902Z","steps":["trace[611970350] 'process raft request'  (duration: 23.662351ms)","trace[611970350] 'compare'  (duration: 93.273186ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T08:42:09.847133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.042101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11454"}
{"level":"info","ts":"2026-06-10T08:42:09.846965Z","caller":"traceutil/trace.go:171","msg":"trace[1693455771] linearizableReadLoop","detail":"{readStateIndex:4867; appliedIndex:4866; }","duration":"113.865698ms","start":"2026-06-10T08:42:09.733068Z","end":"2026-06-10T08:42:09.846934Z","steps":["trace[1693455771] 'read index received'  (duration: 20.257957ms)","trace[1693455771] 'applied index is now lower than readState.Index'  (duration: 93.604791ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:42:09.847235Z","caller":"traceutil/trace.go:171","msg":"trace[625980514] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4687; }","duration":"114.191793ms","start":"2026-06-10T08:42:09.733023Z","end":"2026-06-10T08:42:09.847215Z","steps":["trace[625980514] 'agreement among raft nodes before linearized reading'  (duration: 113.947379ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:42:09.847398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.637058ms","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:1935"}
{"level":"info","ts":"2026-06-10T08:42:09.847439Z","caller":"traceutil/trace.go:171","msg":"trace[407135258] 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:4687; }","duration":"107.686669ms","start":"2026-06-10T08:42:09.739736Z","end":"2026-06-10T08:42:09.847423Z","steps":["trace[407135258] 'agreement among raft nodes before linearized reading'  (duration: 107.551477ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:17.987503Z","caller":"traceutil/trace.go:171","msg":"trace[1198181398] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"116.022268ms","start":"2026-06-10T08:42:17.871456Z","end":"2026-06-10T08:42:17.987478Z","steps":["trace[1198181398] 'process raft request'  (duration: 115.63089ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:18.243586Z","caller":"traceutil/trace.go:171","msg":"trace[1497867611] linearizableReadLoop","detail":"{readStateIndex:5130; appliedIndex:5129; }","duration":"101.189456ms","start":"2026-06-10T08:42:18.142366Z","end":"2026-06-10T08:42:18.243555Z","steps":["trace[1497867611] 'read index received'  (duration: 100.883841ms)","trace[1497867611] 'applied index is now lower than readState.Index'  (duration: 304.495µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:42:18.244091Z","caller":"traceutil/trace.go:171","msg":"trace[896415832] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"104.215945ms","start":"2026-06-10T08:42:18.139864Z","end":"2026-06-10T08:42:18.244079Z","steps":["trace[896415832] 'process raft request'  (duration: 103.499361ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:42:18.244548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.152125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:15 size:105869"}
{"level":"info","ts":"2026-06-10T08:42:18.244586Z","caller":"traceutil/trace.go:171","msg":"trace[1893085475] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:15; response_revision:4941; }","duration":"102.213766ms","start":"2026-06-10T08:42:18.142363Z","end":"2026-06-10T08:42:18.244577Z","steps":["trace[1893085475] 'agreement among raft nodes before linearized reading'  (duration: 101.914511ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:42:18.546443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.2235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3584"}
{"level":"info","ts":"2026-06-10T08:42:18.546557Z","caller":"traceutil/trace.go:171","msg":"trace[2106697730] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4942; }","duration":"118.332603ms","start":"2026-06-10T08:42:18.428181Z","end":"2026-06-10T08:42:18.546514Z","steps":["trace[2106697730] 'range keys from in-memory index tree'  (duration: 118.020626ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:34.949469Z","caller":"traceutil/trace.go:171","msg":"trace[1714913441] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"161.321122ms","start":"2026-06-10T08:42:34.788122Z","end":"2026-06-10T08:42:34.949443Z","steps":["trace[1714913441] 'process raft request'  (duration: 161.169539ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:46.063095Z","caller":"traceutil/trace.go:171","msg":"trace[1347848586] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"170.72813ms","start":"2026-06-10T08:42:45.892337Z","end":"2026-06-10T08:42:46.063065Z","steps":["trace[1347848586] 'process raft request'  (duration: 170.428575ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:46.170381Z","caller":"traceutil/trace.go:171","msg":"trace[1215385900] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"101.693196ms","start":"2026-06-10T08:42:46.068658Z","end":"2026-06-10T08:42:46.170351Z","steps":["trace[1215385900] 'process raft request'  (duration: 54.916866ms)","trace[1215385900] 'compare'  (duration: 46.614057ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:42:46.185488Z","caller":"traceutil/trace.go:171","msg":"trace[671106341] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"116.332226ms","start":"2026-06-10T08:42:46.069134Z","end":"2026-06-10T08:42:46.185466Z","steps":["trace[671106341] 'process raft request'  (duration: 116.097451ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:46.185483Z","caller":"traceutil/trace.go:171","msg":"trace[1661714801] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"116.240544ms","start":"2026-06-10T08:42:46.069222Z","end":"2026-06-10T08:42:46.185463Z","steps":["trace[1661714801] 'process raft request'  (duration: 116.141662ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:46.185744Z","caller":"traceutil/trace.go:171","msg":"trace[47372325] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"116.250344ms","start":"2026-06-10T08:42:46.069481Z","end":"2026-06-10T08:42:46.185731Z","steps":["trace[47372325] 'process raft request'  (duration: 115.928528ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:46.185929Z","caller":"traceutil/trace.go:171","msg":"trace[801691538] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"115.946967ms","start":"2026-06-10T08:42:46.069953Z","end":"2026-06-10T08:42:46.1859Z","steps":["trace[801691538] 'process raft request'  (duration: 115.752753ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:42:46.186Z","caller":"traceutil/trace.go:171","msg":"trace[5025721] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"108.760981ms","start":"2026-06-10T08:42:46.077201Z","end":"2026-06-10T08:42:46.185962Z","steps":["trace[5025721] 'process raft request'  (duration: 108.644539ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:43:52.425694Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2848}
{"level":"info","ts":"2026-06-10T08:43:52.508855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2848,"took":"81.554438ms","hash":2239161372,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":33386496,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-06-10T08:43:52.508936Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2239161372,"revision":2848,"compact-revision":-1}
{"level":"info","ts":"2026-06-10T08:48:24.337867Z","caller":"traceutil/trace.go:171","msg":"trace[1826147142] transaction","detail":"{read_only:false; response_revision:7998; number_of_response:1; }","duration":"409.957847ms","start":"2026-06-10T08:48:23.92788Z","end":"2026-06-10T08:48:24.337838Z","steps":["trace[1826147142] 'process raft request'  (duration: 404.082105ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:48:24.338031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:48:23.927861Z","time spent":"410.09196ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:7988 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-06-10T08:48:24.341053Z","caller":"traceutil/trace.go:171","msg":"trace[1839602675] linearizableReadLoop","detail":"{readStateIndex:8280; appliedIndex:8278; }","duration":"343.532275ms","start":"2026-06-10T08:48:23.997493Z","end":"2026-06-10T08:48:24.341026Z","steps":["trace[1839602675] 'read index received'  (duration: 334.501324ms)","trace[1839602675] 'applied index is now lower than readState.Index'  (duration: 9.029931ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T08:48:24.341244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.731699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-06-10T08:48:24.341299Z","caller":"traceutil/trace.go:171","msg":"trace[1792567451] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:7999; }","duration":"343.836081ms","start":"2026-06-10T08:48:23.997442Z","end":"2026-06-10T08:48:24.341278Z","steps":["trace[1792567451] 'agreement among raft nodes before linearized reading'  (duration: 343.722019ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:48:24.341341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:48:23.997422Z","time spent":"343.908982ms","remote":"127.0.0.1:39336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":1,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true "}
{"level":"warn","ts":"2026-06-10T08:48:24.341323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.922251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-06-10T08:48:24.341422Z","caller":"traceutil/trace.go:171","msg":"trace[1467685200] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7999; }","duration":"286.058593ms","start":"2026-06-10T08:48:24.055333Z","end":"2026-06-10T08:48:24.341392Z","steps":["trace[1467685200] 'agreement among raft nodes before linearized reading'  (duration: 285.857269ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:48:24.341407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.432339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-06-10T08:48:24.341507Z","caller":"traceutil/trace.go:171","msg":"trace[1415367590] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:7999; }","duration":"288.589212ms","start":"2026-06-10T08:48:24.052896Z","end":"2026-06-10T08:48:24.341486Z","steps":["trace[1415367590] 'agreement among raft nodes before linearized reading'  (duration: 288.292356ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:48:24.341858Z","caller":"traceutil/trace.go:171","msg":"trace[991536104] transaction","detail":"{read_only:false; response_revision:7999; number_of_response:1; }","duration":"412.696088ms","start":"2026-06-10T08:48:23.928418Z","end":"2026-06-10T08:48:24.341114Z","steps":["trace[991536104] 'process raft request'  (duration: 412.479834ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:48:24.342002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T08:48:23.928391Z","time spent":"413.522744ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:7987 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-06-10T08:48:34.543477Z","caller":"traceutil/trace.go:171","msg":"trace[159575355] transaction","detail":"{read_only:false; response_revision:8051; number_of_response:1; }","duration":"162.280616ms","start":"2026-06-10T08:48:34.381167Z","end":"2026-06-10T08:48:34.543447Z","steps":["trace[159575355] 'process raft request'  (duration: 124.469828ms)","trace[159575355] 'compare'  (duration: 37.609984ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:48:34.543496Z","caller":"traceutil/trace.go:171","msg":"trace[1192518169] linearizableReadLoop","detail":"{readStateIndex:8334; appliedIndex:8332; }","duration":"160.737927ms","start":"2026-06-10T08:48:34.382733Z","end":"2026-06-10T08:48:34.543471Z","steps":["trace[1192518169] 'read index received'  (duration: 93.650265ms)","trace[1192518169] 'applied index is now lower than readState.Index'  (duration: 67.084952ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T08:48:34.543699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.944521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-06-10T08:48:34.54378Z","caller":"traceutil/trace.go:171","msg":"trace[229299970] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8052; }","duration":"161.075163ms","start":"2026-06-10T08:48:34.382683Z","end":"2026-06-10T08:48:34.543758Z","steps":["trace[229299970] 'agreement among raft nodes before linearized reading'  (duration: 160.854699ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:48:34.543852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.966168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-06-10T08:48:34.543948Z","caller":"traceutil/trace.go:171","msg":"trace[31094914] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8052; }","duration":"154.089071ms","start":"2026-06-10T08:48:34.389842Z","end":"2026-06-10T08:48:34.543931Z","steps":["trace[31094914] 'agreement among raft nodes before linearized reading'  (duration: 153.853446ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:48:52.43109Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5980}
{"level":"info","ts":"2026-06-10T08:48:52.530448Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5980,"took":"97.435767ms","hash":104924374,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":22622208,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-06-10T08:48:52.530515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":104924374,"revision":5980,"compact-revision":2848}
{"level":"warn","ts":"2026-06-10T08:49:05.935951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.774519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-06-10T08:49:05.936075Z","caller":"traceutil/trace.go:171","msg":"trace[1698297452] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:8304; }","duration":"245.964663ms","start":"2026-06-10T08:49:05.690084Z","end":"2026-06-10T08:49:05.936049Z","steps":["trace[1698297452] 'range keys from in-memory index tree'  (duration: 245.591655ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:49:06.129965Z","caller":"traceutil/trace.go:171","msg":"trace[1001106460] transaction","detail":"{read_only:false; response_revision:8305; number_of_response:1; }","duration":"157.661348ms","start":"2026-06-10T08:49:05.972268Z","end":"2026-06-10T08:49:06.129929Z","steps":["trace[1001106460] 'process raft request'  (duration: 157.519986ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:49:18.167141Z","caller":"traceutil/trace.go:171","msg":"trace[173586812] linearizableReadLoop","detail":"{readStateIndex:8684; appliedIndex:8682; }","duration":"145.540528ms","start":"2026-06-10T08:49:18.021572Z","end":"2026-06-10T08:49:18.167113Z","steps":["trace[173586812] 'read index received'  (duration: 44.287419ms)","trace[173586812] 'applied index is now lower than readState.Index'  (duration: 101.251939ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T08:49:18.167444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.043593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-06-10T08:49:18.167457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.866275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/openstack/ceph\" ","response":"range_response_count:1 size:3173"}
{"level":"info","ts":"2026-06-10T08:49:18.167515Z","caller":"traceutil/trace.go:171","msg":"trace[627908690] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8386; }","duration":"122.171445ms","start":"2026-06-10T08:49:18.045328Z","end":"2026-06-10T08:49:18.167499Z","steps":["trace[627908690] 'agreement among raft nodes before linearized reading'  (duration: 122.035543ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:49:18.167523Z","caller":"traceutil/trace.go:171","msg":"trace[2053591142] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/openstack/ceph; range_end:; response_count:1; response_revision:8386; }","duration":"145.989766ms","start":"2026-06-10T08:49:18.021516Z","end":"2026-06-10T08:49:18.167506Z","steps":["trace[2053591142] 'agreement among raft nodes before linearized reading'  (duration: 145.781333ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:49:18.167414Z","caller":"traceutil/trace.go:171","msg":"trace[1301714982] transaction","detail":"{read_only:false; response_revision:8386; number_of_response:1; }","duration":"150.147006ms","start":"2026-06-10T08:49:18.017199Z","end":"2026-06-10T08:49:18.167346Z","steps":["trace[1301714982] 'process raft request'  (duration: 128.282581ms)","trace[1301714982] 'compare'  (duration: 21.475317ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:49:18.923468Z","caller":"traceutil/trace.go:171","msg":"trace[2032507110] transaction","detail":"{read_only:false; response_revision:8389; number_of_response:1; }","duration":"236.862489ms","start":"2026-06-10T08:49:18.686581Z","end":"2026-06-10T08:49:18.923444Z","steps":["trace[2032507110] 'process raft request'  (duration: 236.704926ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:49:18.977293Z","caller":"traceutil/trace.go:171","msg":"trace[628001908] linearizableReadLoop","detail":"{readStateIndex:8688; appliedIndex:8686; }","duration":"218.4476ms","start":"2026-06-10T08:49:18.758819Z","end":"2026-06-10T08:49:18.977267Z","steps":["trace[628001908] 'read index received'  (duration: 164.400056ms)","trace[628001908] 'applied index is now lower than readState.Index'  (duration: 54.046614ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:49:18.977401Z","caller":"traceutil/trace.go:171","msg":"trace[677216092] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"279.064489ms","start":"2026-06-10T08:49:18.698295Z","end":"2026-06-10T08:49:18.977359Z","steps":["trace[677216092] 'process raft request'  (duration: 278.832605ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:49:18.977538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.697435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-06-10T08:49:18.977594Z","caller":"traceutil/trace.go:171","msg":"trace[1718508636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8390; }","duration":"218.900809ms","start":"2026-06-10T08:49:18.758679Z","end":"2026-06-10T08:49:18.97758Z","steps":["trace[1718508636] 'agreement among raft nodes before linearized reading'  (duration: 218.728826ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:49:18.977798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.475604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-06-10T08:49:18.977883Z","caller":"traceutil/trace.go:171","msg":"trace[1638387133] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8390; }","duration":"216.568726ms","start":"2026-06-10T08:49:18.761278Z","end":"2026-06-10T08:49:18.977846Z","steps":["trace[1638387133] 'agreement among raft nodes before linearized reading'  (duration: 216.381432ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:49:18.978052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.792033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-06-10T08:49:18.978186Z","caller":"traceutil/trace.go:171","msg":"trace[1473054334] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8390; }","duration":"203.970917ms","start":"2026-06-10T08:49:18.774182Z","end":"2026-06-10T08:49:18.978153Z","steps":["trace[1473054334] 'agreement among raft nodes before linearized reading'  (duration: 203.565759ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:50:22.165793Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000246a.wal"}
{"level":"info","ts":"2026-06-10T08:50:24.75377Z","caller":"traceutil/trace.go:171","msg":"trace[518839931] linearizableReadLoop","detail":"{readStateIndex:9332; appliedIndex:9331; }","duration":"140.74957ms","start":"2026-06-10T08:50:24.612996Z","end":"2026-06-10T08:50:24.753746Z","steps":["trace[518839931] 'read index received'  (duration: 140.522294ms)","trace[518839931] 'applied index is now lower than readState.Index'  (duration: 226.266µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T08:50:24.753869Z","caller":"traceutil/trace.go:171","msg":"trace[2007746249] transaction","detail":"{read_only:false; response_revision:9016; number_of_response:1; }","duration":"141.982332ms","start":"2026-06-10T08:50:24.611851Z","end":"2026-06-10T08:50:24.753833Z","steps":["trace[2007746249] 'process raft request'  (duration: 141.728066ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:50:24.754162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.156847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-06-10T08:50:24.754213Z","caller":"traceutil/trace.go:171","msg":"trace[268517578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9016; }","duration":"141.255739ms","start":"2026-06-10T08:50:24.612946Z","end":"2026-06-10T08:50:24.754202Z","steps":["trace[268517578] 'agreement among raft nodes before linearized reading'  (duration: 140.927853ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:50:24.754195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.4597ms","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-10T08:50:24.754661Z","caller":"traceutil/trace.go:171","msg":"trace[1451917718] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9016; }","duration":"105.943899ms","start":"2026-06-10T08:50:24.648648Z","end":"2026-06-10T08:50:24.754592Z","steps":["trace[1451917718] 'agreement among raft nodes before linearized reading'  (duration: 105.320158ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T08:50:24.969167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.958422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-65b4584884-t2rhp.18b7ac00480e554f\" ","response":"range_response_count:1 size:1135"}
{"level":"info","ts":"2026-06-10T08:50:24.969245Z","caller":"traceutil/trace.go:171","msg":"trace[1420622752] range","detail":"{range_begin:/registry/events/openstack/barbican-api-65b4584884-t2rhp.18b7ac00480e554f; range_end:; response_count:1; response_revision:9017; }","duration":"111.082865ms","start":"2026-06-10T08:50:24.858143Z","end":"2026-06-10T08:50:24.969226Z","steps":["trace[1420622752] 'range keys from in-memory index tree'  (duration: 110.739809ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T08:51:43.456802Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e98569549cc430c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-10T08:51:43.461503Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-06-10T08:51:43.461576Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-06-10T08:53:52.436377Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8151}
{"level":"info","ts":"2026-06-10T08:53:52.505764Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8151,"took":"66.815057ms","hash":703638605,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":30834688,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-10T08:53:52.505818Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":703638605,"revision":8151,"compact-revision":5980}
{"level":"info","ts":"2026-06-10T08:58:52.445349Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10878}
{"level":"info","ts":"2026-06-10T08:58:52.530434Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10878,"took":"82.514806ms","hash":1083449306,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":27512832,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-06-10T08:58:52.530497Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1083449306,"revision":10878,"compact-revision":8151}
{"level":"warn","ts":"2026-06-10T09:01:04.508162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.723129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-c5wkz\" ","response":"range_response_count:1 size:6530"}
{"level":"info","ts":"2026-06-10T09:01:04.508269Z","caller":"traceutil/trace.go:171","msg":"trace[909170502] range","detail":"{range_begin:/registry/pods/openstack/keepalived-c5wkz; range_end:; response_count:1; response_revision:13911; }","duration":"261.872073ms","start":"2026-06-10T09:01:04.246376Z","end":"2026-06-10T09:01:04.508248Z","steps":["trace[909170502] 'range keys from in-memory index tree'  (duration: 261.476695ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:02:35.155829Z","caller":"traceutil/trace.go:171","msg":"trace[1111383558] linearizableReadLoop","detail":"{readStateIndex:15242; appliedIndex:15241; }","duration":"129.200018ms","start":"2026-06-10T09:02:35.026602Z","end":"2026-06-10T09:02:35.155802Z","steps":["trace[1111383558] 'read index received'  (duration: 128.904692ms)","trace[1111383558] 'applied index is now lower than readState.Index'  (duration: 294.276µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:02:35.156898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.272978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-06-10T09:02:35.156944Z","caller":"traceutil/trace.go:171","msg":"trace[921364512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14738; }","duration":"130.37206ms","start":"2026-06-10T09:02:35.026559Z","end":"2026-06-10T09:02:35.156931Z","steps":["trace[921364512] 'agreement among raft nodes before linearized reading'  (duration: 129.366822ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:02:35.156917Z","caller":"traceutil/trace.go:171","msg":"trace[575837042] transaction","detail":"{read_only:false; response_revision:14738; number_of_response:1; }","duration":"138.587806ms","start":"2026-06-10T09:02:35.018299Z","end":"2026-06-10T09:02:35.156887Z","steps":["trace[575837042] 'process raft request'  (duration: 137.330111ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:02:35.28032Z","caller":"traceutil/trace.go:171","msg":"trace[713057598] transaction","detail":"{read_only:false; response_revision:14739; number_of_response:1; }","duration":"119.158108ms","start":"2026-06-10T09:02:35.16111Z","end":"2026-06-10T09:02:35.280268Z","steps":["trace[713057598] 'process raft request'  (duration: 116.620959ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:03:52.451281Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12914}
{"level":"info","ts":"2026-06-10T09:03:52.533218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12914,"took":"79.835253ms","hash":3640680488,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":29769728,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-06-10T09:03:52.533291Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3640680488,"revision":12914,"compact-revision":10878}
{"level":"info","ts":"2026-06-10T09:08:04.167249Z","caller":"traceutil/trace.go:171","msg":"trace[1499838529] linearizableReadLoop","detail":"{readStateIndex:17847; appliedIndex:17846; }","duration":"118.70353ms","start":"2026-06-10T09:08:04.048504Z","end":"2026-06-10T09:08:04.167208Z","steps":["trace[1499838529] 'read index received'  (duration: 118.506206ms)","trace[1499838529] 'applied index is now lower than readState.Index'  (duration: 196.114µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:08:04.167374Z","caller":"traceutil/trace.go:171","msg":"trace[1960868366] transaction","detail":"{read_only:false; response_revision:17261; number_of_response:1; }","duration":"229.356329ms","start":"2026-06-10T09:08:03.937992Z","end":"2026-06-10T09:08:04.167349Z","steps":["trace[1960868366] 'process raft request'  (duration: 229.031772ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:08:04.167572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.060088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:08:04.167661Z","caller":"traceutil/trace.go:171","msg":"trace[146498852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17261; }","duration":"119.19919ms","start":"2026-06-10T09:08:04.048446Z","end":"2026-06-10T09:08:04.167645Z","steps":["trace[146498852] 'agreement among raft nodes before linearized reading'  (duration: 119.054217ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:08:04.167706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.451802ms","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-10T09:08:04.167732Z","caller":"traceutil/trace.go:171","msg":"trace[1712225735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17261; }","duration":"103.514743ms","start":"2026-06-10T09:08:04.064209Z","end":"2026-06-10T09:08:04.167724Z","steps":["trace[1712225735] 'agreement among raft nodes before linearized reading'  (duration: 103.37995ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:08:04.168063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.632294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-senlin\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:08:04.168223Z","caller":"traceutil/trace.go:171","msg":"trace[785994800] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-senlin; range_end:; response_count:0; response_revision:17261; }","duration":"115.96652ms","start":"2026-06-10T09:08:04.052208Z","end":"2026-06-10T09:08:04.168174Z","steps":["trace[785994800] 'agreement among raft nodes before linearized reading'  (duration: 115.369209ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:08:04.450919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.837307ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875646816 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:17248 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:08:04.451058Z","caller":"traceutil/trace.go:171","msg":"trace[2019861902] linearizableReadLoop","detail":"{readStateIndex:17848; appliedIndex:17847; }","duration":"270.890427ms","start":"2026-06-10T09:08:04.180117Z","end":"2026-06-10T09:08:04.451007Z","steps":["trace[2019861902] 'read index received'  (duration: 125.603182ms)","trace[2019861902] 'applied index is now lower than readState.Index'  (duration: 145.285685ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:08:04.451128Z","caller":"traceutil/trace.go:171","msg":"trace[989322693] transaction","detail":"{read_only:false; response_revision:17262; number_of_response:1; }","duration":"276.461063ms","start":"2026-06-10T09:08:04.174655Z","end":"2026-06-10T09:08:04.451116Z","steps":["trace[989322693] 'process raft request'  (duration: 131.128647ms)","trace[989322693] 'compare'  (duration: 144.45503ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:08:04.451394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.249214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:08:04.451493Z","caller":"traceutil/trace.go:171","msg":"trace[1740861316] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:17262; }","duration":"271.360386ms","start":"2026-06-10T09:08:04.180104Z","end":"2026-06-10T09:08:04.451465Z","steps":["trace[1740861316] 'agreement among raft nodes before linearized reading'  (duration: 271.194842ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:08:04.475648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.831087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-06-10T09:08:04.475708Z","caller":"traceutil/trace.go:171","msg":"trace[840026431] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17263; }","duration":"106.97368ms","start":"2026-06-10T09:08:04.368719Z","end":"2026-06-10T09:08:04.475693Z","steps":["trace[840026431] 'agreement among raft nodes before linearized reading'  (duration: 106.825997ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:08:04.475708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.661659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-h766s\" ","response":"range_response_count:1 size:9800"}
{"level":"info","ts":"2026-06-10T09:08:04.475781Z","caller":"traceutil/trace.go:171","msg":"trace[588554953] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-h766s; range_end:; response_count:1; response_revision:17263; }","duration":"177.780052ms","start":"2026-06-10T09:08:04.297982Z","end":"2026-06-10T09:08:04.475762Z","steps":["trace[588554953] 'agreement among raft nodes before linearized reading'  (duration: 177.559028ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:08:52.476123Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15266}
{"level":"info","ts":"2026-06-10T09:08:52.571158Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15266,"took":"90.275531ms","hash":2057923533,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":33468416,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-06-10T09:08:52.571263Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2057923533,"revision":15266,"compact-revision":12914}
{"level":"info","ts":"2026-06-10T09:11:39.727451Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e98569549cc430c","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-10T09:11:39.733361Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-06-10T09:11:39.733472Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-06-10T09:13:52.482795Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17865}
{"level":"info","ts":"2026-06-10T09:13:52.594393Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17865,"took":"108.256298ms","hash":1790209018,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":31760384,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-06-10T09:13:52.594465Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1790209018,"revision":17865,"compact-revision":15266}
{"level":"info","ts":"2026-06-10T09:15:07.059257Z","caller":"traceutil/trace.go:171","msg":"trace[205411630] transaction","detail":"{read_only:false; response_revision:20861; number_of_response:1; }","duration":"136.178758ms","start":"2026-06-10T09:15:06.923056Z","end":"2026-06-10T09:15:07.059234Z","steps":["trace[205411630] 'process raft request'  (duration: 135.793511ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:15:24.770334Z","caller":"traceutil/trace.go:171","msg":"trace[1929663550] transaction","detail":"{read_only:false; response_revision:20971; number_of_response:1; }","duration":"173.926298ms","start":"2026-06-10T09:15:24.596377Z","end":"2026-06-10T09:15:24.770303Z","steps":["trace[1929663550] 'process raft request'  (duration: 173.679264ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:15:24.833486Z","caller":"traceutil/trace.go:171","msg":"trace[2035802631] transaction","detail":"{read_only:false; response_revision:20972; number_of_response:1; }","duration":"128.836298ms","start":"2026-06-10T09:15:24.704622Z","end":"2026-06-10T09:15:24.833458Z","steps":["trace[2035802631] 'process raft request'  (duration: 128.633664ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:15:25.261574Z","caller":"traceutil/trace.go:171","msg":"trace[2095233888] transaction","detail":"{read_only:false; response_revision:20974; number_of_response:1; }","duration":"111.605334ms","start":"2026-06-10T09:15:25.149945Z","end":"2026-06-10T09:15:25.26155Z","steps":["trace[2095233888] 'process raft request'  (duration: 111.410029ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:15:25.479406Z","caller":"traceutil/trace.go:171","msg":"trace[144112907] transaction","detail":"{read_only:false; response_revision:20975; number_of_response:1; }","duration":"189.002622ms","start":"2026-06-10T09:15:25.290366Z","end":"2026-06-10T09:15:25.479369Z","steps":["trace[144112907] 'process raft request'  (duration: 141.587348ms)","trace[144112907] 'compare'  (duration: 47.040697ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:18:52.488912Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20305}
{"level":"info","ts":"2026-06-10T09:18:52.604295Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20305,"took":"109.868282ms","hash":1437534272,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":35184640,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-06-10T09:18:52.604346Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1437534272,"revision":20305,"compact-revision":17865}
{"level":"warn","ts":"2026-06-10T09:19:02.260872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.668372ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:19:02.261045Z","caller":"traceutil/trace.go:171","msg":"trace[1804785502] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:23267; }","duration":"140.853447ms","start":"2026-06-10T09:19:02.120171Z","end":"2026-06-10T09:19:02.261025Z","steps":["trace[1804785502] 'range keys from in-memory index tree'  (duration: 140.649592ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:19:02.261349Z","caller":"traceutil/trace.go:171","msg":"trace[1168837937] transaction","detail":"{read_only:false; response_revision:23268; number_of_response:1; }","duration":"167.09985ms","start":"2026-06-10T09:19:02.094225Z","end":"2026-06-10T09:19:02.261325Z","steps":["trace[1168837937] 'process raft request'  (duration: 166.906787ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:16.254428Z","caller":"traceutil/trace.go:171","msg":"trace[585725627] transaction","detail":"{read_only:false; response_revision:25316; number_of_response:1; }","duration":"127.035821ms","start":"2026-06-10T09:22:16.127361Z","end":"2026-06-10T09:22:16.254396Z","steps":["trace[585725627] 'process raft request'  (duration: 126.662845ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:21.781468Z","caller":"traceutil/trace.go:171","msg":"trace[1290291985] transaction","detail":"{read_only:false; response_revision:25352; number_of_response:1; }","duration":"101.546062ms","start":"2026-06-10T09:22:21.679902Z","end":"2026-06-10T09:22:21.781448Z","steps":["trace[1290291985] 'process raft request'  (duration: 101.388509ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:22.04077Z","caller":"traceutil/trace.go:171","msg":"trace[1256087633] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"252.775139ms","start":"2026-06-10T09:22:21.787965Z","end":"2026-06-10T09:22:22.04074Z","steps":["trace[1256087633] 'process raft request'  (duration: 252.694048ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:22.041013Z","caller":"traceutil/trace.go:171","msg":"trace[718391073] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"253.027744ms","start":"2026-06-10T09:22:21.787962Z","end":"2026-06-10T09:22:22.04099Z","steps":["trace[718391073] 'process raft request'  (duration: 155.013358ms)","trace[718391073] 'compare'  (duration: 96.509717ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:22.312348Z","caller":"traceutil/trace.go:171","msg":"trace[1370583716] transaction","detail":"{read_only:false; response_revision:25355; number_of_response:1; }","duration":"522.928356ms","start":"2026-06-10T09:22:21.789398Z","end":"2026-06-10T09:22:22.312326Z","steps":["trace[1370583716] 'process raft request'  (duration: 431.930252ms)","trace[1370583716] 'compare'  (duration: 90.857432ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:22.312472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:21.789389Z","time spent":"523.018799ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25339 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-06-10T09:22:22.312486Z","caller":"traceutil/trace.go:171","msg":"trace[1202058162] transaction","detail":"{read_only:false; response_revision:25356; number_of_response:1; }","duration":"522.955168ms","start":"2026-06-10T09:22:21.789501Z","end":"2026-06-10T09:22:22.312456Z","steps":["trace[1202058162] 'process raft request'  (duration: 522.797495ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:22.312645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:21.789496Z","time spent":"523.06685ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25340 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-06-10T09:22:22.313509Z","caller":"traceutil/trace.go:171","msg":"trace[650598125] transaction","detail":"{read_only:false; response_revision:25357; number_of_response:1; }","duration":"269.850401ms","start":"2026-06-10T09:22:22.043612Z","end":"2026-06-10T09:22:22.313463Z","steps":["trace[650598125] 'process raft request'  (duration: 269.632987ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:22.313777Z","caller":"traceutil/trace.go:171","msg":"trace[924953909] transaction","detail":"{read_only:false; response_revision:25358; number_of_response:1; }","duration":"170.206264ms","start":"2026-06-10T09:22:22.143523Z","end":"2026-06-10T09:22:22.313729Z","steps":["trace[924953909] 'process raft request'  (duration: 169.921699ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:22.313693Z","caller":"traceutil/trace.go:171","msg":"trace[802548930] linearizableReadLoop","detail":"{readStateIndex:26175; appliedIndex:26172; }","duration":"248.03814ms","start":"2026-06-10T09:22:22.065631Z","end":"2026-06-10T09:22:22.31367Z","steps":["trace[802548930] 'read index received'  (duration: 155.738752ms)","trace[802548930] 'applied index is now lower than readState.Index'  (duration: 92.298328ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:22.314036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.380856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:22.314101Z","caller":"traceutil/trace.go:171","msg":"trace[482224628] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:25358; }","duration":"248.497109ms","start":"2026-06-10T09:22:22.065586Z","end":"2026-06-10T09:22:22.314083Z","steps":["trace[482224628] 'agreement among raft nodes before linearized reading'  (duration: 248.380437ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:25.607123Z","caller":"traceutil/trace.go:171","msg":"trace[1470597425] transaction","detail":"{read_only:false; response_revision:25388; number_of_response:1; }","duration":"266.274714ms","start":"2026-06-10T09:22:25.34082Z","end":"2026-06-10T09:22:25.607095Z","steps":["trace[1470597425] 'process raft request'  (duration: 265.915927ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:26.173975Z","caller":"traceutil/trace.go:171","msg":"trace[340801356] transaction","detail":"{read_only:false; response_revision:25391; number_of_response:1; }","duration":"116.835789ms","start":"2026-06-10T09:22:26.057107Z","end":"2026-06-10T09:22:26.173943Z","steps":["trace[340801356] 'process raft request'  (duration: 116.622855ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:26.196387Z","caller":"traceutil/trace.go:171","msg":"trace[804534268] transaction","detail":"{read_only:false; response_revision:25392; number_of_response:1; }","duration":"138.070239ms","start":"2026-06-10T09:22:26.058296Z","end":"2026-06-10T09:22:26.196367Z","steps":["trace[804534268] 'process raft request'  (duration: 137.965667ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:26.621763Z","caller":"traceutil/trace.go:171","msg":"trace[751868329] transaction","detail":"{read_only:false; response_revision:25394; number_of_response:1; }","duration":"293.314753ms","start":"2026-06-10T09:22:26.328384Z","end":"2026-06-10T09:22:26.621699Z","steps":["trace[751868329] 'process raft request'  (duration: 254.662415ms)","trace[751868329] 'compare'  (duration: 37.856623ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:26.621903Z","caller":"traceutil/trace.go:171","msg":"trace[1639463036] transaction","detail":"{read_only:false; response_revision:25396; number_of_response:1; }","duration":"225.590887ms","start":"2026-06-10T09:22:26.396271Z","end":"2026-06-10T09:22:26.621862Z","steps":["trace[1639463036] 'process raft request'  (duration: 225.523256ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:26.62209Z","caller":"traceutil/trace.go:171","msg":"trace[754915648] transaction","detail":"{read_only:false; response_revision:25395; number_of_response:1; }","duration":"270.381931ms","start":"2026-06-10T09:22:26.351676Z","end":"2026-06-10T09:22:26.622058Z","steps":["trace[754915648] 'process raft request'  (duration: 269.886502ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:26.622229Z","caller":"traceutil/trace.go:171","msg":"trace[1391629190] linearizableReadLoop","detail":"{readStateIndex:26214; appliedIndex:26212; }","duration":"231.280905ms","start":"2026-06-10T09:22:26.390933Z","end":"2026-06-10T09:22:26.622214Z","steps":["trace[1391629190] 'read index received'  (duration: 192.130988ms)","trace[1391629190] 'applied index is now lower than readState.Index'  (duration: 39.147587ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:26.62237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.024575ms","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-10T09:22:26.622418Z","caller":"traceutil/trace.go:171","msg":"trace[1611589522] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:25396; }","duration":"260.129837ms","start":"2026-06-10T09:22:26.362273Z","end":"2026-06-10T09:22:26.622403Z","steps":["trace[1611589522] 'agreement among raft nodes before linearized reading'  (duration: 260.038205ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:26.622522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.867803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"}
{"level":"info","ts":"2026-06-10T09:22:26.622579Z","caller":"traceutil/trace.go:171","msg":"trace[706731160] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25396; }","duration":"292.976326ms","start":"2026-06-10T09:22:26.329586Z","end":"2026-06-10T09:22:26.622562Z","steps":["trace[706731160] 'agreement among raft nodes before linearized reading'  (duration: 292.738642ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:26.622604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.325159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:26.622651Z","caller":"traceutil/trace.go:171","msg":"trace[397604892] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:25396; }","duration":"176.39152ms","start":"2026-06-10T09:22:26.446245Z","end":"2026-06-10T09:22:26.622636Z","steps":["trace[397604892] 'agreement among raft nodes before linearized reading'  (duration: 176.294809ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:26.965093Z","caller":"traceutil/trace.go:171","msg":"trace[1469241450] transaction","detail":"{read_only:false; response_revision:25398; number_of_response:1; }","duration":"160.35449ms","start":"2026-06-10T09:22:26.804716Z","end":"2026-06-10T09:22:26.965071Z","steps":["trace[1469241450] 'process raft request'  (duration: 147.790443ms)","trace[1469241450] 'compare'  (duration: 12.077068ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:30.335685Z","caller":"traceutil/trace.go:171","msg":"trace[1806859102] linearizableReadLoop","detail":"{readStateIndex:26238; appliedIndex:26237; }","duration":"124.201219ms","start":"2026-06-10T09:22:30.211462Z","end":"2026-06-10T09:22:30.335663Z","steps":["trace[1806859102] 'read index received'  (duration: 110.886888ms)","trace[1806859102] 'applied index is now lower than readState.Index'  (duration: 13.313571ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:30.335764Z","caller":"traceutil/trace.go:171","msg":"trace[1047698292] transaction","detail":"{read_only:false; response_revision:25419; number_of_response:1; }","duration":"141.920983ms","start":"2026-06-10T09:22:30.193814Z","end":"2026-06-10T09:22:30.335735Z","steps":["trace[1047698292] 'process raft request'  (duration: 128.638863ms)","trace[1047698292] 'compare'  (duration: 12.876743ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:30.335885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.436493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-06-10T09:22:30.335939Z","caller":"traceutil/trace.go:171","msg":"trace[265203997] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25419; }","duration":"124.540975ms","start":"2026-06-10T09:22:30.211382Z","end":"2026-06-10T09:22:30.335923Z","steps":["trace[265203997] 'agreement among raft nodes before linearized reading'  (duration: 124.382472ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:30.585258Z","caller":"traceutil/trace.go:171","msg":"trace[602256627] transaction","detail":"{read_only:false; response_revision:25420; number_of_response:1; }","duration":"245.099924ms","start":"2026-06-10T09:22:30.340119Z","end":"2026-06-10T09:22:30.585219Z","steps":["trace[602256627] 'process raft request'  (duration: 164.225542ms)","trace[602256627] 'compare'  (duration: 80.523126ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:30.635758Z","caller":"traceutil/trace.go:171","msg":"trace[894672874] transaction","detail":"{read_only:false; response_revision:25421; number_of_response:1; }","duration":"233.390415ms","start":"2026-06-10T09:22:30.402346Z","end":"2026-06-10T09:22:30.635737Z","steps":["trace[894672874] 'process raft request'  (duration: 233.212552ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:30.92012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.997092ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875669640 > lease_revoke:<id:430c9eb0aa9ed96d>","response":"size:28"}
{"level":"info","ts":"2026-06-10T09:22:30.920349Z","caller":"traceutil/trace.go:171","msg":"trace[1505792152] linearizableReadLoop","detail":"{readStateIndex:26241; appliedIndex:26239; }","duration":"295.342342ms","start":"2026-06-10T09:22:30.624988Z","end":"2026-06-10T09:22:30.920331Z","steps":["trace[1505792152] 'read index received'  (duration: 10.57212ms)","trace[1505792152] 'applied index is now lower than readState.Index'  (duration: 284.769212ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:30.920703Z","caller":"traceutil/trace.go:171","msg":"trace[1938752335] transaction","detail":"{read_only:false; response_revision:25422; number_of_response:1; }","duration":"284.780792ms","start":"2026-06-10T09:22:30.635888Z","end":"2026-06-10T09:22:30.920669Z","steps":["trace[1938752335] 'process raft request'  (duration: 284.337774ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:30.921913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.907671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-06-10T09:22:30.921959Z","caller":"traceutil/trace.go:171","msg":"trace[1042767662] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25421; }","duration":"296.992042ms","start":"2026-06-10T09:22:30.624954Z","end":"2026-06-10T09:22:30.921946Z","steps":["trace[1042767662] 'agreement among raft nodes before linearized reading'  (duration: 295.474434ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:30.942458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.589865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-06-10T09:22:30.94254Z","caller":"traceutil/trace.go:171","msg":"trace[389864739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25423; }","duration":"304.700158ms","start":"2026-06-10T09:22:30.637823Z","end":"2026-06-10T09:22:30.942523Z","steps":["trace[389864739] 'agreement among raft nodes before linearized reading'  (duration: 304.495793ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:30.942623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:30.637815Z","time spent":"304.79716ms","remote":"127.0.0.1:41988","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-10T09:22:30.942912Z","caller":"traceutil/trace.go:171","msg":"trace[153598824] transaction","detail":"{read_only:false; response_revision:25423; number_of_response:1; }","duration":"303.784571ms","start":"2026-06-10T09:22:30.63911Z","end":"2026-06-10T09:22:30.942894Z","steps":["trace[153598824] 'process raft request'  (duration: 281.536632ms)","trace[153598824] 'compare'  (duration: 21.483724ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:30.943042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:30.639097Z","time spent":"303.853522ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25408 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-06-10T09:22:30.943465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.72117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:30.943513Z","caller":"traceutil/trace.go:171","msg":"trace[422806494] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:25423; }","duration":"140.775981ms","start":"2026-06-10T09:22:30.802725Z","end":"2026-06-10T09:22:30.943501Z","steps":["trace[422806494] 'agreement among raft nodes before linearized reading'  (duration: 140.674669ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:30.943833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.596358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"}
{"level":"info","ts":"2026-06-10T09:22:30.943874Z","caller":"traceutil/trace.go:171","msg":"trace[358383118] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25423; }","duration":"251.68289ms","start":"2026-06-10T09:22:30.692182Z","end":"2026-06-10T09:22:30.943865Z","steps":["trace[358383118] 'agreement among raft nodes before linearized reading'  (duration: 251.550027ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:31.195836Z","caller":"traceutil/trace.go:171","msg":"trace[1808695163] linearizableReadLoop","detail":"{readStateIndex:26247; appliedIndex:26244; }","duration":"200.076677ms","start":"2026-06-10T09:22:30.995739Z","end":"2026-06-10T09:22:31.195815Z","steps":["trace[1808695163] 'read index received'  (duration: 199.74773ms)","trace[1808695163] 'applied index is now lower than readState.Index'  (duration: 328.177µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:31.196232Z","caller":"traceutil/trace.go:171","msg":"trace[277018914] transaction","detail":"{read_only:false; response_revision:25427; number_of_response:1; }","duration":"219.042135ms","start":"2026-06-10T09:22:30.977156Z","end":"2026-06-10T09:22:31.196198Z","steps":["trace[277018914] 'process raft request'  (duration: 218.623207ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:31.196264Z","caller":"traceutil/trace.go:171","msg":"trace[724253597] transaction","detail":"{read_only:false; response_revision:25425; number_of_response:1; }","duration":"245.776608ms","start":"2026-06-10T09:22:30.950452Z","end":"2026-06-10T09:22:31.196229Z","steps":["trace[724253597] 'process raft request'  (duration: 245.087545ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:31.196443Z","caller":"traceutil/trace.go:171","msg":"trace[843467497] transaction","detail":"{read_only:false; response_revision:25426; number_of_response:1; }","duration":"220.852029ms","start":"2026-06-10T09:22:30.975571Z","end":"2026-06-10T09:22:31.196423Z","steps":["trace[843467497] 'process raft request'  (duration: 220.149956ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:31.196486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.732399ms","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-10T09:22:31.196575Z","caller":"traceutil/trace.go:171","msg":"trace[1661076168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25427; }","duration":"200.874341ms","start":"2026-06-10T09:22:30.995678Z","end":"2026-06-10T09:22:31.196552Z","steps":["trace[1661076168] 'agreement among raft nodes before linearized reading'  (duration: 200.568106ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:31.253719Z","caller":"traceutil/trace.go:171","msg":"trace[1624165795] transaction","detail":"{read_only:false; response_revision:25428; number_of_response:1; }","duration":"142.997302ms","start":"2026-06-10T09:22:31.110693Z","end":"2026-06-10T09:22:31.25369Z","steps":["trace[1624165795] 'process raft request'  (duration: 142.715817ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:31.25378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.654535ms","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-10T09:22:31.253875Z","caller":"traceutil/trace.go:171","msg":"trace[1503563466] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25428; }","duration":"152.791087ms","start":"2026-06-10T09:22:31.101058Z","end":"2026-06-10T09:22:31.253849Z","steps":["trace[1503563466] 'agreement among raft nodes before linearized reading'  (duration: 152.521762ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:31.449726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.605154ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875669651 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25413 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:22:31.44981Z","caller":"traceutil/trace.go:171","msg":"trace[401344121] transaction","detail":"{read_only:false; response_revision:25429; number_of_response:1; }","duration":"249.247703ms","start":"2026-06-10T09:22:31.200546Z","end":"2026-06-10T09:22:31.449794Z","steps":["trace[401344121] 'process raft request'  (duration: 147.446475ms)","trace[401344121] 'compare'  (duration: 101.376289ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:31.840806Z","caller":"traceutil/trace.go:171","msg":"trace[1313651862] transaction","detail":"{read_only:false; response_revision:25430; number_of_response:1; }","duration":"134.911459ms","start":"2026-06-10T09:22:31.705875Z","end":"2026-06-10T09:22:31.840786Z","steps":["trace[1313651862] 'process raft request'  (duration: 134.770107ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:32.150153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.408533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:32.150226Z","caller":"traceutil/trace.go:171","msg":"trace[665699454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25430; }","duration":"107.529975ms","start":"2026-06-10T09:22:32.042681Z","end":"2026-06-10T09:22:32.150211Z","steps":["trace[665699454] 'range keys from in-memory index tree'  (duration: 107.28232ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:32.15053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.164195ms","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-10T09:22:32.150573Z","caller":"traceutil/trace.go:171","msg":"trace[1594087632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25430; }","duration":"246.243247ms","start":"2026-06-10T09:22:31.90432Z","end":"2026-06-10T09:22:32.150563Z","steps":["trace[1594087632] 'range keys from in-memory index tree'  (duration: 245.994502ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:32.424232Z","caller":"traceutil/trace.go:171","msg":"trace[1960224093] linearizableReadLoop","detail":"{readStateIndex:26251; appliedIndex:26250; }","duration":"215.736932ms","start":"2026-06-10T09:22:32.208471Z","end":"2026-06-10T09:22:32.424208Z","steps":["trace[1960224093] 'read index received'  (duration: 215.497388ms)","trace[1960224093] 'applied index is now lower than readState.Index'  (duration: 238.624µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:32.424334Z","caller":"traceutil/trace.go:171","msg":"trace[1679773891] transaction","detail":"{read_only:false; response_revision:25431; number_of_response:1; }","duration":"270.979513ms","start":"2026-06-10T09:22:32.153342Z","end":"2026-06-10T09:22:32.424321Z","steps":["trace[1679773891] 'process raft request'  (duration: 270.717157ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:32.424717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.232783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-06-10T09:22:32.42482Z","caller":"traceutil/trace.go:171","msg":"trace[2006896928] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:25431; }","duration":"216.379335ms","start":"2026-06-10T09:22:32.208414Z","end":"2026-06-10T09:22:32.424794Z","steps":["trace[2006896928] 'agreement among raft nodes before linearized reading'  (duration: 215.931077ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:32.448736Z","caller":"traceutil/trace.go:171","msg":"trace[1024889888] transaction","detail":"{read_only:false; response_revision:25432; number_of_response:1; }","duration":"122.24549ms","start":"2026-06-10T09:22:32.326471Z","end":"2026-06-10T09:22:32.448717Z","steps":["trace[1024889888] 'process raft request'  (duration: 122.034246ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:32.448853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.353849ms","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-10T09:22:32.448929Z","caller":"traceutil/trace.go:171","msg":"trace[192815040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25432; }","duration":"109.463301ms","start":"2026-06-10T09:22:32.33945Z","end":"2026-06-10T09:22:32.448914Z","steps":["trace[192815040] 'agreement among raft nodes before linearized reading'  (duration: 109.264307ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:32.581286Z","caller":"traceutil/trace.go:171","msg":"trace[695286394] transaction","detail":"{read_only:false; response_revision:25433; number_of_response:1; }","duration":"121.151402ms","start":"2026-06-10T09:22:32.460107Z","end":"2026-06-10T09:22:32.581259Z","steps":["trace[695286394] 'process raft request'  (duration: 119.893828ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:32.875891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.96764ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875669668 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25420 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:22:32.87606Z","caller":"traceutil/trace.go:171","msg":"trace[2033764259] transaction","detail":"{read_only:false; response_revision:25436; number_of_response:1; }","duration":"124.841111ms","start":"2026-06-10T09:22:32.751209Z","end":"2026-06-10T09:22:32.87605Z","steps":["trace[2033764259] 'process raft request'  (duration: 124.816261ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:32.876184Z","caller":"traceutil/trace.go:171","msg":"trace[1379100677] transaction","detail":"{read_only:false; response_revision:25434; number_of_response:1; }","duration":"281.95676ms","start":"2026-06-10T09:22:32.59422Z","end":"2026-06-10T09:22:32.876177Z","steps":["trace[1379100677] 'process raft request'  (duration: 138.201532ms)","trace[1379100677] 'compare'  (duration: 143.312289ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:32.876314Z","caller":"traceutil/trace.go:171","msg":"trace[2098271918] transaction","detail":"{read_only:false; response_revision:25435; number_of_response:1; }","duration":"235.059726ms","start":"2026-06-10T09:22:32.641249Z","end":"2026-06-10T09:22:32.876309Z","steps":["trace[2098271918] 'process raft request'  (duration: 234.71379ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:32.87638Z","caller":"traceutil/trace.go:171","msg":"trace[484140412] linearizableReadLoop","detail":"{readStateIndex:26255; appliedIndex:26253; }","duration":"215.157231ms","start":"2026-06-10T09:22:32.661218Z","end":"2026-06-10T09:22:32.876375Z","steps":["trace[484140412] 'read index received'  (duration: 71.18104ms)","trace[484140412] 'applied index is now lower than readState.Index'  (duration: 143.975471ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:32.876473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.256253ms","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-10T09:22:32.876492Z","caller":"traceutil/trace.go:171","msg":"trace[1512904249] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25436; }","duration":"215.312084ms","start":"2026-06-10T09:22:32.661176Z","end":"2026-06-10T09:22:32.876488Z","steps":["trace[1512904249] 'agreement among raft nodes before linearized reading'  (duration: 215.277524ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:32.876681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.449834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:32.87675Z","caller":"traceutil/trace.go:171","msg":"trace[1321482173] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:25436; }","duration":"209.559586ms","start":"2026-06-10T09:22:32.667175Z","end":"2026-06-10T09:22:32.876734Z","steps":["trace[1321482173] 'agreement among raft nodes before linearized reading'  (duration: 209.435234ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.159467Z","caller":"traceutil/trace.go:171","msg":"trace[2088772880] transaction","detail":"{read_only:false; response_revision:25437; number_of_response:1; }","duration":"277.25482ms","start":"2026-06-10T09:22:32.882184Z","end":"2026-06-10T09:22:33.159439Z","steps":["trace[2088772880] 'process raft request'  (duration: 257.712292ms)","trace[2088772880] 'compare'  (duration: 19.212612ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:33.159469Z","caller":"traceutil/trace.go:171","msg":"trace[1628245614] linearizableReadLoop","detail":"{readStateIndex:26257; appliedIndex:26256; }","duration":"276.985295ms","start":"2026-06-10T09:22:32.88245Z","end":"2026-06-10T09:22:33.159435Z","steps":["trace[1628245614] 'read index received'  (duration: 257.469597ms)","trace[1628245614] 'applied index is now lower than readState.Index'  (duration: 19.514168ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:33.159721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.258561ms","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-10T09:22:33.159809Z","caller":"traceutil/trace.go:171","msg":"trace[821449606] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25437; }","duration":"277.370393ms","start":"2026-06-10T09:22:32.882419Z","end":"2026-06-10T09:22:33.159789Z","steps":["trace[821449606] 'agreement among raft nodes before linearized reading'  (duration: 277.156949ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.224935Z","caller":"traceutil/trace.go:171","msg":"trace[1402945237] transaction","detail":"{read_only:false; response_revision:25439; number_of_response:1; }","duration":"274.813244ms","start":"2026-06-10T09:22:32.95009Z","end":"2026-06-10T09:22:33.224903Z","steps":["trace[1402945237] 'process raft request'  (duration: 274.719112ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.224966Z","caller":"traceutil/trace.go:171","msg":"trace[1731882296] transaction","detail":"{read_only:false; response_revision:25438; number_of_response:1; }","duration":"298.769365ms","start":"2026-06-10T09:22:32.926172Z","end":"2026-06-10T09:22:33.224941Z","steps":["trace[1731882296] 'process raft request'  (duration: 298.47796ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:33.225132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.191904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:33.225202Z","caller":"traceutil/trace.go:171","msg":"trace[1510424110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25439; }","duration":"179.270335ms","start":"2026-06-10T09:22:33.045916Z","end":"2026-06-10T09:22:33.225186Z","steps":["trace[1510424110] 'agreement among raft nodes before linearized reading'  (duration: 179.143883ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:33.225215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.735309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"}
{"level":"warn","ts":"2026-06-10T09:22:33.225149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.029069ms","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-10T09:22:33.225289Z","caller":"traceutil/trace.go:171","msg":"trace[1330192102] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25439; }","duration":"235.8516ms","start":"2026-06-10T09:22:32.989417Z","end":"2026-06-10T09:22:33.225268Z","steps":["trace[1330192102] 'agreement among raft nodes before linearized reading'  (duration: 235.622516ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.225379Z","caller":"traceutil/trace.go:171","msg":"trace[590021045] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25439; }","duration":"282.261604ms","start":"2026-06-10T09:22:32.943073Z","end":"2026-06-10T09:22:33.225335Z","steps":["trace[590021045] 'agreement among raft nodes before linearized reading'  (duration: 281.957989ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.325498Z","caller":"traceutil/trace.go:171","msg":"trace[1375693061] transaction","detail":"{read_only:false; response_revision:25440; number_of_response:1; }","duration":"123.372153ms","start":"2026-06-10T09:22:33.202095Z","end":"2026-06-10T09:22:33.325467Z","steps":["trace[1375693061] 'process raft request'  (duration: 120.837925ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.325534Z","caller":"traceutil/trace.go:171","msg":"trace[1167684394] linearizableReadLoop","detail":"{readStateIndex:26261; appliedIndex:26259; }","duration":"100.642365ms","start":"2026-06-10T09:22:33.224859Z","end":"2026-06-10T09:22:33.325502Z","steps":["trace[1167684394] 'read index received'  (duration: 98.081167ms)","trace[1167684394] 'applied index is now lower than readState.Index'  (duration: 2.559928ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:33.325599Z","caller":"traceutil/trace.go:171","msg":"trace[499049900] transaction","detail":"{read_only:false; response_revision:25441; number_of_response:1; }","duration":"123.327422ms","start":"2026-06-10T09:22:33.202237Z","end":"2026-06-10T09:22:33.325565Z","steps":["trace[499049900] 'process raft request'  (duration: 123.039066ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:33.325761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.877671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"warn","ts":"2026-06-10T09:22:33.325779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.65789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18256"}
{"level":"info","ts":"2026-06-10T09:22:33.325831Z","caller":"traceutil/trace.go:171","msg":"trace[2024818220] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25441; }","duration":"124.994202ms","start":"2026-06-10T09:22:33.200819Z","end":"2026-06-10T09:22:33.325814Z","steps":["trace[2024818220] 'agreement among raft nodes before linearized reading'  (duration: 124.769848ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.32584Z","caller":"traceutil/trace.go:171","msg":"trace[1660914901] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25441; }","duration":"164.783372ms","start":"2026-06-10T09:22:33.161042Z","end":"2026-06-10T09:22:33.325825Z","steps":["trace[1660914901] 'agreement among raft nodes before linearized reading'  (duration: 164.596589ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.590962Z","caller":"traceutil/trace.go:171","msg":"trace[1347868813] transaction","detail":"{read_only:false; response_revision:25442; number_of_response:1; }","duration":"361.311144ms","start":"2026-06-10T09:22:33.229622Z","end":"2026-06-10T09:22:33.590933Z","steps":["trace[1347868813] 'process raft request'  (duration: 275.293304ms)","trace[1347868813] 'compare'  (duration: 85.618483ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:33.59109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.133376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-10T09:22:33.591106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:33.22961Z","time spent":"361.418306ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25424 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-06-10T09:22:33.591147Z","caller":"traceutil/trace.go:171","msg":"trace[1534990543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25443; }","duration":"364.236439ms","start":"2026-06-10T09:22:33.226898Z","end":"2026-06-10T09:22:33.591134Z","steps":["trace[1534990543] 'agreement among raft nodes before linearized reading'  (duration: 364.116936ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.591128Z","caller":"traceutil/trace.go:171","msg":"trace[1559531394] transaction","detail":"{read_only:false; response_revision:25443; number_of_response:1; }","duration":"332.823688ms","start":"2026-06-10T09:22:33.258257Z","end":"2026-06-10T09:22:33.591081Z","steps":["trace[1559531394] 'process raft request'  (duration: 332.575773ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:33.591542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:33.258232Z","time spent":"333.088472ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25428 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-06-10T09:22:33.591179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:33.226882Z","time spent":"364.289639ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-06-10T09:22:33.590962Z","caller":"traceutil/trace.go:171","msg":"trace[1404250029] linearizableReadLoop","detail":"{readStateIndex:26263; appliedIndex:26261; }","duration":"265.326256ms","start":"2026-06-10T09:22:33.32561Z","end":"2026-06-10T09:22:33.590936Z","steps":["trace[1404250029] 'read index received'  (duration: 179.301766ms)","trace[1404250029] 'applied index is now lower than readState.Index'  (duration: 86.02331ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:33.736267Z","caller":"traceutil/trace.go:171","msg":"trace[1284392474] linearizableReadLoop","detail":"{readStateIndex:26264; appliedIndex:26263; }","duration":"144.357749ms","start":"2026-06-10T09:22:33.591882Z","end":"2026-06-10T09:22:33.73624Z","steps":["trace[1284392474] 'read index received'  (duration: 131.579218ms)","trace[1284392474] 'applied index is now lower than readState.Index'  (duration: 12.777371ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:33.736591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"}
{"level":"warn","ts":"2026-06-10T09:22:33.736593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.104891ms","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-10T09:22:33.736669Z","caller":"traceutil/trace.go:171","msg":"trace[661418557] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25444; }","duration":"283.241284ms","start":"2026-06-10T09:22:33.453415Z","end":"2026-06-10T09:22:33.736656Z","steps":["trace[661418557] 'agreement among raft nodes before linearized reading'  (duration: 282.969009ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:33.736663Z","caller":"traceutil/trace.go:171","msg":"trace[155277760] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25444; }","duration":"399.418171ms","start":"2026-06-10T09:22:33.337225Z","end":"2026-06-10T09:22:33.736643Z","steps":["trace[155277760] 'agreement among raft nodes before linearized reading'  (duration: 399.188777ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:33.736742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:33.337211Z","time spent":"399.517363ms","remote":"127.0.0.1:56868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5706,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-06-10T09:22:33.736352Z","caller":"traceutil/trace.go:171","msg":"trace[1121728929] transaction","detail":"{read_only:false; response_revision:25444; number_of_response:1; }","duration":"405.19777ms","start":"2026-06-10T09:22:33.331118Z","end":"2026-06-10T09:22:33.736315Z","steps":["trace[1121728929] 'process raft request'  (duration: 392.325327ms)","trace[1121728929] 'compare'  (duration: 12.656599ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:33.737149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:33.33109Z","time spent":"405.983404ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25425 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-06-10T09:22:34.053873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.570266ms","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-10T09:22:34.053924Z","caller":"traceutil/trace.go:171","msg":"trace[1399985766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25445; }","duration":"209.619107ms","start":"2026-06-10T09:22:33.844292Z","end":"2026-06-10T09:22:34.053911Z","steps":["trace[1399985766] 'range keys from in-memory index tree'  (duration: 209.459094ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:34.053767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.09886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:34.05462Z","caller":"traceutil/trace.go:171","msg":"trace[335978399] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:25445; }","duration":"207.977466ms","start":"2026-06-10T09:22:33.846617Z","end":"2026-06-10T09:22:34.054595Z","steps":["trace[335978399] 'count revisions from in-memory index tree'  (duration: 207.068139ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:34.192654Z","caller":"traceutil/trace.go:171","msg":"trace[1687886171] transaction","detail":"{read_only:false; response_revision:25446; number_of_response:1; }","duration":"133.24842ms","start":"2026-06-10T09:22:34.05938Z","end":"2026-06-10T09:22:34.192629Z","steps":["trace[1687886171] 'process raft request'  (duration: 133.076887ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:34.657314Z","caller":"traceutil/trace.go:171","msg":"trace[1644820748] transaction","detail":"{read_only:false; response_revision:25447; number_of_response:1; }","duration":"146.746894ms","start":"2026-06-10T09:22:34.510523Z","end":"2026-06-10T09:22:34.65727Z","steps":["trace[1644820748] 'process raft request'  (duration: 146.279514ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:35.059828Z","caller":"traceutil/trace.go:171","msg":"trace[430935653] transaction","detail":"{read_only:false; response_revision:25450; number_of_response:1; }","duration":"178.689434ms","start":"2026-06-10T09:22:34.881111Z","end":"2026-06-10T09:22:35.0598Z","steps":["trace[430935653] 'process raft request'  (duration: 144.880138ms)","trace[430935653] 'compare'  (duration: 33.624563ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:35.060171Z","caller":"traceutil/trace.go:171","msg":"trace[1384849693] transaction","detail":"{read_only:false; response_revision:25451; number_of_response:1; }","duration":"173.6684ms","start":"2026-06-10T09:22:34.886474Z","end":"2026-06-10T09:22:35.060142Z","steps":["trace[1384849693] 'process raft request'  (duration: 173.281292ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:35.524974Z","caller":"traceutil/trace.go:171","msg":"trace[1673081083] transaction","detail":"{read_only:false; response_revision:25453; number_of_response:1; }","duration":"293.764411ms","start":"2026-06-10T09:22:35.231183Z","end":"2026-06-10T09:22:35.524947Z","steps":["trace[1673081083] 'process raft request'  (duration: 293.564558ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:35.543672Z","caller":"traceutil/trace.go:171","msg":"trace[167217129] linearizableReadLoop","detail":"{readStateIndex:26276; appliedIndex:26272; }","duration":"207.402035ms","start":"2026-06-10T09:22:35.336246Z","end":"2026-06-10T09:22:35.543648Z","steps":["trace[167217129] 'read index received'  (duration: 188.55029ms)","trace[167217129] 'applied index is now lower than readState.Index'  (duration: 18.850585ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:35.543809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.558108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/networks/\" range_end:\"/registry/openstack.k-orc.cloud/networks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:35.543854Z","caller":"traceutil/trace.go:171","msg":"trace[936641256] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/networks/; range_end:/registry/openstack.k-orc.cloud/networks0; response_count:0; response_revision:25456; }","duration":"207.656939ms","start":"2026-06-10T09:22:35.336182Z","end":"2026-06-10T09:22:35.543839Z","steps":["trace[936641256] 'agreement among raft nodes before linearized reading'  (duration: 207.566008ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:35.543846Z","caller":"traceutil/trace.go:171","msg":"trace[902296781] transaction","detail":"{read_only:false; response_revision:25455; number_of_response:1; }","duration":"213.235575ms","start":"2026-06-10T09:22:35.330577Z","end":"2026-06-10T09:22:35.543812Z","steps":["trace[902296781] 'process raft request'  (duration: 212.95597ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:35.54388Z","caller":"traceutil/trace.go:171","msg":"trace[1878098379] transaction","detail":"{read_only:false; response_revision:25454; number_of_response:1; }","duration":"312.005385ms","start":"2026-06-10T09:22:35.231853Z","end":"2026-06-10T09:22:35.543859Z","steps":["trace[1878098379] 'process raft request'  (duration: 311.533826ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:35.544028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:35.231832Z","time spent":"312.103616ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25438 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:506 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-06-10T09:22:35.544046Z","caller":"traceutil/trace.go:171","msg":"trace[692426384] transaction","detail":"{read_only:false; response_revision:25456; number_of_response:1; }","duration":"211.574273ms","start":"2026-06-10T09:22:35.33246Z","end":"2026-06-10T09:22:35.544034Z","steps":["trace[692426384] 'process raft request'  (duration: 211.125145ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:35.696363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.303469ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875669713 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:430c9eb0aa9edad0>","response":"size:40"}
{"level":"warn","ts":"2026-06-10T09:22:36.062688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.797607ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875669716 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.216\" mod_revision:25389 > success:<request_put:<key:\"/registry/masterleases/199.204.45.216\" value_size:68 lease:4831410981875669712 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.216\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:22:36.06294Z","caller":"traceutil/trace.go:171","msg":"trace[542406348] linearizableReadLoop","detail":"{readStateIndex:26280; appliedIndex:26278; }","duration":"322.314789ms","start":"2026-06-10T09:22:35.740606Z","end":"2026-06-10T09:22:36.062921Z","steps":["trace[542406348] 'read index received'  (duration: 75.221487ms)","trace[542406348] 'applied index is now lower than readState.Index'  (duration: 247.092262ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:36.06307Z","caller":"traceutil/trace.go:171","msg":"trace[1241955859] transaction","detail":"{read_only:false; response_revision:25458; number_of_response:1; }","duration":"365.317939ms","start":"2026-06-10T09:22:35.697734Z","end":"2026-06-10T09:22:36.063052Z","steps":["trace[1241955859] 'process raft request'  (duration: 118.046923ms)","trace[1241955859] 'compare'  (duration: 246.576173ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:36.063195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:35.697713Z","time spent":"365.40071ms","remote":"127.0.0.1:41718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.216\" mod_revision:25389 > success:<request_put:<key:\"/registry/masterleases/199.204.45.216\" value_size:68 lease:4831410981875669712 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.216\" > >"}
{"level":"info","ts":"2026-06-10T09:22:36.063267Z","caller":"traceutil/trace.go:171","msg":"trace[1031641269] transaction","detail":"{read_only:false; response_revision:25459; number_of_response:1; }","duration":"362.851852ms","start":"2026-06-10T09:22:35.700387Z","end":"2026-06-10T09:22:36.063239Z","steps":["trace[1031641269] 'process raft request'  (duration: 362.440014ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:36.06332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.594961ms","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-10T09:22:36.063393Z","caller":"traceutil/trace.go:171","msg":"trace[1430484619] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:25459; }","duration":"249.708643ms","start":"2026-06-10T09:22:35.813665Z","end":"2026-06-10T09:22:36.063373Z","steps":["trace[1430484619] 'agreement among raft nodes before linearized reading'  (duration: 249.578059ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:36.063422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:35.700365Z","time spent":"362.966435ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:25442 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-06-10T09:22:36.063428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.800739ms","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-10T09:22:36.063515Z","caller":"traceutil/trace.go:171","msg":"trace[1036434856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25459; }","duration":"322.947572ms","start":"2026-06-10T09:22:35.740546Z","end":"2026-06-10T09:22:36.063494Z","steps":["trace[1036434856] 'agreement among raft nodes before linearized reading'  (duration: 322.652405ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:36.063527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.04629ms","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-10T09:22:36.06356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:35.740524Z","time spent":"323.027643ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-06-10T09:22:36.063591Z","caller":"traceutil/trace.go:171","msg":"trace[1616682276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25459; }","duration":"291.157902ms","start":"2026-06-10T09:22:35.772415Z","end":"2026-06-10T09:22:36.063572Z","steps":["trace[1616682276] 'agreement among raft nodes before linearized reading'  (duration: 290.824325ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:36.296709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.138317ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875669724 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25444 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:22:36.296848Z","caller":"traceutil/trace.go:171","msg":"trace[483486735] linearizableReadLoop","detail":"{readStateIndex:26282; appliedIndex:26280; }","duration":"227.83229ms","start":"2026-06-10T09:22:36.068998Z","end":"2026-06-10T09:22:36.29683Z","steps":["trace[483486735] 'read index received'  (duration: 63.857392ms)","trace[483486735] 'applied index is now lower than readState.Index'  (duration: 163.973348ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:36.296913Z","caller":"traceutil/trace.go:171","msg":"trace[168251016] transaction","detail":"{read_only:false; response_revision:25461; number_of_response:1; }","duration":"227.948922ms","start":"2026-06-10T09:22:36.068926Z","end":"2026-06-10T09:22:36.296875Z","steps":["trace[168251016] 'process raft request'  (duration: 102.54645ms)","trace[168251016] 'compare'  (duration: 125.006324ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:36.29707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.058854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-06-10T09:22:36.297123Z","caller":"traceutil/trace.go:171","msg":"trace[350202660] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:25461; }","duration":"228.168556ms","start":"2026-06-10T09:22:36.06894Z","end":"2026-06-10T09:22:36.297109Z","steps":["trace[350202660] 'agreement among raft nodes before linearized reading'  (duration: 227.959002ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:36.822964Z","caller":"traceutil/trace.go:171","msg":"trace[82646470] linearizableReadLoop","detail":"{readStateIndex:26284; appliedIndex:26283; }","duration":"140.26419ms","start":"2026-06-10T09:22:36.682675Z","end":"2026-06-10T09:22:36.822939Z","steps":["trace[82646470] 'read index received'  (duration: 139.977125ms)","trace[82646470] 'applied index is now lower than readState.Index'  (duration: 286.105µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:36.823176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.485625ms","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-10T09:22:36.82323Z","caller":"traceutil/trace.go:171","msg":"trace[1374153062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25463; }","duration":"140.588196ms","start":"2026-06-10T09:22:36.682628Z","end":"2026-06-10T09:22:36.823217Z","steps":["trace[1374153062] 'agreement among raft nodes before linearized reading'  (duration: 140.403323ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:36.82331Z","caller":"traceutil/trace.go:171","msg":"trace[476558052] transaction","detail":"{read_only:false; response_revision:25463; number_of_response:1; }","duration":"158.928492ms","start":"2026-06-10T09:22:36.664343Z","end":"2026-06-10T09:22:36.823272Z","steps":["trace[476558052] 'process raft request'  (duration: 158.367452ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:37.084008Z","caller":"traceutil/trace.go:171","msg":"trace[1959329630] transaction","detail":"{read_only:false; response_revision:25464; number_of_response:1; }","duration":"256.886308ms","start":"2026-06-10T09:22:36.827096Z","end":"2026-06-10T09:22:37.083982Z","steps":["trace[1959329630] 'process raft request'  (duration: 256.749435ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.206259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.702549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-10T09:22:44.206285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.928718ms","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-10T09:22:44.206336Z","caller":"traceutil/trace.go:171","msg":"trace[1701274536] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25572; }","duration":"157.830621ms","start":"2026-06-10T09:22:44.048489Z","end":"2026-06-10T09:22:44.206319Z","steps":["trace[1701274536] 'range keys from in-memory index tree'  (duration: 157.620728ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:44.206359Z","caller":"traceutil/trace.go:171","msg":"trace[1527371565] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25572; }","duration":"307.051011ms","start":"2026-06-10T09:22:43.89929Z","end":"2026-06-10T09:22:44.206341Z","steps":["trace[1527371565] 'range keys from in-memory index tree'  (duration: 306.721455ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.206403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:43.899268Z","time spent":"307.121123ms","remote":"127.0.0.1:41880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-06-10T09:22:44.2065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.228358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-63c3d7c8-8bd4-49be-81c5-306ca2f55588\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-06-10T09:22:44.206601Z","caller":"traceutil/trace.go:171","msg":"trace[116530689] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-63c3d7c8-8bd4-49be-81c5-306ca2f55588; range_end:; response_count:1; response_revision:25572; }","duration":"253.3633ms","start":"2026-06-10T09:22:43.953213Z","end":"2026-06-10T09:22:44.206576Z","steps":["trace[116530689] 'range keys from in-memory index tree'  (duration: 253.016844ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.206636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.098637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-10T09:22:44.206703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.577769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-63c3d7c8-8bd4-49be-81c5-306ca2f55588\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-06-10T09:22:44.206717Z","caller":"traceutil/trace.go:171","msg":"trace[1607942070] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:25572; }","duration":"269.184598ms","start":"2026-06-10T09:22:43.937514Z","end":"2026-06-10T09:22:44.206699Z","steps":["trace[1607942070] 'count revisions from in-memory index tree'  (duration: 269.014646ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:44.206746Z","caller":"traceutil/trace.go:171","msg":"trace[1254159570] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-63c3d7c8-8bd4-49be-81c5-306ca2f55588; range_end:; response_count:1; response_revision:25572; }","duration":"214.642351ms","start":"2026-06-10T09:22:43.992091Z","end":"2026-06-10T09:22:44.206733Z","steps":["trace[1254159570] 'range keys from in-memory index tree'  (duration: 214.433757ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.207301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.461411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"}
{"level":"info","ts":"2026-06-10T09:22:44.207391Z","caller":"traceutil/trace.go:171","msg":"trace[130615974] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25572; }","duration":"110.593743ms","start":"2026-06-10T09:22:44.096774Z","end":"2026-06-10T09:22:44.207367Z","steps":["trace[130615974] 'range keys from in-memory index tree'  (duration: 109.512742ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:44.487367Z","caller":"traceutil/trace.go:171","msg":"trace[260879636] linearizableReadLoop","detail":"{readStateIndex:26397; appliedIndex:26396; }","duration":"275.162711ms","start":"2026-06-10T09:22:44.212175Z","end":"2026-06-10T09:22:44.487338Z","steps":["trace[260879636] 'read index received'  (duration: 21.296441ms)","trace[260879636] 'applied index is now lower than readState.Index'  (duration: 253.86503ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:44.487837Z","caller":"traceutil/trace.go:171","msg":"trace[635271388] transaction","detail":"{read_only:false; response_revision:25574; number_of_response:1; }","duration":"275.966816ms","start":"2026-06-10T09:22:44.211856Z","end":"2026-06-10T09:22:44.487823Z","steps":["trace[635271388] 'process raft request'  (duration: 259.525777ms)","trace[635271388] 'compare'  (duration: 15.654875ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:44.488081Z","caller":"traceutil/trace.go:171","msg":"trace[1272809032] transaction","detail":"{read_only:false; response_revision:25575; number_of_response:1; }","duration":"273.793286ms","start":"2026-06-10T09:22:44.214256Z","end":"2026-06-10T09:22:44.488049Z","steps":["trace[1272809032] 'process raft request'  (duration: 272.988631ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.488145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.330522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-06-10T09:22:44.488148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.241547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-06-10T09:22:44.488183Z","caller":"traceutil/trace.go:171","msg":"trace[46088738] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25575; }","duration":"123.382233ms","start":"2026-06-10T09:22:44.36479Z","end":"2026-06-10T09:22:44.488173Z","steps":["trace[46088738] 'agreement among raft nodes before linearized reading'  (duration: 123.258681ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.488174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.928377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-06-10T09:22:44.488209Z","caller":"traceutil/trace.go:171","msg":"trace[1997612337] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25575; }","duration":"160.341099ms","start":"2026-06-10T09:22:44.327853Z","end":"2026-06-10T09:22:44.488194Z","steps":["trace[1997612337] 'agreement among raft nodes before linearized reading'  (duration: 160.171986ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:44.488256Z","caller":"traceutil/trace.go:171","msg":"trace[329649647] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:25575; }","duration":"155.025589ms","start":"2026-06-10T09:22:44.333213Z","end":"2026-06-10T09:22:44.488238Z","steps":["trace[329649647] 'agreement among raft nodes before linearized reading'  (duration: 154.877166ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.488551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.363194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18256"}
{"level":"info","ts":"2026-06-10T09:22:44.488606Z","caller":"traceutil/trace.go:171","msg":"trace[1330871535] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25575; }","duration":"276.437436ms","start":"2026-06-10T09:22:44.212155Z","end":"2026-06-10T09:22:44.488593Z","steps":["trace[1330871535] 'agreement among raft nodes before linearized reading'  (duration: 275.959377ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.731207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.839498ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875670038 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25502 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:22:44.731441Z","caller":"traceutil/trace.go:171","msg":"trace[107562862] linearizableReadLoop","detail":"{readStateIndex:26400; appliedIndex:26398; }","duration":"184.107797ms","start":"2026-06-10T09:22:44.547314Z","end":"2026-06-10T09:22:44.731422Z","steps":["trace[107562862] 'read index received'  (duration: 65.981483ms)","trace[107562862] 'applied index is now lower than readState.Index'  (duration: 118.125314ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:44.731448Z","caller":"traceutil/trace.go:171","msg":"trace[683952447] transaction","detail":"{read_only:false; response_revision:25576; number_of_response:1; }","duration":"238.330377ms","start":"2026-06-10T09:22:44.493089Z","end":"2026-06-10T09:22:44.73142Z","steps":["trace[683952447] 'process raft request'  (duration: 120.190733ms)","trace[683952447] 'compare'  (duration: 117.691506ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:44.731513Z","caller":"traceutil/trace.go:171","msg":"trace[1383288560] transaction","detail":"{read_only:false; response_revision:25577; number_of_response:1; }","duration":"238.249095ms","start":"2026-06-10T09:22:44.493253Z","end":"2026-06-10T09:22:44.731502Z","steps":["trace[1383288560] 'process raft request'  (duration: 238.078842ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:44.73162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.28013ms","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-10T09:22:44.731687Z","caller":"traceutil/trace.go:171","msg":"trace[2111629315] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25577; }","duration":"184.405583ms","start":"2026-06-10T09:22:44.547267Z","end":"2026-06-10T09:22:44.731673Z","steps":["trace[2111629315] 'agreement among raft nodes before linearized reading'  (duration: 184.27945ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:45.037178Z","caller":"traceutil/trace.go:171","msg":"trace[575216339] transaction","detail":"{read_only:false; response_revision:25578; number_of_response:1; }","duration":"239.917888ms","start":"2026-06-10T09:22:44.797244Z","end":"2026-06-10T09:22:45.037162Z","steps":["trace[575216339] 'process raft request'  (duration: 239.793645ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:45.127921Z","caller":"traceutil/trace.go:171","msg":"trace[1941781379] linearizableReadLoop","detail":"{readStateIndex:26402; appliedIndex:26400; }","duration":"276.593337ms","start":"2026-06-10T09:22:44.8513Z","end":"2026-06-10T09:22:45.127894Z","steps":["trace[1941781379] 'read index received'  (duration: 185.714886ms)","trace[1941781379] 'applied index is now lower than readState.Index'  (duration: 90.877511ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:45.12806Z","caller":"traceutil/trace.go:171","msg":"trace[150211364] transaction","detail":"{read_only:false; response_revision:25579; number_of_response:1; }","duration":"330.135316ms","start":"2026-06-10T09:22:44.797885Z","end":"2026-06-10T09:22:45.12802Z","steps":["trace[150211364] 'process raft request'  (duration: 306.294368ms)","trace[150211364] 'compare'  (duration: 23.310678ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:45.128238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:44.797868Z","time spent":"330.282948ms","remote":"127.0.0.1:42022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":871,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/ingress/openstack/container-infra\" mod_revision:25168 > success:<request_put:<key:\"/registry/ingress/openstack/container-infra\" value_size:820 >> failure:<request_range:<key:\"/registry/ingress/openstack/container-infra\" > >"}
{"level":"info","ts":"2026-06-10T09:22:45.12808Z","caller":"traceutil/trace.go:171","msg":"trace[398985574] transaction","detail":"{read_only:false; response_revision:25580; number_of_response:1; }","duration":"246.096213ms","start":"2026-06-10T09:22:44.881956Z","end":"2026-06-10T09:22:45.128052Z","steps":["trace[398985574] 'process raft request'  (duration: 245.836238ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:45.128312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.995405ms","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-10T09:22:45.128373Z","caller":"traceutil/trace.go:171","msg":"trace[270136408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25580; }","duration":"277.114747ms","start":"2026-06-10T09:22:44.851242Z","end":"2026-06-10T09:22:45.128357Z","steps":["trace[270136408] 'agreement among raft nodes before linearized reading'  (duration: 276.824572ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:45.18755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.764558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra-registry.18b7adda82561923\" ","response":"range_response_count:1 size:722"}
{"level":"info","ts":"2026-06-10T09:22:45.187672Z","caller":"traceutil/trace.go:171","msg":"trace[773477897] range","detail":"{range_begin:/registry/events/openstack/container-infra-registry.18b7adda82561923; range_end:; response_count:1; response_revision:25581; }","duration":"142.932742ms","start":"2026-06-10T09:22:45.044718Z","end":"2026-06-10T09:22:45.187651Z","steps":["trace[773477897] 'agreement among raft nodes before linearized reading'  (duration: 142.669737ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:45.302903Z","caller":"traceutil/trace.go:171","msg":"trace[1876373087] transaction","detail":"{read_only:false; response_revision:25585; number_of_response:1; }","duration":"110.801046ms","start":"2026-06-10T09:22:45.192078Z","end":"2026-06-10T09:22:45.302879Z","steps":["trace[1876373087] 'process raft request'  (duration: 110.749426ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:45.302906Z","caller":"traceutil/trace.go:171","msg":"trace[1417927081] transaction","detail":"{read_only:false; response_revision:25583; number_of_response:1; }","duration":"114.321002ms","start":"2026-06-10T09:22:45.188554Z","end":"2026-06-10T09:22:45.302875Z","steps":["trace[1417927081] 'process raft request'  (duration: 114.059768ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:45.303073Z","caller":"traceutil/trace.go:171","msg":"trace[729578798] transaction","detail":"{read_only:false; response_revision:25584; number_of_response:1; }","duration":"112.470738ms","start":"2026-06-10T09:22:45.190484Z","end":"2026-06-10T09:22:45.302954Z","steps":["trace[729578798] 'process raft request'  (duration: 112.273574ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:45.303474Z","caller":"traceutil/trace.go:171","msg":"trace[2124391336] transaction","detail":"{read_only:false; response_revision:25586; number_of_response:1; }","duration":"102.105682ms","start":"2026-06-10T09:22:45.201348Z","end":"2026-06-10T09:22:45.303453Z","steps":["trace[2124391336] 'process raft request'  (duration: 101.852797ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:45.303498Z","caller":"traceutil/trace.go:171","msg":"trace[1058578394] transaction","detail":"{read_only:false; response_revision:25587; number_of_response:1; }","duration":"101.917969ms","start":"2026-06-10T09:22:45.201565Z","end":"2026-06-10T09:22:45.303483Z","steps":["trace[1058578394] 'process raft request'  (duration: 101.830157ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:47.325633Z","caller":"traceutil/trace.go:171","msg":"trace[1661574954] linearizableReadLoop","detail":"{readStateIndex:26425; appliedIndex:26424; }","duration":"132.504975ms","start":"2026-06-10T09:22:47.193105Z","end":"2026-06-10T09:22:47.32561Z","steps":["trace[1661574954] 'read index received'  (duration: 132.296251ms)","trace[1661574954] 'applied index is now lower than readState.Index'  (duration: 207.894µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:47.325724Z","caller":"traceutil/trace.go:171","msg":"trace[14007914] transaction","detail":"{read_only:false; response_revision:25601; number_of_response:1; }","duration":"134.132566ms","start":"2026-06-10T09:22:47.191551Z","end":"2026-06-10T09:22:47.325684Z","steps":["trace[14007914] 'process raft request'  (duration: 133.906902ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:47.325866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.735299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-63c3d7c8-8bd4-49be-81c5-306ca2f55588\" ","response":"range_response_count:1 size:3947"}
{"level":"info","ts":"2026-06-10T09:22:47.325944Z","caller":"traceutil/trace.go:171","msg":"trace[1093358399] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-63c3d7c8-8bd4-49be-81c5-306ca2f55588; range_end:; response_count:1; response_revision:25601; }","duration":"132.836892ms","start":"2026-06-10T09:22:47.193067Z","end":"2026-06-10T09:22:47.325904Z","steps":["trace[1093358399] 'agreement among raft nodes before linearized reading'  (duration: 132.667239ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:47.326003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.027964ms","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-10T09:22:47.326107Z","caller":"traceutil/trace.go:171","msg":"trace[730828002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25601; }","duration":"125.191897ms","start":"2026-06-10T09:22:47.200892Z","end":"2026-06-10T09:22:47.326084Z","steps":["trace[730828002] 'agreement among raft nodes before linearized reading'  (duration: 124.909102ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:47.408496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.709605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"warn","ts":"2026-06-10T09:22:47.408496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.659334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:22:47.408567Z","caller":"traceutil/trace.go:171","msg":"trace[1429676426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25601; }","duration":"101.815977ms","start":"2026-06-10T09:22:47.306736Z","end":"2026-06-10T09:22:47.408552Z","steps":["trace[1429676426] 'agreement among raft nodes before linearized reading'  (duration: 19.181311ms)","trace[1429676426] 'range keys from in-memory index tree'  (duration: 82.468072ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:47.408579Z","caller":"traceutil/trace.go:171","msg":"trace[1748971564] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:25601; }","duration":"203.794877ms","start":"2026-06-10T09:22:47.20476Z","end":"2026-06-10T09:22:47.408555Z","steps":["trace[1748971564] 'agreement among raft nodes before linearized reading'  (duration: 121.186852ms)","trace[1748971564] 'count revisions from in-memory index tree'  (duration: 82.487653ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:50.316822Z","caller":"traceutil/trace.go:171","msg":"trace[12785565] transaction","detail":"{read_only:false; response_revision:25642; number_of_response:1; }","duration":"223.914636ms","start":"2026-06-10T09:22:50.092887Z","end":"2026-06-10T09:22:50.316802Z","steps":["trace[12785565] 'process raft request'  (duration: 223.793454ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:50.317254Z","caller":"traceutil/trace.go:171","msg":"trace[1982484108] linearizableReadLoop","detail":"{readStateIndex:26467; appliedIndex:26467; }","duration":"223.804504ms","start":"2026-06-10T09:22:50.093427Z","end":"2026-06-10T09:22:50.317232Z","steps":["trace[1982484108] 'read index received'  (duration: 223.350375ms)","trace[1982484108] 'applied index is now lower than readState.Index'  (duration: 452.349µs)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:50.31737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.924737ms","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-10T09:22:50.3174Z","caller":"traceutil/trace.go:171","msg":"trace[1681344684] 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:25642; }","duration":"223.988298ms","start":"2026-06-10T09:22:50.093404Z","end":"2026-06-10T09:22:50.317392Z","steps":["trace[1681344684] 'agreement among raft nodes before linearized reading'  (duration: 223.924617ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:50.53524Z","caller":"traceutil/trace.go:171","msg":"trace[544765918] linearizableReadLoop","detail":"{readStateIndex:26468; appliedIndex:26467; }","duration":"217.874973ms","start":"2026-06-10T09:22:50.317341Z","end":"2026-06-10T09:22:50.535216Z","steps":["trace[544765918] 'read index received'  (duration: 164.100389ms)","trace[544765918] 'applied index is now lower than readState.Index'  (duration: 53.773424ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:22:50.535329Z","caller":"traceutil/trace.go:171","msg":"trace[2070554609] transaction","detail":"{read_only:false; response_revision:25643; number_of_response:1; }","duration":"227.318971ms","start":"2026-06-10T09:22:50.307969Z","end":"2026-06-10T09:22:50.535288Z","steps":["trace[2070554609] 'process raft request'  (duration: 173.458766ms)","trace[2070554609] 'compare'  (duration: 53.612829ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:22:50.535362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.452501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-06-10T09:22:50.535385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.758809ms","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:8"}
{"level":"info","ts":"2026-06-10T09:22:50.53542Z","caller":"traceutil/trace.go:171","msg":"trace[1220171755] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:25643; }","duration":"392.560512ms","start":"2026-06-10T09:22:50.142846Z","end":"2026-06-10T09:22:50.535406Z","steps":["trace[1220171755] 'agreement among raft nodes before linearized reading'  (duration: 392.45985ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:50.535421Z","caller":"traceutil/trace.go:171","msg":"trace[2079342704] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:25643; }","duration":"397.831721ms","start":"2026-06-10T09:22:50.137579Z","end":"2026-06-10T09:22:50.535411Z","steps":["trace[2079342704] 'agreement among raft nodes before linearized reading'  (duration: 397.75067ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:50.535458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:50.142822Z","time spent":"392.625314ms","remote":"127.0.0.1:54496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "}
{"level":"warn","ts":"2026-06-10T09:22:50.535462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:50.137568Z","time spent":"397.884312ms","remote":"127.0.0.1:47980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "}
{"level":"warn","ts":"2026-06-10T09:22:50.535451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.832769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"}
{"level":"warn","ts":"2026-06-10T09:22:50.535498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.65612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-06-10T09:22:50.535532Z","caller":"traceutil/trace.go:171","msg":"trace[211996162] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25643; }","duration":"279.958301ms","start":"2026-06-10T09:22:50.255555Z","end":"2026-06-10T09:22:50.535514Z","steps":["trace[211996162] 'agreement among raft nodes before linearized reading'  (duration: 279.663716ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:50.535589Z","caller":"traceutil/trace.go:171","msg":"trace[1008902469] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25643; }","duration":"361.788702ms","start":"2026-06-10T09:22:50.173778Z","end":"2026-06-10T09:22:50.535567Z","steps":["trace[1008902469] 'agreement among raft nodes before linearized reading'  (duration: 361.522167ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:50.535691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:22:50.173763Z","time spent":"361.917375ms","remote":"127.0.0.1:41852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1882,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" "}
{"level":"info","ts":"2026-06-10T09:22:50.609565Z","caller":"traceutil/trace.go:171","msg":"trace[16006888] transaction","detail":"{read_only:false; response_revision:25644; number_of_response:1; }","duration":"285.790481ms","start":"2026-06-10T09:22:50.323749Z","end":"2026-06-10T09:22:50.60954Z","steps":["trace[16006888] 'process raft request'  (duration: 285.617558ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:50.609931Z","caller":"traceutil/trace.go:171","msg":"trace[1814211513] transaction","detail":"{read_only:false; response_revision:25645; number_of_response:1; }","duration":"286.116987ms","start":"2026-06-10T09:22:50.323786Z","end":"2026-06-10T09:22:50.609903Z","steps":["trace[1814211513] 'process raft request'  (duration: 285.71061ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:50.60999Z","caller":"traceutil/trace.go:171","msg":"trace[294051356] transaction","detail":"{read_only:false; response_revision:25646; number_of_response:1; }","duration":"286.108737ms","start":"2026-06-10T09:22:50.323824Z","end":"2026-06-10T09:22:50.609933Z","steps":["trace[294051356] 'process raft request'  (duration: 285.910903ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:22:50.610109Z","caller":"traceutil/trace.go:171","msg":"trace[217479173] transaction","detail":"{read_only:false; response_revision:25647; number_of_response:1; }","duration":"286.178518ms","start":"2026-06-10T09:22:50.323885Z","end":"2026-06-10T09:22:50.610064Z","steps":["trace[217479173] 'process raft request'  (duration: 285.951874ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:22:50.610189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.063244ms","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-10T09:22:50.61026Z","caller":"traceutil/trace.go:171","msg":"trace[1690950705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25647; }","duration":"100.190835ms","start":"2026-06-10T09:22:50.510055Z","end":"2026-06-10T09:22:50.610245Z","steps":["trace[1690950705] 'agreement among raft nodes before linearized reading'  (duration: 99.987342ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.057825Z","caller":"traceutil/trace.go:171","msg":"trace[754444153] transaction","detail":"{read_only:false; response_revision:25844; number_of_response:1; }","duration":"175.175298ms","start":"2026-06-10T09:23:14.882614Z","end":"2026-06-10T09:23:15.057789Z","steps":["trace[754444153] 'process raft request'  (duration: 78.701752ms)","trace[754444153] 'compare'  (duration: 95.745832ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:15.626355Z","caller":"traceutil/trace.go:171","msg":"trace[1560116367] linearizableReadLoop","detail":"{readStateIndex:26676; appliedIndex:26675; }","duration":"191.651538ms","start":"2026-06-10T09:23:15.434684Z","end":"2026-06-10T09:23:15.626336Z","steps":["trace[1560116367] 'read index received'  (duration: 124.095016ms)","trace[1560116367] 'applied index is now lower than readState.Index'  (duration: 67.555812ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:15.62638Z","caller":"traceutil/trace.go:171","msg":"trace[1877826401] transaction","detail":"{read_only:false; response_revision:25846; number_of_response:1; }","duration":"199.618198ms","start":"2026-06-10T09:23:15.426725Z","end":"2026-06-10T09:23:15.626343Z","steps":["trace[1877826401] 'process raft request'  (duration: 132.082327ms)","trace[1877826401] 'compare'  (duration: 67.44256ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:15.626776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.076106ms","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-10T09:23:15.626817Z","caller":"traceutil/trace.go:171","msg":"trace[1528555252] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25846; }","duration":"192.149008ms","start":"2026-06-10T09:23:15.434657Z","end":"2026-06-10T09:23:15.626806Z","steps":["trace[1528555252] 'agreement among raft nodes before linearized reading'  (duration: 191.768591ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:15.642726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.421368ms","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-10T09:23:15.642795Z","caller":"traceutil/trace.go:171","msg":"trace[606493253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25847; }","duration":"103.520629ms","start":"2026-06-10T09:23:15.539261Z","end":"2026-06-10T09:23:15.642781Z","steps":["trace[606493253] 'agreement among raft nodes before linearized reading'  (duration: 103.371986ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:15.64295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.161698ms","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-10T09:23:15.643109Z","caller":"traceutil/trace.go:171","msg":"trace[1031246535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25847; }","duration":"107.356211ms","start":"2026-06-10T09:23:15.535745Z","end":"2026-06-10T09:23:15.643101Z","steps":["trace[1031246535] 'agreement among raft nodes before linearized reading'  (duration: 106.823081ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.81693Z","caller":"traceutil/trace.go:171","msg":"trace[108269546] transaction","detail":"{read_only:false; response_revision:25848; number_of_response:1; }","duration":"170.44618ms","start":"2026-06-10T09:23:15.646427Z","end":"2026-06-10T09:23:15.816873Z","steps":["trace[108269546] 'process raft request'  (duration: 170.239686ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:15.81758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.904268ms","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-10T09:23:15.817643Z","caller":"traceutil/trace.go:171","msg":"trace[1261362629] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25854; }","duration":"170.98982ms","start":"2026-06-10T09:23:15.646639Z","end":"2026-06-10T09:23:15.817629Z","steps":["trace[1261362629] 'agreement among raft nodes before linearized reading'  (duration: 170.815627ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.817289Z","caller":"traceutil/trace.go:171","msg":"trace[188542735] transaction","detail":"{read_only:false; response_revision:25852; number_of_response:1; }","duration":"137.516589ms","start":"2026-06-10T09:23:15.679755Z","end":"2026-06-10T09:23:15.817271Z","steps":["trace[188542735] 'process raft request'  (duration: 137.434308ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.817309Z","caller":"traceutil/trace.go:171","msg":"trace[1820859395] transaction","detail":"{read_only:false; response_revision:25850; number_of_response:1; }","duration":"168.89923ms","start":"2026-06-10T09:23:15.648389Z","end":"2026-06-10T09:23:15.817288Z","steps":["trace[1820859395] 'process raft request'  (duration: 168.467142ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.817404Z","caller":"traceutil/trace.go:171","msg":"trace[723754692] linearizableReadLoop","detail":"{readStateIndex:26679; appliedIndex:26678; }","duration":"170.725853ms","start":"2026-06-10T09:23:15.646656Z","end":"2026-06-10T09:23:15.817382Z","steps":["trace[723754692] 'read index received'  (duration: 41.223855ms)","trace[723754692] 'applied index is now lower than readState.Index'  (duration: 129.500658ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:15.817391Z","caller":"traceutil/trace.go:171","msg":"trace[1188776767] transaction","detail":"{read_only:false; response_revision:25851; number_of_response:1; }","duration":"158.25758ms","start":"2026-06-10T09:23:15.659089Z","end":"2026-06-10T09:23:15.817346Z","steps":["trace[1188776767] 'process raft request'  (duration: 157.992195ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.817481Z","caller":"traceutil/trace.go:171","msg":"trace[1202673484] transaction","detail":"{read_only:false; response_revision:25853; number_of_response:1; }","duration":"136.613512ms","start":"2026-06-10T09:23:15.680856Z","end":"2026-06-10T09:23:15.817469Z","steps":["trace[1202673484] 'process raft request'  (duration: 136.371437ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.81749Z","caller":"traceutil/trace.go:171","msg":"trace[1748055660] transaction","detail":"{read_only:false; response_revision:25854; number_of_response:1; }","duration":"135.704426ms","start":"2026-06-10T09:23:15.681773Z","end":"2026-06-10T09:23:15.817477Z","steps":["trace[1748055660] 'process raft request'  (duration: 135.550372ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.818313Z","caller":"traceutil/trace.go:171","msg":"trace[1748708641] transaction","detail":"{read_only:false; response_revision:25849; number_of_response:1; }","duration":"169.771576ms","start":"2026-06-10T09:23:15.647111Z","end":"2026-06-10T09:23:15.816883Z","steps":["trace[1748708641] 'process raft request'  (duration: 169.693865ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.880047Z","caller":"traceutil/trace.go:171","msg":"trace[1957480708] transaction","detail":"{read_only:false; response_revision:25855; number_of_response:1; }","duration":"190.298214ms","start":"2026-06-10T09:23:15.689728Z","end":"2026-06-10T09:23:15.880026Z","steps":["trace[1957480708] 'process raft request'  (duration: 190.183902ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:15.978071Z","caller":"traceutil/trace.go:171","msg":"trace[1232938280] transaction","detail":"{read_only:false; response_revision:25856; number_of_response:1; }","duration":"136.643833ms","start":"2026-06-10T09:23:15.840684Z","end":"2026-06-10T09:23:15.977327Z","steps":["trace[1232938280] 'process raft request'  (duration: 123.023946ms)","trace[1232938280] 'compare'  (duration: 13.165498ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:16.920096Z","caller":"traceutil/trace.go:171","msg":"trace[2034923214] transaction","detail":"{read_only:false; response_revision:25859; number_of_response:1; }","duration":"142.685436ms","start":"2026-06-10T09:23:16.777385Z","end":"2026-06-10T09:23:16.920071Z","steps":["trace[2034923214] 'process raft request'  (duration: 70.880814ms)","trace[2034923214] 'compare'  (duration: 71.277133ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:17.259929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.534759ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875670738 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25843 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:23:17.260092Z","caller":"traceutil/trace.go:171","msg":"trace[1991005514] linearizableReadLoop","detail":"{readStateIndex:26691; appliedIndex:26690; }","duration":"214.088571ms","start":"2026-06-10T09:23:17.045981Z","end":"2026-06-10T09:23:17.26007Z","steps":["trace[1991005514] 'read index received'  (duration: 33.190916ms)","trace[1991005514] 'applied index is now lower than readState.Index'  (duration: 180.895995ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:17.260208Z","caller":"traceutil/trace.go:171","msg":"trace[1359896777] transaction","detail":"{read_only:false; response_revision:25860; number_of_response:1; }","duration":"335.868514ms","start":"2026-06-10T09:23:16.924322Z","end":"2026-06-10T09:23:17.26019Z","steps":["trace[1359896777] 'process raft request'  (duration: 154.927167ms)","trace[1359896777] 'compare'  (duration: 179.884627ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:17.2603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:23:16.924295Z","time spent":"335.957937ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25843 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-06-10T09:23:17.260354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.332604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-06-10T09:23:17.260442Z","caller":"traceutil/trace.go:171","msg":"trace[1320248439] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25860; }","duration":"199.468617ms","start":"2026-06-10T09:23:17.060953Z","end":"2026-06-10T09:23:17.260422Z","steps":["trace[1320248439] 'agreement among raft nodes before linearized reading'  (duration: 199.266283ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:17.260898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.921047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:23:17.260961Z","caller":"traceutil/trace.go:171","msg":"trace[235114160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25860; }","duration":"215.013339ms","start":"2026-06-10T09:23:17.045929Z","end":"2026-06-10T09:23:17.260942Z","steps":["trace[235114160] 'agreement among raft nodes before linearized reading'  (duration: 214.631812ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:17.945277Z","caller":"traceutil/trace.go:171","msg":"trace[773679822] transaction","detail":"{read_only:false; response_revision:25864; number_of_response:1; }","duration":"121.329804ms","start":"2026-06-10T09:23:17.823929Z","end":"2026-06-10T09:23:17.945258Z","steps":["trace[773679822] 'process raft request'  (duration: 121.150361ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:17.94569Z","caller":"traceutil/trace.go:171","msg":"trace[778813071] transaction","detail":"{read_only:false; response_revision:25865; number_of_response:1; }","duration":"120.277175ms","start":"2026-06-10T09:23:17.825384Z","end":"2026-06-10T09:23:17.945661Z","steps":["trace[778813071] 'process raft request'  (duration: 119.836846ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:17.945934Z","caller":"traceutil/trace.go:171","msg":"trace[1732326707] transaction","detail":"{read_only:false; response_revision:25866; number_of_response:1; }","duration":"120.169833ms","start":"2026-06-10T09:23:17.825751Z","end":"2026-06-10T09:23:17.94592Z","steps":["trace[1732326707] 'process raft request'  (duration: 119.794646ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:17.94594Z","caller":"traceutil/trace.go:171","msg":"trace[1102956819] linearizableReadLoop","detail":"{readStateIndex:26695; appliedIndex:26693; }","duration":"120.745593ms","start":"2026-06-10T09:23:17.825161Z","end":"2026-06-10T09:23:17.945906Z","steps":["trace[1102956819] 'read index received'  (duration: 45.619918ms)","trace[1102956819] 'applied index is now lower than readState.Index'  (duration: 75.124765ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:17.946022Z","caller":"traceutil/trace.go:171","msg":"trace[395874430] transaction","detail":"{read_only:false; response_revision:25867; number_of_response:1; }","duration":"119.458639ms","start":"2026-06-10T09:23:17.826552Z","end":"2026-06-10T09:23:17.94601Z","steps":["trace[395874430] 'process raft request'  (duration: 119.283986ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:17.946129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.952748ms","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-10T09:23:17.946176Z","caller":"traceutil/trace.go:171","msg":"trace[1530908904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25867; }","duration":"121.011229ms","start":"2026-06-10T09:23:17.825154Z","end":"2026-06-10T09:23:17.946165Z","steps":["trace[1530908904] 'agreement among raft nodes before linearized reading'  (duration: 120.859116ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:18.01429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.912478ms","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-10T09:23:18.014375Z","caller":"traceutil/trace.go:171","msg":"trace[920906120] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:25868; }","duration":"138.037899ms","start":"2026-06-10T09:23:17.876313Z","end":"2026-06-10T09:23:18.014351Z","steps":["trace[920906120] 'agreement among raft nodes before linearized reading'  (duration: 137.849626ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:18.014364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.119471ms","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-10T09:23:18.014439Z","caller":"traceutil/trace.go:171","msg":"trace[276020011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25868; }","duration":"189.224454ms","start":"2026-06-10T09:23:17.825198Z","end":"2026-06-10T09:23:18.014422Z","steps":["trace[276020011] 'agreement among raft nodes before linearized reading'  (duration: 188.992379ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:18.302507Z","caller":"traceutil/trace.go:171","msg":"trace[106959201] linearizableReadLoop","detail":"{readStateIndex:26702; appliedIndex:26701; }","duration":"162.897658ms","start":"2026-06-10T09:23:18.13957Z","end":"2026-06-10T09:23:18.302468Z","steps":["trace[106959201] 'read index received'  (duration: 162.635474ms)","trace[106959201] 'applied index is now lower than readState.Index'  (duration: 260.794µs)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:18.302615Z","caller":"traceutil/trace.go:171","msg":"trace[1867888883] transaction","detail":"{read_only:false; response_revision:25871; number_of_response:1; }","duration":"284.433366ms","start":"2026-06-10T09:23:18.018155Z","end":"2026-06-10T09:23:18.302589Z","steps":["trace[1867888883] 'process raft request'  (duration: 284.079499ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:18.302693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.094722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:23:18.302739Z","caller":"traceutil/trace.go:171","msg":"trace[2120666288] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:25871; }","duration":"163.207993ms","start":"2026-06-10T09:23:18.139517Z","end":"2026-06-10T09:23:18.302725Z","steps":["trace[2120666288] 'agreement among raft nodes before linearized reading'  (duration: 163.109741ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:18.302872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.283216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"info","ts":"2026-06-10T09:23:18.302975Z","caller":"traceutil/trace.go:171","msg":"trace[718218777] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25871; }","duration":"119.404178ms","start":"2026-06-10T09:23:18.183529Z","end":"2026-06-10T09:23:18.302933Z","steps":["trace[718218777] 'agreement among raft nodes before linearized reading'  (duration: 119.200264ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:18.553013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.369833ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875670767 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:25747 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" value_size:466 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:23:18.553092Z","caller":"traceutil/trace.go:171","msg":"trace[546653672] linearizableReadLoop","detail":"{readStateIndex:26703; appliedIndex:26702; }","duration":"175.78799ms","start":"2026-06-10T09:23:18.377286Z","end":"2026-06-10T09:23:18.553074Z","steps":["trace[546653672] 'read index received'  (duration: 10.225223ms)","trace[546653672] 'applied index is now lower than readState.Index'  (duration: 165.561647ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:18.553133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.860412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:23:18.55315Z","caller":"traceutil/trace.go:171","msg":"trace[2144040543] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:25872; }","duration":"175.919072ms","start":"2026-06-10T09:23:18.377227Z","end":"2026-06-10T09:23:18.553146Z","steps":["trace[2144040543] 'agreement among raft nodes before linearized reading'  (duration: 175.881072ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:18.553117Z","caller":"traceutil/trace.go:171","msg":"trace[583025411] transaction","detail":"{read_only:false; response_revision:25872; number_of_response:1; }","duration":"246.235077ms","start":"2026-06-10T09:23:18.306855Z","end":"2026-06-10T09:23:18.55309Z","steps":["trace[583025411] 'process raft request'  (duration: 80.719251ms)","trace[583025411] 'compare'  (duration: 165.103009ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:18.943957Z","caller":"traceutil/trace.go:171","msg":"trace[98167975] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"159.84463ms","start":"2026-06-10T09:23:18.784087Z","end":"2026-06-10T09:23:18.943932Z","steps":["trace[98167975] 'process raft request'  (duration: 159.504743ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:19.099366Z","caller":"traceutil/trace.go:171","msg":"trace[2026700760] transaction","detail":"{read_only:false; response_revision:25874; number_of_response:1; }","duration":"150.766159ms","start":"2026-06-10T09:23:18.948537Z","end":"2026-06-10T09:23:19.099303Z","steps":["trace[2026700760] 'process raft request'  (duration: 73.016625ms)","trace[2026700760] 'compare'  (duration: 77.367867ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:19.451137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.371013ms","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-10T09:23:19.451248Z","caller":"traceutil/trace.go:171","msg":"trace[873706018] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25874; }","duration":"141.527376ms","start":"2026-06-10T09:23:19.309699Z","end":"2026-06-10T09:23:19.451227Z","steps":["trace[873706018] 'range keys from in-memory index tree'  (duration: 141.2099ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:19.451383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.138914ms","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-10T09:23:19.451464Z","caller":"traceutil/trace.go:171","msg":"trace[1862884094] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25874; }","duration":"187.283017ms","start":"2026-06-10T09:23:19.264162Z","end":"2026-06-10T09:23:19.451445Z","steps":["trace[1862884094] 'range keys from in-memory index tree'  (duration: 186.978981ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:19.788019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.300073ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875670778 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25860 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:23:19.788142Z","caller":"traceutil/trace.go:171","msg":"trace[140159170] transaction","detail":"{read_only:false; response_revision:25876; number_of_response:1; }","duration":"332.405769ms","start":"2026-06-10T09:23:19.455715Z","end":"2026-06-10T09:23:19.788121Z","steps":["trace[140159170] 'process raft request'  (duration: 210.913162ms)","trace[140159170] 'compare'  (duration: 121.13408ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:19.788208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:23:19.455689Z","time spent":"332.488031ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:25860 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-06-10T09:23:19.857251Z","caller":"traceutil/trace.go:171","msg":"trace[1595531488] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"179.770875ms","start":"2026-06-10T09:23:19.677438Z","end":"2026-06-10T09:23:19.857209Z","steps":["trace[1595531488] 'process raft request'  (duration: 179.584112ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:20.086993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.992185ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875670781 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:25863 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:23:20.087307Z","caller":"traceutil/trace.go:171","msg":"trace[376523360] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"212.150455ms","start":"2026-06-10T09:23:19.875129Z","end":"2026-06-10T09:23:20.08728Z","steps":["trace[376523360] 'process raft request'  (duration: 53.789003ms)","trace[376523360] 'compare'  (duration: 157.865903ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:20.087346Z","caller":"traceutil/trace.go:171","msg":"trace[1595436042] linearizableReadLoop","detail":"{readStateIndex:26710; appliedIndex:26708; }","duration":"136.476459ms","start":"2026-06-10T09:23:19.950824Z","end":"2026-06-10T09:23:20.087301Z","steps":["trace[1595436042] 'read index received'  (duration: 108.930681ms)","trace[1595436042] 'applied index is now lower than readState.Index'  (duration: 27.544648ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:20.087329Z","caller":"traceutil/trace.go:171","msg":"trace[1731974042] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"136.546562ms","start":"2026-06-10T09:23:19.950761Z","end":"2026-06-10T09:23:20.087308Z","steps":["trace[1731974042] 'process raft request'  (duration: 136.335148ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:20.087648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.725525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-06-10T09:23:20.087707Z","caller":"traceutil/trace.go:171","msg":"trace[501376920] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25879; }","duration":"136.923018ms","start":"2026-06-10T09:23:19.950768Z","end":"2026-06-10T09:23:20.087691Z","steps":["trace[501376920] 'agreement among raft nodes before linearized reading'  (duration: 136.602722ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:20.389114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.400502ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875670783 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25865 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:23:20.389226Z","caller":"traceutil/trace.go:171","msg":"trace[1105586077] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"438.403204ms","start":"2026-06-10T09:23:19.950809Z","end":"2026-06-10T09:23:20.389212Z","steps":["trace[1105586077] 'process raft request'  (duration: 271.845239ms)","trace[1105586077] 'compare'  (duration: 165.790281ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:20.389268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:23:19.950783Z","time spent":"438.465866ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25865 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-06-10T09:23:20.389627Z","caller":"traceutil/trace.go:171","msg":"trace[1051357862] transaction","detail":"{read_only:false; response_revision:25881; number_of_response:1; }","duration":"438.623739ms","start":"2026-06-10T09:23:19.95095Z","end":"2026-06-10T09:23:20.389574Z","steps":["trace[1051357862] 'process raft request'  (duration: 438.231991ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:20.389779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:23:19.950924Z","time spent":"438.772792ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:25866 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:507 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"info","ts":"2026-06-10T09:23:20.389862Z","caller":"traceutil/trace.go:171","msg":"trace[55459063] transaction","detail":"{read_only:false; response_revision:25882; number_of_response:1; }","duration":"341.769445ms","start":"2026-06-10T09:23:20.048082Z","end":"2026-06-10T09:23:20.389852Z","steps":["trace[55459063] 'process raft request'  (duration: 341.369668ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:20.389911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:23:20.048071Z","time spent":"341.813226ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25870 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-06-10T09:23:20.390041Z","caller":"traceutil/trace.go:171","msg":"trace[1425867377] linearizableReadLoop","detail":"{readStateIndex:26713; appliedIndex:26710; }","duration":"302.622609ms","start":"2026-06-10T09:23:20.087411Z","end":"2026-06-10T09:23:20.390034Z","steps":["trace[1425867377] 'read index received'  (duration: 135.259897ms)","trace[1425867377] 'applied index is now lower than readState.Index'  (duration: 167.361902ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:20.390184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.742434ms","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-10T09:23:20.390202Z","caller":"traceutil/trace.go:171","msg":"trace[198820624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25882; }","duration":"342.761595ms","start":"2026-06-10T09:23:20.047435Z","end":"2026-06-10T09:23:20.390197Z","steps":["trace[198820624] 'agreement among raft nodes before linearized reading'  (duration: 342.662543ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:20.390222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T09:23:20.047395Z","time spent":"342.821405ms","remote":"127.0.0.1:41988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-06-10T09:23:20.390435Z","caller":"traceutil/trace.go:171","msg":"trace[961536217] transaction","detail":"{read_only:false; response_revision:25883; number_of_response:1; }","duration":"298.547282ms","start":"2026-06-10T09:23:20.091879Z","end":"2026-06-10T09:23:20.390427Z","steps":["trace[961536217] 'process raft request'  (duration: 298.102514ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:20.577111Z","caller":"traceutil/trace.go:171","msg":"trace[457655477] transaction","detail":"{read_only:false; response_revision:25885; number_of_response:1; }","duration":"182.682991ms","start":"2026-06-10T09:23:20.394393Z","end":"2026-06-10T09:23:20.577076Z","steps":["trace[457655477] 'process raft request'  (duration: 138.899936ms)","trace[457655477] 'compare'  (duration: 43.622952ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:20.844046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.084584ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875670792 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:25847 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:23:20.844129Z","caller":"traceutil/trace.go:171","msg":"trace[1242198597] linearizableReadLoop","detail":"{readStateIndex:26717; appliedIndex:26716; }","duration":"157.549197ms","start":"2026-06-10T09:23:20.686568Z","end":"2026-06-10T09:23:20.844118Z","steps":["trace[1242198597] 'read index received'  (duration: 45.121µs)","trace[1242198597] 'applied index is now lower than readState.Index'  (duration: 157.503256ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:20.844192Z","caller":"traceutil/trace.go:171","msg":"trace[798490008] transaction","detail":"{read_only:false; response_revision:25886; number_of_response:1; }","duration":"197.408078ms","start":"2026-06-10T09:23:20.64675Z","end":"2026-06-10T09:23:20.844158Z","steps":["trace[798490008] 'process raft request'  (duration: 36.13584ms)","trace[798490008] 'compare'  (duration: 160.87298ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:20.844234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.635998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-06-10T09:23:20.84427Z","caller":"traceutil/trace.go:171","msg":"trace[878456699] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:25886; }","duration":"157.73309ms","start":"2026-06-10T09:23:20.686525Z","end":"2026-06-10T09:23:20.844258Z","steps":["trace[878456699] 'agreement among raft nodes before linearized reading'  (duration: 157.638049ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:20.95934Z","caller":"traceutil/trace.go:171","msg":"trace[344994074] linearizableReadLoop","detail":"{readStateIndex:26718; appliedIndex:26717; }","duration":"115.163439ms","start":"2026-06-10T09:23:20.844147Z","end":"2026-06-10T09:23:20.959311Z","steps":["trace[344994074] 'read index received'  (duration: 62.769462ms)","trace[344994074] 'applied index is now lower than readState.Index'  (duration: 52.389717ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:20.959965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.244469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:36 size:299320"}
{"level":"info","ts":"2026-06-10T09:23:20.960048Z","caller":"traceutil/trace.go:171","msg":"trace[711957656] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:36; response_revision:25886; }","duration":"244.378571ms","start":"2026-06-10T09:23:20.715652Z","end":"2026-06-10T09:23:20.960031Z","steps":["trace[711957656] 'agreement among raft nodes before linearized reading'  (duration: 243.715509ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:44.966361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.510461ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875671246 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:25993 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:23:44.966476Z","caller":"traceutil/trace.go:171","msg":"trace[1950570463] linearizableReadLoop","detail":"{readStateIndex:26906; appliedIndex:26905; }","duration":"189.983857ms","start":"2026-06-10T09:23:44.776475Z","end":"2026-06-10T09:23:44.966459Z","steps":["trace[1950570463] 'read index received'  (duration: 62.300693ms)","trace[1950570463] 'applied index is now lower than readState.Index'  (duration: 127.681664ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:44.966568Z","caller":"traceutil/trace.go:171","msg":"trace[544295602] transaction","detail":"{read_only:false; response_revision:26070; number_of_response:1; }","duration":"270.021475ms","start":"2026-06-10T09:23:44.696532Z","end":"2026-06-10T09:23:44.966553Z","steps":["trace[544295602] 'process raft request'  (duration: 142.210318ms)","trace[544295602] 'compare'  (duration: 127.274347ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:44.96673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.810269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1991"}
{"level":"info","ts":"2026-06-10T09:23:44.966856Z","caller":"traceutil/trace.go:171","msg":"trace[412163651] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:26070; }","duration":"176.968052ms","start":"2026-06-10T09:23:44.789855Z","end":"2026-06-10T09:23:44.966823Z","steps":["trace[412163651] 'agreement among raft nodes before linearized reading'  (duration: 176.763258ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:44.96727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.764832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterctl.cluster.x-k8s.io/providers/\" range_end:\"/registry/clusterctl.cluster.x-k8s.io/providers0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-06-10T09:23:44.967379Z","caller":"traceutil/trace.go:171","msg":"trace[337346286] range","detail":"{range_begin:/registry/clusterctl.cluster.x-k8s.io/providers/; range_end:/registry/clusterctl.cluster.x-k8s.io/providers0; response_count:0; response_revision:26070; }","duration":"190.937025ms","start":"2026-06-10T09:23:44.776424Z","end":"2026-06-10T09:23:44.967361Z","steps":["trace[337346286] 'agreement among raft nodes before linearized reading'  (duration: 190.744341ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:45.276404Z","caller":"traceutil/trace.go:171","msg":"trace[1401537409] transaction","detail":"{read_only:false; response_revision:26071; number_of_response:1; }","duration":"118.384289ms","start":"2026-06-10T09:23:45.157965Z","end":"2026-06-10T09:23:45.276349Z","steps":["trace[1401537409] 'process raft request'  (duration: 118.101664ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:45.544731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.77742ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4831410981875671253 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:26058 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-06-10T09:23:45.544868Z","caller":"traceutil/trace.go:171","msg":"trace[87402918] linearizableReadLoop","detail":"{readStateIndex:26908; appliedIndex:26907; }","duration":"262.019192ms","start":"2026-06-10T09:23:45.282832Z","end":"2026-06-10T09:23:45.544851Z","steps":["trace[87402918] 'read index received'  (duration: 68.939267ms)","trace[87402918] 'applied index is now lower than readState.Index'  (duration: 193.078415ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:45.545037Z","caller":"traceutil/trace.go:171","msg":"trace[1512370392] transaction","detail":"{read_only:false; response_revision:26072; number_of_response:1; }","duration":"264.729204ms","start":"2026-06-10T09:23:45.280292Z","end":"2026-06-10T09:23:45.545021Z","steps":["trace[1512370392] 'process raft request'  (duration: 71.525776ms)","trace[1512370392] 'compare'  (duration: 192.560876ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:45.545345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.499642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-06-10T09:23:45.5454Z","caller":"traceutil/trace.go:171","msg":"trace[1524687637] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:26072; }","duration":"262.560453ms","start":"2026-06-10T09:23:45.282826Z","end":"2026-06-10T09:23:45.545387Z","steps":["trace[1524687637] 'agreement among raft nodes before linearized reading'  (duration: 262.39528ms)"],"step_count":1}
{"level":"warn","ts":"2026-06-10T09:23:45.545421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.179092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-06-10T09:23:45.545514Z","caller":"traceutil/trace.go:171","msg":"trace[1922860623] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26072; }","duration":"163.321365ms","start":"2026-06-10T09:23:45.382169Z","end":"2026-06-10T09:23:45.54549Z","steps":["trace[1922860623] 'agreement among raft nodes before linearized reading'  (duration: 163.06837ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:45.828883Z","caller":"traceutil/trace.go:171","msg":"trace[1581089335] transaction","detail":"{read_only:false; response_revision:26073; number_of_response:1; }","duration":"278.313742ms","start":"2026-06-10T09:23:45.550529Z","end":"2026-06-10T09:23:45.828843Z","steps":["trace[1581089335] 'process raft request'  (duration: 229.535123ms)","trace[1581089335] 'compare'  (duration: 48.568215ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:23:45.835565Z","caller":"traceutil/trace.go:171","msg":"trace[192310401] linearizableReadLoop","detail":"{readStateIndex:26910; appliedIndex:26908; }","duration":"117.208997ms","start":"2026-06-10T09:23:45.718331Z","end":"2026-06-10T09:23:45.83554Z","steps":["trace[192310401] 'read index received'  (duration: 61.882675ms)","trace[192310401] 'applied index is now lower than readState.Index'  (duration: 55.325172ms)"],"step_count":2}
{"level":"warn","ts":"2026-06-10T09:23:45.835734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.3985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-06-10T09:23:45.835779Z","caller":"traceutil/trace.go:171","msg":"trace[1903381264] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26073; }","duration":"117.493622ms","start":"2026-06-10T09:23:45.718273Z","end":"2026-06-10T09:23:45.835767Z","steps":["trace[1903381264] 'agreement among raft nodes before linearized reading'  (duration: 117.34682ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:23:52.497122Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22830}
{"level":"info","ts":"2026-06-10T09:23:52.626746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22830,"took":"125.186486ms","hash":2771651745,"current-db-size-bytes":57217024,"current-db-size":"57 MB","current-db-size-in-use-bytes":41713664,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-06-10T09:23:52.626811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2771651745,"revision":22830,"compact-revision":20305}
{"level":"info","ts":"2026-06-10T09:24:01.579934Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000069b8.wal"}
{"level":"info","ts":"2026-06-10T09:24:38.302699Z","caller":"traceutil/trace.go:171","msg":"trace[944164116] transaction","detail":"{read_only:false; response_revision:26638; number_of_response:1; }","duration":"100.668384ms","start":"2026-06-10T09:24:38.201985Z","end":"2026-06-10T09:24:38.302653Z","steps":["trace[944164116] 'process raft request'  (duration: 52.210353ms)","trace[944164116] 'compare'  (duration: 48.289888ms)"],"step_count":2}
{"level":"info","ts":"2026-06-10T09:28:52.503099Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26126}
{"level":"info","ts":"2026-06-10T09:28:52.650419Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26126,"took":"140.769698ms","hash":1608222985,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":36519936,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-06-10T09:28:52.650472Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1608222985,"revision":26126,"compact-revision":22830}
{"level":"info","ts":"2026-06-10T09:29:00.18119Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e98569549cc430c","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-10T09:29:00.185775Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-06-10T09:29:00.185902Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-06-10T09:33:52.508609Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29035}
{"level":"info","ts":"2026-06-10T09:33:52.650026Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29035,"took":"137.677035ms","hash":3701167953,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":31137792,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-10T09:33:52.650098Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3701167953,"revision":29035,"compact-revision":26126}
{"level":"info","ts":"2026-06-10T09:38:52.51502Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31294}
{"level":"info","ts":"2026-06-10T09:38:52.636706Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31294,"took":"118.394073ms","hash":2151347612,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":31166464,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-06-10T09:38:52.636822Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2151347612,"revision":31294,"compact-revision":29035}
{"level":"info","ts":"2026-06-10T09:43:52.521165Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33599}
{"level":"info","ts":"2026-06-10T09:43:52.678492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33599,"took":"152.076955ms","hash":2422714991,"current-db-size-bytes":58482688,"current-db-size":"58 MB","current-db-size-in-use-bytes":32653312,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-06-10T09:43:52.678578Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2422714991,"revision":33599,"compact-revision":31294}
{"level":"info","ts":"2026-06-10T09:48:33.322766Z","caller":"traceutil/trace.go:171","msg":"trace[1511312209] transaction","detail":"{read_only:false; response_revision:38011; number_of_response:1; }","duration":"100.065461ms","start":"2026-06-10T09:48:33.222678Z","end":"2026-06-10T09:48:33.322744Z","steps":["trace[1511312209] 'process raft request'  (duration: 99.690934ms)"],"step_count":1}
{"level":"info","ts":"2026-06-10T09:48:52.528012Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35929}
{"level":"info","ts":"2026-06-10T09:48:52.667943Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35929,"took":"136.74124ms","hash":3713165550,"current-db-size-bytes":61120512,"current-db-size":"61 MB","current-db-size-in-use-bytes":33017856,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-06-10T09:48:52.668009Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3713165550,"revision":35929,"compact-revision":33599}
{"level":"info","ts":"2026-06-10T09:50:04.678015Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4e98569549cc430c","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-06-10T09:50:04.686132Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-06-10T09:50:04.686329Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}