{"level":"warn","ts":"2026-08-25T19:10:15.163854Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-25T19:10:15.163979Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.56: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://162.253.55.56:2380","--initial-cluster=instance=https://162.253.55.56:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.56:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.56: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-08-25T19:10:15.164064Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-25T19:10:15.164081Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.56:2380"]}
{"level":"info","ts":"2026-08-25T19:10:15.164111Z","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-08-25T19:10:15.164837Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.56:2379"]}
{"level":"info","ts":"2026-08-25T19:10:15.164929Z","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://162.253.55.56:2380"],"listen-peer-urls":["https://162.253.55.56:2380"],"advertise-client-urls":["https://162.253.55.56:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.56:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.56: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-08-25T19:10:15.167667Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.488423ms"}
{"level":"info","ts":"2026-08-25T19:10:15.178589Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c9fb5245756f3898","cluster-id":"2527a2eb37d698df"}
{"level":"info","ts":"2026-08-25T19:10:15.178688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-25T19:10:15.178721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 became follower at term 0"}
{"level":"info","ts":"2026-08-25T19:10:15.178742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c9fb5245756f3898 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-25T19:10:15.178767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 became follower at term 1"}
{"level":"info","ts":"2026-08-25T19:10:15.17883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 switched to configuration voters=(14554317079054334104)"}
{"level":"warn","ts":"2026-08-25T19:10:15.183772Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-25T19:10:15.18854Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-25T19:10:15.190718Z","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-08-25T19:10:15.193632Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c9fb5245756f3898","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-25T19:10:15.193906Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c9fb5245756f3898","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-25T19:10:15.19414Z","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-08-25T19:10:15.194282Z","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-08-25T19:10:15.194302Z","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-08-25T19:10:15.195012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 switched to configuration voters=(14554317079054334104)"}
{"level":"info","ts":"2026-08-25T19:10:15.195109Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2527a2eb37d698df","local-member-id":"c9fb5245756f3898","added-peer-id":"c9fb5245756f3898","added-peer-peer-urls":["https://162.253.55.56:2380"]}
{"level":"info","ts":"2026-08-25T19:10:15.197229Z","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-08-25T19:10:15.197339Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.56:2380"}
{"level":"info","ts":"2026-08-25T19:10:15.197567Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.56:2380"}
{"level":"info","ts":"2026-08-25T19:10:15.197764Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c9fb5245756f3898","initial-advertise-peer-urls":["https://162.253.55.56:2380"],"listen-peer-urls":["https://162.253.55.56:2380"],"advertise-client-urls":["https://162.253.55.56:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.56:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-25T19:10:15.197808Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-25T19:10:15.479413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-25T19:10:15.47951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-25T19:10:15.479552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 received MsgPreVoteResp from c9fb5245756f3898 at term 1"}
{"level":"info","ts":"2026-08-25T19:10:15.479577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 became candidate at term 2"}
{"level":"info","ts":"2026-08-25T19:10:15.479594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 received MsgVoteResp from c9fb5245756f3898 at term 2"}
{"level":"info","ts":"2026-08-25T19:10:15.479619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9fb5245756f3898 became leader at term 2"}
{"level":"info","ts":"2026-08-25T19:10:15.479642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9fb5245756f3898 elected leader c9fb5245756f3898 at term 2"}
{"level":"info","ts":"2026-08-25T19:10:15.480518Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c9fb5245756f3898","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.56:2379]}","request-path":"/0/members/c9fb5245756f3898/attributes","cluster-id":"2527a2eb37d698df","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-25T19:10:15.4806Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-25T19:10:15.480692Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-25T19:10:15.480731Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-25T19:10:15.481162Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-25T19:10:15.481209Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-25T19:10:15.482916Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2527a2eb37d698df","local-member-id":"c9fb5245756f3898","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-25T19:10:15.483057Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-25T19:10:15.483111Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-25T19:10:15.48458Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-25T19:10:15.484638Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.56:2379"}
{"level":"info","ts":"2026-08-25T19:10:26.095391Z","caller":"traceutil/trace.go:171","msg":"trace[466567754] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"398.546421ms","start":"2026-08-25T19:10:25.696816Z","end":"2026-08-25T19:10:26.095363Z","steps":["trace[466567754] 'process raft request'  (duration: 308.2314ms)","trace[466567754] 'compare'  (duration: 89.922722ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:10:26.095394Z","caller":"traceutil/trace.go:171","msg":"trace[960726078] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"398.466919ms","start":"2026-08-25T19:10:25.696903Z","end":"2026-08-25T19:10:26.09537Z","steps":["trace[960726078] 'process raft request'  (duration: 398.384047ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:26.09621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:25.696797Z","time spent":"398.701705ms","remote":"127.0.0.1:44410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-7c96b6546b-hzqqx.18cf220f2ec5a5a4\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-7c96b6546b-hzqqx.18cf220f2ec5a5a4\" value_size:742 lease:4078185634971159836 >> failure:<>"}
{"level":"warn","ts":"2026-08-25T19:10:26.096543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:25.696872Z","time spent":"398.871918ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4001,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-7c96b6546b-hzqqx\" mod_revision:334 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-hzqqx\" value_size:3942 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-hzqqx\" > >"}
{"level":"info","ts":"2026-08-25T19:10:26.415256Z","caller":"traceutil/trace.go:171","msg":"trace[47997853] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:351; }","duration":"646.255718ms","start":"2026-08-25T19:10:25.768956Z","end":"2026-08-25T19:10:26.415212Z","steps":["trace[47997853] 'read index received'  (duration: 236.100544ms)","trace[47997853] 'applied index is now lower than readState.Index'  (duration: 410.153433ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:10:26.415365Z","caller":"traceutil/trace.go:171","msg":"trace[1879856623] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"673.308096ms","start":"2026-08-25T19:10:25.742023Z","end":"2026-08-25T19:10:26.415331Z","steps":["trace[1879856623] 'process raft request'  (duration: 638.284985ms)","trace[1879856623] 'compare'  (duration: 34.645142ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:10:26.415614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.39957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-25T19:10:26.416418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:25.742005Z","time spent":"673.412328ms","remote":"127.0.0.1:44784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/coredns\" mod_revision:316 > success:<request_put:<key:\"/registry/deployments/kube-system/coredns\" value_size:3992 >> failure:<request_range:<key:\"/registry/deployments/kube-system/coredns\" > >"}
{"level":"warn","ts":"2026-08-25T19:10:26.416155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.184649ms","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-08-25T19:10:26.41702Z","caller":"traceutil/trace.go:171","msg":"trace[775434476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:342; }","duration":"647.843723ms","start":"2026-08-25T19:10:25.76888Z","end":"2026-08-25T19:10:26.416724Z","steps":["trace[775434476] 'agreement among raft nodes before linearized reading'  (duration: 646.516244ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:26.418008Z","caller":"traceutil/trace.go:171","msg":"trace[1891569023] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:342; }","duration":"114.785291ms","start":"2026-08-25T19:10:26.303142Z","end":"2026-08-25T19:10:26.417927Z","steps":["trace[1891569023] 'agreement among raft nodes before linearized reading'  (duration: 112.314759ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:26.418407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:25.76885Z","time spent":"648.267562ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-08-25T19:10:57.430212Z","caller":"traceutil/trace.go:171","msg":"trace[988967071] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"195.557015ms","start":"2026-08-25T19:10:57.234557Z","end":"2026-08-25T19:10:57.430114Z","steps":["trace[988967071] 'process raft request'  (duration: 192.809735ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:58.317788Z","caller":"traceutil/trace.go:171","msg":"trace[2141261335] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"450.10172ms","start":"2026-08-25T19:10:57.867605Z","end":"2026-08-25T19:10:58.317707Z","steps":["trace[2141261335] 'process raft request'  (duration: 449.837435ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.31806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:57.867574Z","time spent":"450.392007ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:438 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-08-25T19:10:58.366319Z","caller":"traceutil/trace.go:171","msg":"trace[1264061222] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:609; }","duration":"208.753392ms","start":"2026-08-25T19:10:58.15754Z","end":"2026-08-25T19:10:58.366293Z","steps":["trace[1264061222] 'read index received'  (duration: 159.999324ms)","trace[1264061222] 'applied index is now lower than readState.Index'  (duration: 48.752367ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:10:58.366365Z","caller":"traceutil/trace.go:171","msg":"trace[1659088660] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"454.934094ms","start":"2026-08-25T19:10:57.911393Z","end":"2026-08-25T19:10:58.366327Z","steps":["trace[1659088660] 'process raft request'  (duration: 454.302161ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.366491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.923765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:10:58.366544Z","caller":"traceutil/trace.go:171","msg":"trace[525450366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"209.021918ms","start":"2026-08-25T19:10:58.157508Z","end":"2026-08-25T19:10:58.366529Z","steps":["trace[525450366] 'agreement among raft nodes before linearized reading'  (duration: 208.895345ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.366549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:57.911374Z","time spent":"455.073468ms","remote":"127.0.0.1:44420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:583 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036205 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-08-25T19:12:30.35354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.630587ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971163022 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1066bef-90e1-4d80-b10e-048b36273067\" mod_revision:1790 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1066bef-90e1-4d80-b10e-048b36273067\" value_size:3625 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1066bef-90e1-4d80-b10e-048b36273067\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-25T19:12:30.353786Z","caller":"traceutil/trace.go:171","msg":"trace[2137209139] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"386.070243ms","start":"2026-08-25T19:12:29.967633Z","end":"2026-08-25T19:12:30.353703Z","steps":["trace[2137209139] 'process raft request'  (duration: 166.977004ms)","trace[2137209139] 'compare'  (duration: 218.514865ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:12:30.353907Z","caller":"traceutil/trace.go:171","msg":"trace[711904933] linearizableReadLoop","detail":"{readStateIndex:1906; appliedIndex:1904; }","duration":"318.087601ms","start":"2026-08-25T19:12:30.035801Z","end":"2026-08-25T19:12:30.353888Z","steps":["trace[711904933] 'read index received'  (duration: 98.90014ms)","trace[711904933] 'applied index is now lower than readState.Index'  (duration: 219.186381ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:12:30.353988Z","caller":"traceutil/trace.go:171","msg":"trace[190265892] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"338.055589ms","start":"2026-08-25T19:12:30.0159Z","end":"2026-08-25T19:12:30.353956Z","steps":["trace[190265892] 'process raft request'  (duration: 337.744782ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:12:30.354124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:12:29.967618Z","time spent":"386.313117ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3725,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1066bef-90e1-4d80-b10e-048b36273067\" mod_revision:1790 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1066bef-90e1-4d80-b10e-048b36273067\" value_size:3625 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1066bef-90e1-4d80-b10e-048b36273067\" > >"}
{"level":"warn","ts":"2026-08-25T19:12:30.354159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:12:30.015882Z","time spent":"338.180271ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:1684 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-08-25T19:12:30.354321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.436928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-25T19:12:30.354392Z","caller":"traceutil/trace.go:171","msg":"trace[1683442013] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1834; }","duration":"318.586021ms","start":"2026-08-25T19:12:30.035794Z","end":"2026-08-25T19:12:30.35438Z","steps":["trace[1683442013] 'agreement among raft nodes before linearized reading'  (duration: 318.265184ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:12:30.354557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:12:30.035739Z","time spent":"318.752456ms","remote":"127.0.0.1:49866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-08-25T19:12:47.526189Z","caller":"traceutil/trace.go:171","msg":"trace[1777588686] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"105.310762ms","start":"2026-08-25T19:12:47.420837Z","end":"2026-08-25T19:12:47.526148Z","steps":["trace[1777588686] 'process raft request'  (duration: 105.048645ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:25.292751Z","caller":"traceutil/trace.go:171","msg":"trace[382911252] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"153.312465ms","start":"2026-08-25T19:13:25.139406Z","end":"2026-08-25T19:13:25.292718Z","steps":["trace[382911252] 'process raft request'  (duration: 153.139852ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:13:25.600846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.557871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-25T19:13:25.600933Z","caller":"traceutil/trace.go:171","msg":"trace[1540195735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2184; }","duration":"185.696254ms","start":"2026-08-25T19:13:25.415216Z","end":"2026-08-25T19:13:25.600913Z","steps":["trace[1540195735] 'range keys from in-memory index tree'  (duration: 185.381138ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:13:25.600936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.638522ms","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-08-25T19:13:25.601045Z","caller":"traceutil/trace.go:171","msg":"trace[1724768355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2184; }","duration":"179.806456ms","start":"2026-08-25T19:13:25.421216Z","end":"2026-08-25T19:13:25.601023Z","steps":["trace[1724768355] 'range keys from in-memory index tree'  (duration: 179.470508ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:13:25.601055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.391027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:13:25.601198Z","caller":"traceutil/trace.go:171","msg":"trace[1523427365] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:2184; }","duration":"205.710104ms","start":"2026-08-25T19:13:25.395466Z","end":"2026-08-25T19:13:25.601176Z","steps":["trace[1523427365] 'count revisions from in-memory index tree'  (duration: 205.298875ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:25.734734Z","caller":"traceutil/trace.go:171","msg":"trace[2045776593] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"128.007039ms","start":"2026-08-25T19:13:25.6067Z","end":"2026-08-25T19:13:25.734707Z","steps":["trace[2045776593] 'process raft request'  (duration: 127.828545ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:25.741494Z","caller":"traceutil/trace.go:171","msg":"trace[1775681347] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"133.432197ms","start":"2026-08-25T19:13:25.608002Z","end":"2026-08-25T19:13:25.741435Z","steps":["trace[1775681347] 'process raft request'  (duration: 133.156081ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:14:33.680592Z","caller":"traceutil/trace.go:171","msg":"trace[1490489691] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"136.408443ms","start":"2026-08-25T19:14:33.544152Z","end":"2026-08-25T19:14:33.68056Z","steps":["trace[1490489691] 'process raft request'  (duration: 136.152828ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:14:34.12715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.929089ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971165114 > lease_revoke:<id:3898a03a548ea0d3>","response":"size:28"}
{"level":"warn","ts":"2026-08-25T19:18:37.965488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.968747ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971170365 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumidentities/36342\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumidentities/36342\" value_size:2125 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-25T19:18:37.965586Z","caller":"traceutil/trace.go:171","msg":"trace[824559370] linearizableReadLoop","detail":"{readStateIndex:5135; appliedIndex:5134; }","duration":"131.337157ms","start":"2026-08-25T19:18:37.834235Z","end":"2026-08-25T19:18:37.965572Z","steps":["trace[824559370] 'read index received'  (duration: 63.802µs)","trace[824559370] 'applied index is now lower than readState.Index'  (duration: 131.272245ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:18:37.965781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.545771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-25T19:18:37.965807Z","caller":"traceutil/trace.go:171","msg":"trace[652257147] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4948; }","duration":"131.620093ms","start":"2026-08-25T19:18:37.83418Z","end":"2026-08-25T19:18:37.9658Z","steps":["trace[652257147] 'agreement among raft nodes before linearized reading'  (duration: 131.48427ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:18:37.965926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.558472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-63e8f84e-4e8b-4db3-8521-6a76f8c664fb\" ","response":"range_response_count:1 size:3600"}
{"level":"warn","ts":"2026-08-25T19:18:37.965954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.125778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-q2sgw.18cf228189b5eca9\" ","response":"range_response_count:1 size:962"}
{"level":"info","ts":"2026-08-25T19:18:37.966025Z","caller":"traceutil/trace.go:171","msg":"trace[1625483021] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-63e8f84e-4e8b-4db3-8521-6a76f8c664fb; range_end:; response_count:1; response_revision:4948; }","duration":"111.715756ms","start":"2026-08-25T19:18:37.854285Z","end":"2026-08-25T19:18:37.966Z","steps":["trace[1625483021] 'agreement among raft nodes before linearized reading'  (duration: 111.41478ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:37.96603Z","caller":"traceutil/trace.go:171","msg":"trace[326151250] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-q2sgw.18cf228189b5eca9; range_end:; response_count:1; response_revision:4948; }","duration":"108.223779ms","start":"2026-08-25T19:18:37.857787Z","end":"2026-08-25T19:18:37.96601Z","steps":["trace[326151250] 'agreement among raft nodes before linearized reading'  (duration: 107.993824ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:37.966203Z","caller":"traceutil/trace.go:171","msg":"trace[680316697] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"161.404375ms","start":"2026-08-25T19:18:37.804778Z","end":"2026-08-25T19:18:37.966182Z","steps":["trace[680316697] 'process raft request'  (duration: 25.676802ms)","trace[680316697] 'compare'  (duration: 134.840563ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:18:40.158904Z","caller":"traceutil/trace.go:171","msg":"trace[715594274] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5178; }","duration":"153.053942ms","start":"2026-08-25T19:18:40.005828Z","end":"2026-08-25T19:18:40.158882Z","steps":["trace[715594274] 'read index received'  (duration: 152.875058ms)","trace[715594274] 'applied index is now lower than readState.Index'  (duration: 177.944µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:18:40.158981Z","caller":"traceutil/trace.go:171","msg":"trace[500822338] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"179.452301ms","start":"2026-08-25T19:18:39.979499Z","end":"2026-08-25T19:18:40.158951Z","steps":["trace[500822338] 'process raft request'  (duration: 179.262807ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:18:40.159105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.253187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fq8n5\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-08-25T19:18:40.159151Z","caller":"traceutil/trace.go:171","msg":"trace[562368602] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fq8n5; range_end:; response_count:1; response_revision:4990; }","duration":"153.338098ms","start":"2026-08-25T19:18:40.005801Z","end":"2026-08-25T19:18:40.159139Z","steps":["trace[562368602] 'agreement among raft nodes before linearized reading'  (duration: 153.179364ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:42.758482Z","caller":"traceutil/trace.go:171","msg":"trace[602451818] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"124.098948ms","start":"2026-08-25T19:18:42.634347Z","end":"2026-08-25T19:18:42.758446Z","steps":["trace[602451818] 'process raft request'  (duration: 108.220741ms)","trace[602451818] 'compare'  (duration: 15.729823ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:18:51.159069Z","caller":"traceutil/trace.go:171","msg":"trace[1700850478] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"107.260749ms","start":"2026-08-25T19:18:51.051777Z","end":"2026-08-25T19:18:51.159038Z","steps":["trace[1700850478] 'process raft request'  (duration: 107.090696ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:51.217668Z","caller":"traceutil/trace.go:171","msg":"trace[1644667525] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"131.718554ms","start":"2026-08-25T19:18:51.085901Z","end":"2026-08-25T19:18:51.21762Z","steps":["trace[1644667525] 'process raft request'  (duration: 112.084775ms)","trace[1644667525] 'compare'  (duration: 19.470336ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:18:51.217803Z","caller":"traceutil/trace.go:171","msg":"trace[1949108615] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"121.683065ms","start":"2026-08-25T19:18:51.09608Z","end":"2026-08-25T19:18:51.217764Z","steps":["trace[1949108615] 'process raft request'  (duration: 121.485691ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:51.650347Z","caller":"traceutil/trace.go:171","msg":"trace[1512954321] transaction","detail":"{read_only:false; response_revision:5194; number_of_response:1; }","duration":"113.639711ms","start":"2026-08-25T19:18:51.536659Z","end":"2026-08-25T19:18:51.650298Z","steps":["trace[1512954321] 'process raft request'  (duration: 94.258687ms)","trace[1512954321] 'compare'  (duration: 19.138798ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:18:51.650405Z","caller":"traceutil/trace.go:171","msg":"trace[1300195063] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"111.929834ms","start":"2026-08-25T19:18:51.538445Z","end":"2026-08-25T19:18:51.650375Z","steps":["trace[1300195063] 'process raft request'  (duration: 111.73759ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:53.137613Z","caller":"traceutil/trace.go:171","msg":"trace[1131341676] linearizableReadLoop","detail":"{readStateIndex:5427; appliedIndex:5424; }","duration":"108.277333ms","start":"2026-08-25T19:18:53.029312Z","end":"2026-08-25T19:18:53.137589Z","steps":["trace[1131341676] 'read index received'  (duration: 34.81599ms)","trace[1131341676] 'applied index is now lower than readState.Index'  (duration: 73.460303ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:18:53.13764Z","caller":"traceutil/trace.go:171","msg":"trace[1166146679] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"119.814886ms","start":"2026-08-25T19:18:53.01779Z","end":"2026-08-25T19:18:53.137604Z","steps":["trace[1166146679] 'process raft request'  (duration: 119.611551ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:18:53.137772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.430947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:18:53.137809Z","caller":"traceutil/trace.go:171","msg":"trace[489167309] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:5231; }","duration":"108.490208ms","start":"2026-08-25T19:18:53.029305Z","end":"2026-08-25T19:18:53.137796Z","steps":["trace[489167309] 'agreement among raft nodes before linearized reading'  (duration: 108.404206ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:53.139148Z","caller":"traceutil/trace.go:171","msg":"trace[802355666] transaction","detail":"{read_only:false; response_revision:5231; number_of_response:1; }","duration":"117.783671ms","start":"2026-08-25T19:18:53.021339Z","end":"2026-08-25T19:18:53.139123Z","steps":["trace[802355666] 'process raft request'  (duration: 116.190596ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:53.62233Z","caller":"traceutil/trace.go:171","msg":"trace[536794351] linearizableReadLoop","detail":"{readStateIndex:5439; appliedIndex:5438; }","duration":"183.905055ms","start":"2026-08-25T19:18:53.438395Z","end":"2026-08-25T19:18:53.6223Z","steps":["trace[536794351] 'read index received'  (duration: 183.69285ms)","trace[536794351] 'applied index is now lower than readState.Index'  (duration: 210.994µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:18:53.622465Z","caller":"traceutil/trace.go:171","msg":"trace[820789294] transaction","detail":"{read_only:false; response_revision:5243; number_of_response:1; }","duration":"198.535534ms","start":"2026-08-25T19:18:53.423896Z","end":"2026-08-25T19:18:53.622431Z","steps":["trace[820789294] 'process raft request'  (duration: 198.220128ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:18:53.622558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.137229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-08-25T19:18:53.622652Z","caller":"traceutil/trace.go:171","msg":"trace[1458631155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5243; }","duration":"184.273103ms","start":"2026-08-25T19:18:53.438362Z","end":"2026-08-25T19:18:53.622635Z","steps":["trace[1458631155] 'agreement among raft nodes before linearized reading'  (duration: 184.059158ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:58.18331Z","caller":"traceutil/trace.go:171","msg":"trace[724850116] linearizableReadLoop","detail":"{readStateIndex:5486; appliedIndex:5485; }","duration":"100.271548ms","start":"2026-08-25T19:18:58.082997Z","end":"2026-08-25T19:18:58.183269Z","steps":["trace[724850116] 'read index received'  (duration: 99.88882ms)","trace[724850116] 'applied index is now lower than readState.Index'  (duration: 380.398µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:18:58.183688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.648766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-08-25T19:18:58.183746Z","caller":"traceutil/trace.go:171","msg":"trace[869065943] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5289; }","duration":"100.79435ms","start":"2026-08-25T19:18:58.082934Z","end":"2026-08-25T19:18:58.183729Z","steps":["trace[869065943] 'agreement among raft nodes before linearized reading'  (duration: 100.502363ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:18:58.18432Z","caller":"traceutil/trace.go:171","msg":"trace[490372315] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"119.715173ms","start":"2026-08-25T19:18:58.064586Z","end":"2026-08-25T19:18:58.184301Z","steps":["trace[490372315] 'process raft request'  (duration: 118.450795ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:02.17548Z","caller":"traceutil/trace.go:171","msg":"trace[1868824911] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"205.643719ms","start":"2026-08-25T19:19:01.969812Z","end":"2026-08-25T19:19:02.175456Z","steps":["trace[1868824911] 'process raft request'  (duration: 205.502666ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:02.421086Z","caller":"traceutil/trace.go:171","msg":"trace[533076380] linearizableReadLoop","detail":"{readStateIndex:5609; appliedIndex:5607; }","duration":"311.822007ms","start":"2026-08-25T19:19:02.109235Z","end":"2026-08-25T19:19:02.421057Z","steps":["trace[533076380] 'read index received'  (duration: 66.177704ms)","trace[533076380] 'applied index is now lower than readState.Index'  (duration: 245.642513ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:19:02.421823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.770628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:19:02.421911Z","caller":"traceutil/trace.go:171","msg":"trace[97686660] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5408; }","duration":"263.909081ms","start":"2026-08-25T19:19:02.157985Z","end":"2026-08-25T19:19:02.421894Z","steps":["trace[97686660] 'agreement among raft nodes before linearized reading'  (duration: 263.765748ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:02.422045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.966272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fq8n5\" ","response":"range_response_count:1 size:6527"}
{"level":"warn","ts":"2026-08-25T19:19:02.422237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.020047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"warn","ts":"2026-08-25T19:19:02.422277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.034014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e621e5d0-1748-41b8-8553-d152e646eb41\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-08-25T19:19:02.422309Z","caller":"traceutil/trace.go:171","msg":"trace[653123133] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fq8n5; range_end:; response_count:1; response_revision:5408; }","duration":"111.264549ms","start":"2026-08-25T19:19:02.311028Z","end":"2026-08-25T19:19:02.422292Z","steps":["trace[653123133] 'agreement among raft nodes before linearized reading'  (duration: 110.827289ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:02.421839Z","caller":"traceutil/trace.go:171","msg":"trace[639760241] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"451.647209ms","start":"2026-08-25T19:19:01.970178Z","end":"2026-08-25T19:19:02.421825Z","steps":["trace[639760241] 'process raft request'  (duration: 450.600187ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:02.422341Z","caller":"traceutil/trace.go:171","msg":"trace[555789816] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5408; }","duration":"113.357895ms","start":"2026-08-25T19:19:02.308961Z","end":"2026-08-25T19:19:02.422319Z","steps":["trace[555789816] 'agreement among raft nodes before linearized reading'  (duration: 112.907364ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:02.422346Z","caller":"traceutil/trace.go:171","msg":"trace[1378479730] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e621e5d0-1748-41b8-8553-d152e646eb41; range_end:; response_count:1; response_revision:5408; }","duration":"313.142106ms","start":"2026-08-25T19:19:02.109186Z","end":"2026-08-25T19:19:02.422328Z","steps":["trace[1378479730] 'agreement among raft nodes before linearized reading'  (duration: 312.643024ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:02.42241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:19:02.109167Z","time spent":"313.229989ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e621e5d0-1748-41b8-8553-d152e646eb41\" "}
{"level":"warn","ts":"2026-08-25T19:19:02.422447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:19:01.970156Z","time spent":"452.192983ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5305 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-25T19:20:15.569676Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2978}
{"level":"info","ts":"2026-08-25T19:20:15.645825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2978,"took":"75.03016ms","hash":2091471273,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":34217984,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-25T19:20:15.645882Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2091471273,"revision":2978,"compact-revision":-1}
{"level":"info","ts":"2026-08-25T19:25:15.609314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6085}
{"level":"info","ts":"2026-08-25T19:25:15.714118Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6085,"took":"103.123542ms","hash":179808053,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":22990848,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-08-25T19:25:15.714172Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":179808053,"revision":6085,"compact-revision":2978}
{"level":"warn","ts":"2026-08-25T19:25:20.090919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.301636ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971178866 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8291 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-25T19:25:20.091069Z","caller":"traceutil/trace.go:171","msg":"trace[1916255828] linearizableReadLoop","detail":"{readStateIndex:8598; appliedIndex:8597; }","duration":"400.75249ms","start":"2026-08-25T19:25:19.690297Z","end":"2026-08-25T19:25:20.091049Z","steps":["trace[1916255828] 'read index received'  (duration: 213.981723ms)","trace[1916255828] 'applied index is now lower than readState.Index'  (duration: 186.768747ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:25:20.091101Z","caller":"traceutil/trace.go:171","msg":"trace[164586458] transaction","detail":"{read_only:false; response_revision:8303; number_of_response:1; }","duration":"450.871695ms","start":"2026-08-25T19:25:19.640196Z","end":"2026-08-25T19:25:20.091068Z","steps":["trace[164586458] 'process raft request'  (duration: 264.139358ms)","trace[164586458] 'compare'  (duration: 184.789505ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:25:20.09126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:25:19.640183Z","time spent":"450.988257ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8291 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-25T19:25:20.091327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.036166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"}
{"level":"info","ts":"2026-08-25T19:25:20.091451Z","caller":"traceutil/trace.go:171","msg":"trace[1409869548] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8303; }","duration":"401.19448ms","start":"2026-08-25T19:25:19.690246Z","end":"2026-08-25T19:25:20.091441Z","steps":["trace[1409869548] 'agreement among raft nodes before linearized reading'  (duration: 400.911024ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:25:20.091508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:25:19.690224Z","time spent":"401.272231ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12232,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-08-25T19:25:31.452525Z","caller":"traceutil/trace.go:171","msg":"trace[1964443627] transaction","detail":"{read_only:false; response_revision:8363; number_of_response:1; }","duration":"172.847354ms","start":"2026-08-25T19:25:31.279648Z","end":"2026-08-25T19:25:31.452496Z","steps":["trace[1964443627] 'process raft request'  (duration: 172.66825ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:25:31.765023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.928902ms","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-08-25T19:25:31.765077Z","caller":"traceutil/trace.go:171","msg":"trace[505855188] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8363; }","duration":"105.033464ms","start":"2026-08-25T19:25:31.660031Z","end":"2026-08-25T19:25:31.765065Z","steps":["trace[505855188] 'range keys from in-memory index tree'  (duration: 104.711766ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:25:32.395841Z","caller":"traceutil/trace.go:171","msg":"trace[831080157] transaction","detail":"{read_only:false; response_revision:8367; number_of_response:1; }","duration":"203.629926ms","start":"2026-08-25T19:25:32.192183Z","end":"2026-08-25T19:25:32.395813Z","steps":["trace[831080157] 'process raft request'  (duration: 203.459773ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:25:32.51293Z","caller":"traceutil/trace.go:171","msg":"trace[29000412] linearizableReadLoop","detail":"{readStateIndex:8665; appliedIndex:8663; }","duration":"174.626952ms","start":"2026-08-25T19:25:32.338276Z","end":"2026-08-25T19:25:32.512903Z","steps":["trace[29000412] 'read index received'  (duration: 57.421984ms)","trace[29000412] 'applied index is now lower than readState.Index'  (duration: 117.204228ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:25:32.512995Z","caller":"traceutil/trace.go:171","msg":"trace[1675180609] transaction","detail":"{read_only:false; response_revision:8368; number_of_response:1; }","duration":"291.526006ms","start":"2026-08-25T19:25:32.221439Z","end":"2026-08-25T19:25:32.512965Z","steps":["trace[1675180609] 'process raft request'  (duration: 280.729171ms)","trace[1675180609] 'compare'  (duration: 10.61206ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:25:32.513172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.799541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-08-25T19:25:32.513167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.879029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-08-25T19:25:32.513216Z","caller":"traceutil/trace.go:171","msg":"trace[1068564046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8368; }","duration":"171.868073ms","start":"2026-08-25T19:25:32.341334Z","end":"2026-08-25T19:25:32.513202Z","steps":["trace[1068564046] 'agreement among raft nodes before linearized reading'  (duration: 171.71344ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:25:32.513243Z","caller":"traceutil/trace.go:171","msg":"trace[1839064954] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:8368; }","duration":"174.995901ms","start":"2026-08-25T19:25:32.338229Z","end":"2026-08-25T19:25:32.513225Z","steps":["trace[1839064954] 'agreement among raft nodes before linearized reading'  (duration: 174.768866ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:25:32.513274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.60992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-25T19:25:32.513368Z","caller":"traceutil/trace.go:171","msg":"trace[1819215713] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8368; }","duration":"167.761423ms","start":"2026-08-25T19:25:32.345589Z","end":"2026-08-25T19:25:32.513351Z","steps":["trace[1819215713] 'agreement among raft nodes before linearized reading'  (duration: 167.529008ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:25:47.860648Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002233.wal"}
{"level":"info","ts":"2026-08-25T19:26:00.156557Z","caller":"traceutil/trace.go:171","msg":"trace[377738975] transaction","detail":"{read_only:false; response_revision:8569; number_of_response:1; }","duration":"128.882684ms","start":"2026-08-25T19:26:00.027639Z","end":"2026-08-25T19:26:00.156522Z","steps":["trace[377738975] 'process raft request'  (duration: 126.003961ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:26:12.846335Z","caller":"traceutil/trace.go:171","msg":"trace[1612340550] transaction","detail":"{read_only:false; response_revision:8636; number_of_response:1; }","duration":"252.699397ms","start":"2026-08-25T19:26:12.593609Z","end":"2026-08-25T19:26:12.846308Z","steps":["trace[1612340550] 'process raft request'  (duration: 252.530743ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:26:13.01697Z","caller":"traceutil/trace.go:171","msg":"trace[1480023044] transaction","detail":"{read_only:false; response_revision:8637; number_of_response:1; }","duration":"369.345865ms","start":"2026-08-25T19:26:12.647514Z","end":"2026-08-25T19:26:13.01686Z","steps":["trace[1480023044] 'process raft request'  (duration: 356.937454ms)","trace[1480023044] 'compare'  (duration: 12.199206ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:26:13.017005Z","caller":"traceutil/trace.go:171","msg":"trace[9478806] linearizableReadLoop","detail":"{readStateIndex:8945; appliedIndex:8943; }","duration":"295.589703ms","start":"2026-08-25T19:26:12.721383Z","end":"2026-08-25T19:26:13.016973Z","steps":["trace[9478806] 'read index received'  (duration: 124.877946ms)","trace[9478806] 'applied index is now lower than readState.Index'  (duration: 170.709737ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:26:13.017048Z","caller":"traceutil/trace.go:171","msg":"trace[1193654021] transaction","detail":"{read_only:false; response_revision:8638; number_of_response:1; }","duration":"204.531595ms","start":"2026-08-25T19:26:12.812488Z","end":"2026-08-25T19:26:13.01702Z","steps":["trace[1193654021] 'process raft request'  (duration: 204.3031ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:26:13.017209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:26:12.647483Z","time spent":"369.61401ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8627 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-25T19:26:13.017429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.017972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-08-25T19:26:13.017515Z","caller":"traceutil/trace.go:171","msg":"trace[1106057774] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8638; }","duration":"296.134485ms","start":"2026-08-25T19:26:12.721348Z","end":"2026-08-25T19:26:13.017483Z","steps":["trace[1106057774] 'agreement among raft nodes before linearized reading'  (duration: 295.762967ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:26:13.021841Z","caller":"traceutil/trace.go:171","msg":"trace[200249486] transaction","detail":"{read_only:false; response_revision:8639; number_of_response:1; }","duration":"121.122674ms","start":"2026-08-25T19:26:12.900697Z","end":"2026-08-25T19:26:13.02182Z","steps":["trace[200249486] 'process raft request'  (duration: 120.875959ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:26:13.02196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.883506ms","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-08-25T19:26:13.022046Z","caller":"traceutil/trace.go:171","msg":"trace[569297629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8640; }","duration":"288.020259ms","start":"2026-08-25T19:26:12.734007Z","end":"2026-08-25T19:26:13.022027Z","steps":["trace[569297629] 'agreement among raft nodes before linearized reading'  (duration: 287.776754ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:26:13.021966Z","caller":"traceutil/trace.go:171","msg":"trace[830324702] transaction","detail":"{read_only:false; response_revision:8640; number_of_response:1; }","duration":"120.100912ms","start":"2026-08-25T19:26:12.901834Z","end":"2026-08-25T19:26:13.021935Z","steps":["trace[830324702] 'process raft request'  (duration: 119.897868ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:26:13.022187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.355547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fq8n5\" ","response":"range_response_count:1 size:6527"}
{"level":"info","ts":"2026-08-25T19:26:13.022275Z","caller":"traceutil/trace.go:171","msg":"trace[1775806008] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fq8n5; range_end:; response_count:1; response_revision:8640; }","duration":"119.481019ms","start":"2026-08-25T19:26:12.902773Z","end":"2026-08-25T19:26:13.022254Z","steps":["trace[1775806008] 'agreement among raft nodes before linearized reading'  (duration: 119.226263ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:26:13.223395Z","caller":"traceutil/trace.go:171","msg":"trace[1034756690] transaction","detail":"{read_only:false; response_revision:8641; number_of_response:1; }","duration":"201.51751ms","start":"2026-08-25T19:26:13.02185Z","end":"2026-08-25T19:26:13.223367Z","steps":["trace[1034756690] 'process raft request'  (duration: 107.697811ms)","trace[1034756690] 'compare'  (duration: 93.699236ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:26:13.23007Z","caller":"traceutil/trace.go:171","msg":"trace[1160124910] transaction","detail":"{read_only:false; response_revision:8642; number_of_response:1; }","duration":"204.643258ms","start":"2026-08-25T19:26:13.025384Z","end":"2026-08-25T19:26:13.230028Z","steps":["trace[1160124910] 'process raft request'  (duration: 204.453694ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:26:13.230198Z","caller":"traceutil/trace.go:171","msg":"trace[1049487738] linearizableReadLoop","detail":"{readStateIndex:8950; appliedIndex:8948; }","duration":"204.081876ms","start":"2026-08-25T19:26:13.026087Z","end":"2026-08-25T19:26:13.230169Z","steps":["trace[1049487738] 'read index received'  (duration: 103.472859ms)","trace[1049487738] 'applied index is now lower than readState.Index'  (duration: 100.607137ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:26:13.230317Z","caller":"traceutil/trace.go:171","msg":"trace[979198115] transaction","detail":"{read_only:false; response_revision:8643; number_of_response:1; }","duration":"194.591419ms","start":"2026-08-25T19:26:13.035709Z","end":"2026-08-25T19:26:13.2303Z","steps":["trace[979198115] 'process raft request'  (duration: 194.239671ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:26:13.23066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.558386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228839"}
{"level":"info","ts":"2026-08-25T19:26:13.230705Z","caller":"traceutil/trace.go:171","msg":"trace[183924399] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8643; }","duration":"204.640438ms","start":"2026-08-25T19:26:13.026055Z","end":"2026-08-25T19:26:13.230695Z","steps":["trace[183924399] 'agreement among raft nodes before linearized reading'  (duration: 204.25517ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:27:41.098696Z","caller":"traceutil/trace.go:171","msg":"trace[498436513] transaction","detail":"{read_only:false; response_revision:9490; number_of_response:1; }","duration":"201.528573ms","start":"2026-08-25T19:27:40.897133Z","end":"2026-08-25T19:27:41.098662Z","steps":["trace[498436513] 'process raft request'  (duration: 188.769915ms)","trace[498436513] 'compare'  (duration: 12.468131ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:27:41.174498Z","caller":"traceutil/trace.go:171","msg":"trace[335378428] transaction","detail":"{read_only:false; response_revision:9491; number_of_response:1; }","duration":"151.873884ms","start":"2026-08-25T19:27:41.022589Z","end":"2026-08-25T19:27:41.174463Z","steps":["trace[335378428] 'process raft request'  (duration: 151.520115ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:28:02.581225Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c9fb5245756f3898","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-25T19:28:02.588266Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-25T19:28:02.588485Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-25T19:30:15.617087Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8209}
{"level":"info","ts":"2026-08-25T19:30:15.681476Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8209,"took":"61.642771ms","hash":3202192461,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":28106752,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-25T19:30:15.681536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3202192461,"revision":8209,"compact-revision":6085}
{"level":"info","ts":"2026-08-25T19:33:16.789526Z","caller":"traceutil/trace.go:171","msg":"trace[1842412148] transaction","detail":"{read_only:false; response_revision:11902; number_of_response:1; }","duration":"186.293567ms","start":"2026-08-25T19:33:16.603204Z","end":"2026-08-25T19:33:16.789497Z","steps":["trace[1842412148] 'process raft request'  (duration: 186.098803ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:33:16.824392Z","caller":"traceutil/trace.go:171","msg":"trace[904621381] transaction","detail":"{read_only:false; response_revision:11904; number_of_response:1; }","duration":"193.071036ms","start":"2026-08-25T19:33:16.631254Z","end":"2026-08-25T19:33:16.824325Z","steps":["trace[904621381] 'process raft request'  (duration: 192.966894ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:33:16.824412Z","caller":"traceutil/trace.go:171","msg":"trace[1800602027] transaction","detail":"{read_only:false; response_revision:11903; number_of_response:1; }","duration":"199.813252ms","start":"2026-08-25T19:33:16.624574Z","end":"2026-08-25T19:33:16.824387Z","steps":["trace[1800602027] 'process raft request'  (duration: 199.489335ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:33:16.824719Z","caller":"traceutil/trace.go:171","msg":"trace[1778027749] transaction","detail":"{read_only:false; response_revision:11905; number_of_response:1; }","duration":"191.287037ms","start":"2026-08-25T19:33:16.633401Z","end":"2026-08-25T19:33:16.824688Z","steps":["trace[1778027749] 'process raft request'  (duration: 190.865688ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:33:16.824743Z","caller":"traceutil/trace.go:171","msg":"trace[1398842501] transaction","detail":"{read_only:false; response_revision:11906; number_of_response:1; }","duration":"186.002041ms","start":"2026-08-25T19:33:16.638712Z","end":"2026-08-25T19:33:16.824714Z","steps":["trace[1398842501] 'process raft request'  (duration: 185.801617ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:33:16.824801Z","caller":"traceutil/trace.go:171","msg":"trace[1090854937] transaction","detail":"{read_only:false; response_revision:11907; number_of_response:1; }","duration":"137.70445ms","start":"2026-08-25T19:33:16.687076Z","end":"2026-08-25T19:33:16.824781Z","steps":["trace[1090854937] 'process raft request'  (duration: 137.513135ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:35:15.63101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10502}
{"level":"info","ts":"2026-08-25T19:35:15.713611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10502,"took":"80.072104ms","hash":558430717,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":26181632,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-25T19:35:15.713711Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":558430717,"revision":10502,"compact-revision":8209}
{"level":"info","ts":"2026-08-25T19:39:28.223388Z","caller":"traceutil/trace.go:171","msg":"trace[1132140120] transaction","detail":"{read_only:false; response_revision:14410; number_of_response:1; }","duration":"103.630243ms","start":"2026-08-25T19:39:28.119741Z","end":"2026-08-25T19:39:28.223371Z","steps":["trace[1132140120] 'process raft request'  (duration: 103.148022ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:39:47.869059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.155404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:39:47.869197Z","caller":"traceutil/trace.go:171","msg":"trace[282359843] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:14512; }","duration":"246.374979ms","start":"2026-08-25T19:39:47.622797Z","end":"2026-08-25T19:39:47.869172Z","steps":["trace[282359843] 'count revisions from in-memory index tree'  (duration: 246.068592ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:39:47.8693Z","caller":"traceutil/trace.go:171","msg":"trace[1853224021] transaction","detail":"{read_only:false; response_revision:14513; number_of_response:1; }","duration":"151.15411ms","start":"2026-08-25T19:39:47.718113Z","end":"2026-08-25T19:39:47.869267Z","steps":["trace[1853224021] 'process raft request'  (duration: 88.570094ms)","trace[1853224021] 'compare'  (duration: 62.452023ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:40:03.573059Z","caller":"traceutil/trace.go:171","msg":"trace[1252814458] transaction","detail":"{read_only:false; response_revision:14608; number_of_response:1; }","duration":"108.460907ms","start":"2026-08-25T19:40:03.464574Z","end":"2026-08-25T19:40:03.573035Z","steps":["trace[1252814458] 'process raft request'  (duration: 108.309224ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:40:04.589318Z","caller":"traceutil/trace.go:171","msg":"trace[207593518] transaction","detail":"{read_only:false; response_revision:14612; number_of_response:1; }","duration":"235.348159ms","start":"2026-08-25T19:40:04.353947Z","end":"2026-08-25T19:40:04.589296Z","steps":["trace[207593518] 'process raft request'  (duration: 235.186876ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:40:04.596636Z","caller":"traceutil/trace.go:171","msg":"trace[1905271995] transaction","detail":"{read_only:false; response_revision:14613; number_of_response:1; }","duration":"239.201204ms","start":"2026-08-25T19:40:04.357393Z","end":"2026-08-25T19:40:04.596594Z","steps":["trace[1905271995] 'process raft request'  (duration: 238.910458ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:40:04.596734Z","caller":"traceutil/trace.go:171","msg":"trace[605741096] transaction","detail":"{read_only:false; response_revision:14615; number_of_response:1; }","duration":"232.950607ms","start":"2026-08-25T19:40:04.363777Z","end":"2026-08-25T19:40:04.596727Z","steps":["trace[605741096] 'process raft request'  (duration: 232.758323ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:40:04.596687Z","caller":"traceutil/trace.go:171","msg":"trace[510302504] linearizableReadLoop","detail":"{readStateIndex:15122; appliedIndex:15118; }","duration":"207.516292ms","start":"2026-08-25T19:40:04.389142Z","end":"2026-08-25T19:40:04.596658Z","steps":["trace[510302504] 'read index received'  (duration: 200.009087ms)","trace[510302504] 'applied index is now lower than readState.Index'  (duration: 7.505835ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:40:04.596696Z","caller":"traceutil/trace.go:171","msg":"trace[135827387] transaction","detail":"{read_only:false; response_revision:14614; number_of_response:1; }","duration":"237.645689ms","start":"2026-08-25T19:40:04.359038Z","end":"2026-08-25T19:40:04.596683Z","steps":["trace[135827387] 'process raft request'  (duration: 237.438995ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:40:04.597065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.90012ms","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-08-25T19:40:04.597159Z","caller":"traceutil/trace.go:171","msg":"trace[1917909274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14615; }","duration":"208.042273ms","start":"2026-08-25T19:40:04.389093Z","end":"2026-08-25T19:40:04.597135Z","steps":["trace[1917909274] 'agreement among raft nodes before linearized reading'  (duration: 207.742576ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:40:15.642911Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12696}
{"level":"info","ts":"2026-08-25T19:40:15.731799Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12696,"took":"86.07193ms","hash":163100383,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":27557888,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-25T19:40:15.732054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":163100383,"revision":12696,"compact-revision":10502}
{"level":"warn","ts":"2026-08-25T19:40:25.976258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.033647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:66 size:630493"}
{"level":"info","ts":"2026-08-25T19:40:25.976352Z","caller":"traceutil/trace.go:171","msg":"trace[1992403592] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:66; response_revision:14921; }","duration":"107.161679ms","start":"2026-08-25T19:40:25.869173Z","end":"2026-08-25T19:40:25.976335Z","steps":["trace[1992403592] 'range keys from in-memory index tree'  (duration: 106.347442ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:40:26.339031Z","caller":"traceutil/trace.go:171","msg":"trace[761324865] transaction","detail":"{read_only:false; response_revision:14922; number_of_response:1; }","duration":"161.586349ms","start":"2026-08-25T19:40:26.177418Z","end":"2026-08-25T19:40:26.339004Z","steps":["trace[761324865] 'process raft request'  (duration: 161.412455ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:41:53.313327Z","caller":"traceutil/trace.go:171","msg":"trace[775593946] transaction","detail":"{read_only:false; response_revision:15734; number_of_response:1; }","duration":"276.651331ms","start":"2026-08-25T19:41:53.03665Z","end":"2026-08-25T19:41:53.313301Z","steps":["trace[775593946] 'process raft request'  (duration: 276.500248ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:41:53.445242Z","caller":"traceutil/trace.go:171","msg":"trace[1775434708] transaction","detail":"{read_only:false; response_revision:15736; number_of_response:1; }","duration":"405.619288ms","start":"2026-08-25T19:41:53.039593Z","end":"2026-08-25T19:41:53.445212Z","steps":["trace[1775434708] 'process raft request'  (duration: 405.498306ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:41:53.445271Z","caller":"traceutil/trace.go:171","msg":"trace[502795218] transaction","detail":"{read_only:false; response_revision:15735; number_of_response:1; }","duration":"406.489517ms","start":"2026-08-25T19:41:53.03875Z","end":"2026-08-25T19:41:53.44524Z","steps":["trace[502795218] 'process raft request'  (duration: 311.242917ms)","trace[502795218] 'compare'  (duration: 94.943623ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:41:53.445397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:41:53.038693Z","time spent":"406.635861ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:15725 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-25T19:41:53.445503Z","caller":"traceutil/trace.go:171","msg":"trace[452646121] linearizableReadLoop","detail":"{readStateIndex:16281; appliedIndex:16278; }","duration":"333.557034ms","start":"2026-08-25T19:41:53.111925Z","end":"2026-08-25T19:41:53.445482Z","steps":["trace[452646121] 'read index received'  (duration: 201.376057ms)","trace[452646121] 'applied index is now lower than readState.Index'  (duration: 132.179447ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:41:53.445423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:41:53.039568Z","time spent":"405.757722ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:15727 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-25T19:41:53.445579Z","caller":"traceutil/trace.go:171","msg":"trace[1777524958] transaction","detail":"{read_only:false; response_revision:15737; number_of_response:1; }","duration":"338.050003ms","start":"2026-08-25T19:41:53.107502Z","end":"2026-08-25T19:41:53.445552Z","steps":["trace[1777524958] 'process raft request'  (duration: 337.662754ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:41:53.445787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.090414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-25T19:41:53.445838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:41:53.10747Z","time spent":"338.206285ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:15728 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-25T19:41:53.44588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.295682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-25T19:41:53.445907Z","caller":"traceutil/trace.go:171","msg":"trace[1761078387] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:15737; }","duration":"215.369344ms","start":"2026-08-25T19:41:53.230528Z","end":"2026-08-25T19:41:53.445897Z","steps":["trace[1761078387] 'agreement among raft nodes before linearized reading'  (duration: 215.322333ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:41:53.445824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.846155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:41:53.445989Z","caller":"traceutil/trace.go:171","msg":"trace[1610550630] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:15737; }","duration":"255.064241ms","start":"2026-08-25T19:41:53.190911Z","end":"2026-08-25T19:41:53.445976Z","steps":["trace[1610550630] 'agreement among raft nodes before linearized reading'  (duration: 254.869306ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:41:53.44592Z","caller":"traceutil/trace.go:171","msg":"trace[484505775] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15737; }","duration":"322.230237ms","start":"2026-08-25T19:41:53.123638Z","end":"2026-08-25T19:41:53.445868Z","steps":["trace[484505775] 'agreement among raft nodes before linearized reading'  (duration: 322.101355ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:41:53.446094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.537476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:41:53.446121Z","caller":"traceutil/trace.go:171","msg":"trace[1095692316] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15737; }","duration":"318.582977ms","start":"2026-08-25T19:41:53.127531Z","end":"2026-08-25T19:41:53.446114Z","steps":["trace[1095692316] 'agreement among raft nodes before linearized reading'  (duration: 318.540826ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:41:53.446141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:41:53.127522Z","time spent":"318.613548ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "}
{"level":"warn","ts":"2026-08-25T19:41:53.446175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:41:53.123618Z","time spent":"322.477252ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-08-25T19:41:53.446212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.656911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-08-25T19:41:53.446316Z","caller":"traceutil/trace.go:171","msg":"trace[539587370] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15737; }","duration":"287.810035ms","start":"2026-08-25T19:41:53.158492Z","end":"2026-08-25T19:41:53.446302Z","steps":["trace[539587370] 'agreement among raft nodes before linearized reading'  (duration: 287.57861ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:41:53.445815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.884302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-25T19:41:53.446387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.117709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:41:53.446391Z","caller":"traceutil/trace.go:171","msg":"trace[1612073040] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15737; }","duration":"334.497625ms","start":"2026-08-25T19:41:53.111882Z","end":"2026-08-25T19:41:53.44638Z","steps":["trace[1612073040] 'agreement among raft nodes before linearized reading'  (duration: 333.731678ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:41:53.446415Z","caller":"traceutil/trace.go:171","msg":"trace[265382790] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15737; }","duration":"286.216552ms","start":"2026-08-25T19:41:53.16019Z","end":"2026-08-25T19:41:53.446407Z","steps":["trace[265382790] 'agreement among raft nodes before linearized reading'  (duration: 286.182261ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:41:53.446434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:41:53.111869Z","time spent":"334.552827ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-25T19:41:53.446351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.722244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:41:53.44662Z","caller":"traceutil/trace.go:171","msg":"trace[98498392] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15737; }","duration":"320.01553ms","start":"2026-08-25T19:41:53.126593Z","end":"2026-08-25T19:41:53.446608Z","steps":["trace[98498392] 'agreement among raft nodes before linearized reading'  (duration: 319.734423ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:41:53.446655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:41:53.126579Z","time spent":"320.065891ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "}
{"level":"info","ts":"2026-08-25T19:45:15.650786Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14731}
{"level":"info","ts":"2026-08-25T19:45:15.727085Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14731,"took":"70.53219ms","hash":2953562307,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":33738752,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-25T19:45:15.727146Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2953562307,"revision":14731,"compact-revision":12696}
{"level":"info","ts":"2026-08-25T19:46:27.871906Z","caller":"traceutil/trace.go:171","msg":"trace[718095854] linearizableReadLoop","detail":"{readStateIndex:18380; appliedIndex:18379; }","duration":"111.348656ms","start":"2026-08-25T19:46:27.760532Z","end":"2026-08-25T19:46:27.87188Z","steps":["trace[718095854] 'read index received'  (duration: 111.120122ms)","trace[718095854] 'applied index is now lower than readState.Index'  (duration: 227.424µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:46:27.872028Z","caller":"traceutil/trace.go:171","msg":"trace[2070472409] transaction","detail":"{read_only:false; response_revision:17770; number_of_response:1; }","duration":"112.226466ms","start":"2026-08-25T19:46:27.759769Z","end":"2026-08-25T19:46:27.871996Z","steps":["trace[2070472409] 'process raft request'  (duration: 111.93048ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:46:27.873016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.45172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:92 size:920150"}
{"level":"info","ts":"2026-08-25T19:46:27.873124Z","caller":"traceutil/trace.go:171","msg":"trace[2014974190] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:92; response_revision:17770; }","duration":"112.587624ms","start":"2026-08-25T19:46:27.760516Z","end":"2026-08-25T19:46:27.873104Z","steps":["trace[2014974190] 'agreement among raft nodes before linearized reading'  (duration: 111.49275ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:46:53.858989Z","caller":"traceutil/trace.go:171","msg":"trace[894926080] transaction","detail":"{read_only:false; response_revision:17940; number_of_response:1; }","duration":"124.225917ms","start":"2026-08-25T19:46:53.7347Z","end":"2026-08-25T19:46:53.858926Z","steps":["trace[894926080] 'process raft request'  (duration: 123.44025ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:46:54.911231Z","caller":"traceutil/trace.go:171","msg":"trace[1880818911] transaction","detail":"{read_only:false; response_revision:17943; number_of_response:1; }","duration":"173.195365ms","start":"2026-08-25T19:46:54.738009Z","end":"2026-08-25T19:46:54.911205Z","steps":["trace[1880818911] 'process raft request'  (duration: 100.115732ms)","trace[1880818911] 'compare'  (duration: 72.545341ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:46:54.912079Z","caller":"traceutil/trace.go:171","msg":"trace[1323713049] transaction","detail":"{read_only:false; response_revision:17944; number_of_response:1; }","duration":"165.931886ms","start":"2026-08-25T19:46:54.746118Z","end":"2026-08-25T19:46:54.91205Z","steps":["trace[1323713049] 'process raft request'  (duration: 165.790483ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:46:54.912416Z","caller":"traceutil/trace.go:171","msg":"trace[597531650] linearizableReadLoop","detail":"{readStateIndex:18561; appliedIndex:18558; }","duration":"165.035807ms","start":"2026-08-25T19:46:54.747329Z","end":"2026-08-25T19:46:54.912365Z","steps":["trace[597531650] 'read index received'  (duration: 90.83978ms)","trace[597531650] 'applied index is now lower than readState.Index'  (duration: 74.194107ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:46:54.912654Z","caller":"traceutil/trace.go:171","msg":"trace[1257372455] transaction","detail":"{read_only:false; response_revision:17945; number_of_response:1; }","duration":"165.408485ms","start":"2026-08-25T19:46:54.747225Z","end":"2026-08-25T19:46:54.912634Z","steps":["trace[1257372455] 'process raft request'  (duration: 164.781332ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:46:54.912838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.481176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-25T19:46:54.912904Z","caller":"traceutil/trace.go:171","msg":"trace[1227027272] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:17945; }","duration":"165.559578ms","start":"2026-08-25T19:46:54.747325Z","end":"2026-08-25T19:46:54.912884Z","steps":["trace[1227027272] 'agreement among raft nodes before linearized reading'  (duration: 165.428425ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:46:55.310585Z","caller":"traceutil/trace.go:171","msg":"trace[761334174] transaction","detail":"{read_only:false; response_revision:17949; number_of_response:1; }","duration":"150.281715ms","start":"2026-08-25T19:46:55.16028Z","end":"2026-08-25T19:46:55.310562Z","steps":["trace[761334174] 'process raft request'  (duration: 115.238951ms)","trace[761334174] 'compare'  (duration: 34.939521ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:46:59.463246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4078185634971208964,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-25T19:46:59.82397Z","caller":"traceutil/trace.go:171","msg":"trace[1318282770] transaction","detail":"{read_only:false; response_revision:17964; number_of_response:1; }","duration":"897.587624ms","start":"2026-08-25T19:46:58.926289Z","end":"2026-08-25T19:46:59.823877Z","steps":["trace[1318282770] 'process raft request'  (duration: 897.44261ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:46:59.824473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:58.926267Z","time spent":"897.82584ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17954 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-25T19:47:00.090939Z","caller":"traceutil/trace.go:171","msg":"trace[1181459466] linearizableReadLoop","detail":"{readStateIndex:18583; appliedIndex:18580; }","duration":"1.127731941s","start":"2026-08-25T19:46:58.963186Z","end":"2026-08-25T19:47:00.090918Z","steps":["trace[1181459466] 'read index received'  (duration: 860.502956ms)","trace[1181459466] 'applied index is now lower than readState.Index'  (duration: 267.227905ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:47:00.091182Z","caller":"traceutil/trace.go:171","msg":"trace[225889151] transaction","detail":"{read_only:false; response_revision:17965; number_of_response:1; }","duration":"1.160920663s","start":"2026-08-25T19:46:58.930248Z","end":"2026-08-25T19:47:00.091169Z","steps":["trace[225889151] 'process raft request'  (duration: 1.093662407s)","trace[225889151] 'compare'  (duration: 66.790436ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:00.09127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:58.930233Z","time spent":"1.160981785s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:17956 > 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-08-25T19:47:00.0914Z","caller":"traceutil/trace.go:171","msg":"trace[1936560473] transaction","detail":"{read_only:false; response_revision:17966; number_of_response:1; }","duration":"1.158999311s","start":"2026-08-25T19:46:58.932393Z","end":"2026-08-25T19:47:00.091392Z","steps":["trace[1936560473] 'process raft request'  (duration: 1.15848061s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.091437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:58.932385Z","time spent":"1.159033252s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:17955 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:00.091597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128411036s","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-08-25T19:47:00.091639Z","caller":"traceutil/trace.go:171","msg":"trace[978928842] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17966; }","duration":"1.128488307s","start":"2026-08-25T19:46:58.963144Z","end":"2026-08-25T19:47:00.091632Z","steps":["trace[978928842] 'agreement among raft nodes before linearized reading'  (duration: 1.128366914s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.091689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:58.963104Z","time spent":"1.128579189s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-25T19:47:00.091827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.155249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-25T19:47:00.091851Z","caller":"traceutil/trace.go:171","msg":"trace[1515265234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17966; }","duration":"938.24304ms","start":"2026-08-25T19:46:59.153602Z","end":"2026-08-25T19:47:00.091845Z","steps":["trace[1515265234] 'agreement among raft nodes before linearized reading'  (duration: 938.181559ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.091869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.153575Z","time spent":"938.289671ms","remote":"127.0.0.1:44608","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":"warn","ts":"2026-08-25T19:47:00.092347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.273192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:1 size:12626"}
{"level":"info","ts":"2026-08-25T19:47:00.092375Z","caller":"traceutil/trace.go:171","msg":"trace[354819431] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:1; response_revision:17966; }","duration":"131.318902ms","start":"2026-08-25T19:46:59.961049Z","end":"2026-08-25T19:47:00.092368Z","steps":["trace[354819431] 'agreement among raft nodes before linearized reading'  (duration: 131.255441ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.092484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.878671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:00.092507Z","caller":"traceutil/trace.go:171","msg":"trace[1725405221] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:17966; }","duration":"140.939851ms","start":"2026-08-25T19:46:59.951561Z","end":"2026-08-25T19:47:00.092501Z","steps":["trace[1725405221] 'agreement among raft nodes before linearized reading'  (duration: 140.90711ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.092591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.800023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:00.092615Z","caller":"traceutil/trace.go:171","msg":"trace[2132925445] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:17966; }","duration":"170.841893ms","start":"2026-08-25T19:46:59.921768Z","end":"2026-08-25T19:47:00.09261Z","steps":["trace[2132925445] 'agreement among raft nodes before linearized reading'  (duration: 170.804303ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.092711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.811272ms","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-08-25T19:47:00.092737Z","caller":"traceutil/trace.go:171","msg":"trace[1705789213] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17966; }","duration":"198.856943ms","start":"2026-08-25T19:46:59.893873Z","end":"2026-08-25T19:47:00.09273Z","steps":["trace[1705789213] 'agreement among raft nodes before linearized reading'  (duration: 198.814562ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.092863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.93741ms","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-08-25T19:47:00.092887Z","caller":"traceutil/trace.go:171","msg":"trace[1114155273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17966; }","duration":"200.97342ms","start":"2026-08-25T19:46:59.891906Z","end":"2026-08-25T19:47:00.092879Z","steps":["trace[1114155273] 'agreement among raft nodes before linearized reading'  (duration: 200.918429ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.092994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.615096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:1 size:12626"}
{"level":"info","ts":"2026-08-25T19:47:00.093017Z","caller":"traceutil/trace.go:171","msg":"trace[90637393] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:1; response_revision:17966; }","duration":"213.670638ms","start":"2026-08-25T19:46:59.87934Z","end":"2026-08-25T19:47:00.09301Z","steps":["trace[90637393] 'agreement among raft nodes before linearized reading'  (duration: 213.616157ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.093129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.498768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:00.093151Z","caller":"traceutil/trace.go:171","msg":"trace[145349933] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17966; }","duration":"483.57798ms","start":"2026-08-25T19:46:59.609567Z","end":"2026-08-25T19:47:00.093145Z","steps":["trace[145349933] 'agreement among raft nodes before linearized reading'  (duration: 483.521429ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.093172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.609529Z","time spent":"483.638291ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:00.093295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.726102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:00.093317Z","caller":"traceutil/trace.go:171","msg":"trace[684844864] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17966; }","duration":"599.749912ms","start":"2026-08-25T19:46:59.493562Z","end":"2026-08-25T19:47:00.093312Z","steps":["trace[684844864] 'agreement among raft nodes before linearized reading'  (duration: 599.696141ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.093338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.493543Z","time spent":"599.790323ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:00.093489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.15457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-pcjnq\" ","response":"range_response_count:1 size:20639"}
{"level":"info","ts":"2026-08-25T19:47:00.093514Z","caller":"traceutil/trace.go:171","msg":"trace[1382193536] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-pcjnq; range_end:; response_count:1; response_revision:17966; }","duration":"644.182291ms","start":"2026-08-25T19:46:59.449326Z","end":"2026-08-25T19:47:00.093508Z","steps":["trace[1382193536] 'agreement among raft nodes before linearized reading'  (duration: 644.116499ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.093539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.449214Z","time spent":"644.320723ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20662,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-pcjnq\" "}
{"level":"warn","ts":"2026-08-25T19:47:00.093819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.736691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:00.093846Z","caller":"traceutil/trace.go:171","msg":"trace[972719811] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17966; }","duration":"682.806483ms","start":"2026-08-25T19:46:59.411034Z","end":"2026-08-25T19:47:00.09384Z","steps":["trace[972719811] 'agreement among raft nodes before linearized reading'  (duration: 682.594668ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.093865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.411013Z","time spent":"682.847204ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:00.094186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.695792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:00.094281Z","caller":"traceutil/trace.go:171","msg":"trace[647348093] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17966; }","duration":"683.862016ms","start":"2026-08-25T19:46:59.410393Z","end":"2026-08-25T19:47:00.094255Z","steps":["trace[647348093] 'agreement among raft nodes before linearized reading'  (duration: 683.556689ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.094339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.444514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-08-25T19:47:00.094356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.410371Z","time spent":"683.972857ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"info","ts":"2026-08-25T19:47:00.094399Z","caller":"traceutil/trace.go:171","msg":"trace[1816105913] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:17966; }","duration":"821.551376ms","start":"2026-08-25T19:46:59.272832Z","end":"2026-08-25T19:47:00.094383Z","steps":["trace[1816105913] 'agreement among raft nodes before linearized reading'  (duration: 821.424474ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.094435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.272814Z","time spent":"821.615027ms","remote":"127.0.0.1:35376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":2,"response size":31,"request content":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:00.094569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.495997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:00.094608Z","caller":"traceutil/trace.go:171","msg":"trace[1359784619] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17966; }","duration":"934.568739ms","start":"2026-08-25T19:46:59.160025Z","end":"2026-08-25T19:47:00.094594Z","steps":["trace[1359784619] 'agreement among raft nodes before linearized reading'  (duration: 934.507368ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.094651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.263229ms","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-08-25T19:47:00.094654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.160004Z","time spent":"934.640991ms","remote":"127.0.0.1:44330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-25T19:47:00.094669Z","caller":"traceutil/trace.go:171","msg":"trace[999683060] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17966; }","duration":"759.32015ms","start":"2026-08-25T19:46:59.335343Z","end":"2026-08-25T19:47:00.094663Z","steps":["trace[999683060] 'agreement among raft nodes before linearized reading'  (duration: 759.229248ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.094687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:46:59.335321Z","time spent":"759.360011ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-25T19:47:00.599187Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4078185634971208969,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-25T19:47:00.847573Z","caller":"traceutil/trace.go:171","msg":"trace[1688162971] transaction","detail":"{read_only:false; response_revision:17967; number_of_response:1; }","duration":"749.366634ms","start":"2026-08-25T19:47:00.098165Z","end":"2026-08-25T19:47:00.847532Z","steps":["trace[1688162971] 'process raft request'  (duration: 749.028747ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:00.847802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.098141Z","time spent":"749.539548ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:17919 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-08-25T19:47:01.565596Z","caller":"traceutil/trace.go:171","msg":"trace[1879621002] transaction","detail":"{read_only:false; response_revision:17969; number_of_response:1; }","duration":"1.466408521s","start":"2026-08-25T19:47:00.099167Z","end":"2026-08-25T19:47:01.565576Z","steps":["trace[1879621002] 'process raft request'  (duration: 1.46635723s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.56574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.099149Z","time spent":"1.466524783s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:17961 > 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":"info","ts":"2026-08-25T19:47:01.565704Z","caller":"traceutil/trace.go:171","msg":"trace[311961612] transaction","detail":"{read_only:false; response_revision:17968; number_of_response:1; }","duration":"1.466645356s","start":"2026-08-25T19:47:00.098981Z","end":"2026-08-25T19:47:01.565626Z","steps":["trace[311961612] 'process raft request'  (duration: 1.466402521s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.565946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.098959Z","time spent":"1.466862412s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:17959 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-25T19:47:01.566171Z","caller":"traceutil/trace.go:171","msg":"trace[451091892] transaction","detail":"{read_only:false; response_revision:17970; number_of_response:1; }","duration":"1.466922122s","start":"2026-08-25T19:47:00.099217Z","end":"2026-08-25T19:47:01.566139Z","steps":["trace[451091892] 'process raft request'  (duration: 1.46633304s)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:01.566276Z","caller":"traceutil/trace.go:171","msg":"trace[105480221] transaction","detail":"{read_only:false; response_revision:17971; number_of_response:1; }","duration":"1.466587265s","start":"2026-08-25T19:47:00.099617Z","end":"2026-08-25T19:47:01.566205Z","steps":["trace[105480221] 'process raft request'  (duration: 1.466226507s)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:01.566407Z","caller":"traceutil/trace.go:171","msg":"trace[762248174] transaction","detail":"{read_only:false; response_revision:17973; number_of_response:1; }","duration":"852.775788ms","start":"2026-08-25T19:47:00.713618Z","end":"2026-08-25T19:47:01.566394Z","steps":["trace[762248174] 'process raft request'  (duration: 852.714547ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:01.56642Z","caller":"traceutil/trace.go:171","msg":"trace[328649573] transaction","detail":"{read_only:false; response_revision:17972; number_of_response:1; }","duration":"1.464760566s","start":"2026-08-25T19:47:00.101632Z","end":"2026-08-25T19:47:01.566392Z","steps":["trace[328649573] 'process raft request'  (duration: 1.464486019s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.566467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.713594Z","time spent":"852.843059ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:17963 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:01.566508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.101621Z","time spent":"1.464839377s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:17957 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:01.566498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.099192Z","time spent":"1.467048966s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:17958 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:01.566543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.099607Z","time spent":"1.466782151s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:17960 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-25T19:47:01.566617Z","caller":"traceutil/trace.go:171","msg":"trace[420633329] linearizableReadLoop","detail":"{readStateIndex:18589; appliedIndex:18583; }","duration":"1.467493675s","start":"2026-08-25T19:47:00.099113Z","end":"2026-08-25T19:47:01.566607Z","steps":["trace[420633329] 'read index received'  (duration: 748.086945ms)","trace[420633329] 'applied index is now lower than readState.Index'  (duration: 719.40504ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:01.566779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.721054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-dhcp-agent-default-9r5mc\" ","response":"range_response_count:1 size:18643"}
{"level":"info","ts":"2026-08-25T19:47:01.566803Z","caller":"traceutil/trace.go:171","msg":"trace[2021118276] range","detail":"{range_begin:/registry/pods/openstack/neutron-dhcp-agent-default-9r5mc; range_end:; response_count:1; response_revision:17973; }","duration":"862.781876ms","start":"2026-08-25T19:47:00.704016Z","end":"2026-08-25T19:47:01.566798Z","steps":["trace[2021118276] 'agreement among raft nodes before linearized reading'  (duration: 862.697054ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.566818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.703985Z","time spent":"862.830056ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":18666,"request content":"key:\"/registry/pods/openstack/neutron-dhcp-agent-default-9r5mc\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.566937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.951738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-l3-agent-default-8k59f\" ","response":"range_response_count:1 size:18668"}
{"level":"warn","ts":"2026-08-25T19:47:01.566955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.536794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"}
{"level":"info","ts":"2026-08-25T19:47:01.566971Z","caller":"traceutil/trace.go:171","msg":"trace[13041492] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17973; }","duration":"252.595395ms","start":"2026-08-25T19:47:01.314371Z","end":"2026-08-25T19:47:01.566966Z","steps":["trace[13041492] 'agreement among raft nodes before linearized reading'  (duration: 252.545434ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:01.566971Z","caller":"traceutil/trace.go:171","msg":"trace[454356398] range","detail":"{range_begin:/registry/pods/openstack/neutron-l3-agent-default-8k59f; range_end:; response_count:1; response_revision:17973; }","duration":"863.01847ms","start":"2026-08-25T19:47:00.703943Z","end":"2026-08-25T19:47:01.566962Z","steps":["trace[454356398] 'agreement among raft nodes before linearized reading'  (duration: 862.813626ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.56693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.261880295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-b7ncc\" ","response":"range_response_count:1 size:22097"}
{"level":"info","ts":"2026-08-25T19:47:01.567024Z","caller":"traceutil/trace.go:171","msg":"trace[904694765] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-b7ncc; range_end:; response_count:1; response_revision:17973; }","duration":"1.262008417s","start":"2026-08-25T19:47:00.304994Z","end":"2026-08-25T19:47:01.567002Z","steps":["trace[904694765] 'agreement among raft nodes before linearized reading'  (duration: 1.261760372s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.56705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.703926Z","time spent":"863.117443ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":18691,"request content":"key:\"/registry/pods/openstack/neutron-l3-agent-default-8k59f\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.567296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.237147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:24 size:217467"}
{"level":"info","ts":"2026-08-25T19:47:01.567347Z","caller":"traceutil/trace.go:171","msg":"trace[95394984] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:24; response_revision:17973; }","duration":"318.331279ms","start":"2026-08-25T19:47:01.249007Z","end":"2026-08-25T19:47:01.567338Z","steps":["trace[95394984] 'agreement among raft nodes before linearized reading'  (duration: 318.020982ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.567372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:01.248986Z","time spent":"318.37905ms","remote":"127.0.0.1:44784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":24,"response size":217490,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.5674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.805907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-br9kg\" ","response":"range_response_count:1 size:14274"}
{"level":"info","ts":"2026-08-25T19:47:01.567485Z","caller":"traceutil/trace.go:171","msg":"trace[810781739] range","detail":"{range_begin:/registry/pods/openstack/neutron-metadata-agent-default-br9kg; range_end:; response_count:1; response_revision:17973; }","duration":"835.919349ms","start":"2026-08-25T19:47:00.731549Z","end":"2026-08-25T19:47:01.567468Z","steps":["trace[810781739] 'agreement among raft nodes before linearized reading'  (duration: 835.666623ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.567492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468372784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"warn","ts":"2026-08-25T19:47:01.567523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.73153Z","time spent":"835.985111ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":14297,"request content":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-br9kg\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.567439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.287624566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-vgzkg\" ","response":"range_response_count:1 size:9791"}
{"level":"info","ts":"2026-08-25T19:47:01.56754Z","caller":"traceutil/trace.go:171","msg":"trace[908617289] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17973; }","duration":"1.468435406s","start":"2026-08-25T19:47:00.09909Z","end":"2026-08-25T19:47:01.567525Z","steps":["trace[908617289] 'agreement among raft nodes before linearized reading'  (duration: 1.467571118s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.56758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.099083Z","time spent":"1.468485387s","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-08-25T19:47:01.567565Z","caller":"traceutil/trace.go:171","msg":"trace[243818583] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-vgzkg; range_end:; response_count:1; response_revision:17973; }","duration":"1.28783784s","start":"2026-08-25T19:47:00.279711Z","end":"2026-08-25T19:47:01.567549Z","steps":["trace[243818583] 'agreement among raft nodes before linearized reading'  (duration: 1.287473372s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.567656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.249726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:01.567681Z","caller":"traceutil/trace.go:171","msg":"trace[573316706] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:17973; }","duration":"607.337187ms","start":"2026-08-25T19:47:00.960336Z","end":"2026-08-25T19:47:01.567674Z","steps":["trace[573316706] 'agreement among raft nodes before linearized reading'  (duration: 607.286366ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.567709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.960299Z","time spent":"607.405299ms","remote":"127.0.0.1:44726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:01.567735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.279693Z","time spent":"1.287968273s","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9814,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-vgzkg\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.567882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106324344s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-08-25T19:47:01.567916Z","caller":"traceutil/trace.go:171","msg":"trace[1021425777] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:17973; }","duration":"1.106394205s","start":"2026-08-25T19:47:00.461515Z","end":"2026-08-25T19:47:01.567909Z","steps":["trace[1021425777] 'agreement among raft nodes before linearized reading'  (duration: 1.106275503s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.567938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.461495Z","time spent":"1.106436306s","remote":"127.0.0.1:44670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":138,"response size":32,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:01.567889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.45496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:01.567978Z","caller":"traceutil/trace.go:171","msg":"trace[1759386952] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17973; }","duration":"640.589283ms","start":"2026-08-25T19:47:00.927379Z","end":"2026-08-25T19:47:01.567968Z","steps":["trace[1759386952] 'agreement among raft nodes before linearized reading'  (duration: 640.44571ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.568015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.927354Z","time spent":"640.652593ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.567083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.304983Z","time spent":"1.262090449s","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22120,"request content":"key:\"/registry/pods/openstack/nova-compute-default-b7ncc\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.569879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.467204319s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:01.570072Z","caller":"traceutil/trace.go:171","msg":"trace[746415076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17973; }","duration":"1.470509841s","start":"2026-08-25T19:47:00.09949Z","end":"2026-08-25T19:47:01.57Z","steps":["trace[746415076] 'agreement among raft nodes before linearized reading'  (duration: 1.467188569s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.570132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.099445Z","time spent":"1.470667425s","remote":"127.0.0.1:44342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.571196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.469294544s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:01.571265Z","caller":"traceutil/trace.go:171","msg":"trace[1572076155] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17973; }","duration":"1.469406657s","start":"2026-08-25T19:47:00.101839Z","end":"2026-08-25T19:47:01.571245Z","steps":["trace[1572076155] 'agreement among raft nodes before linearized reading'  (duration: 1.46537894s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.571322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.101833Z","time spent":"1.469475058s","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:01.574332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470157384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:01.574422Z","caller":"traceutil/trace.go:171","msg":"trace[1712568038] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17973; }","duration":"1.470577052s","start":"2026-08-25T19:47:00.103807Z","end":"2026-08-25T19:47:01.574384Z","steps":["trace[1712568038] 'agreement among raft nodes before linearized reading'  (duration: 1.463173831s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:01.574598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:00.103799Z","time spent":"1.470773877s","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:02.278333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.792097ms","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-08-25T19:47:02.278484Z","caller":"traceutil/trace.go:171","msg":"trace[560530022] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:17973; }","duration":"635.046962ms","start":"2026-08-25T19:47:01.643406Z","end":"2026-08-25T19:47:02.278453Z","steps":["trace[560530022] 'range keys from in-memory index tree'  (duration: 634.599972ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:02.278551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:01.643386Z","time spent":"635.153954ms","remote":"127.0.0.1:44784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-08-25T19:47:02.278753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.511454ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971208988 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17964 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-25T19:47:02.279119Z","caller":"traceutil/trace.go:171","msg":"trace[1360047015] transaction","detail":"{read_only:false; response_revision:17975; number_of_response:1; }","duration":"178.869219ms","start":"2026-08-25T19:47:02.100231Z","end":"2026-08-25T19:47:02.2791Z","steps":["trace[1360047015] 'process raft request'  (duration: 178.789247ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:02.279164Z","caller":"traceutil/trace.go:171","msg":"trace[945556567] linearizableReadLoop","detail":"{readStateIndex:18591; appliedIndex:18590; }","duration":"179.400301ms","start":"2026-08-25T19:47:02.099741Z","end":"2026-08-25T19:47:02.279142Z","steps":["trace[945556567] 'read index received'  (duration: 35.671µs)","trace[945556567] 'applied index is now lower than readState.Index'  (duration: 179.36229ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:02.279349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.583114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:02.279398Z","caller":"traceutil/trace.go:171","msg":"trace[1538416606] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:17975; }","duration":"179.675486ms","start":"2026-08-25T19:47:02.099706Z","end":"2026-08-25T19:47:02.279382Z","steps":["trace[1538416606] 'agreement among raft nodes before linearized reading'  (duration: 179.567093ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:02.279913Z","caller":"traceutil/trace.go:171","msg":"trace[1503276035] transaction","detail":"{read_only:false; response_revision:17974; number_of_response:1; }","duration":"449.035777ms","start":"2026-08-25T19:47:01.82997Z","end":"2026-08-25T19:47:02.279006Z","steps":["trace[1503276035] 'process raft request'  (duration: 146.152535ms)","trace[1503276035] 'compare'  (duration: 302.116145ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:02.280133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:01.829915Z","time spent":"450.099829ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17964 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-25T19:47:02.355417Z","caller":"traceutil/trace.go:171","msg":"trace[962641110] transaction","detail":"{read_only:false; response_revision:17976; number_of_response:1; }","duration":"254.19545ms","start":"2026-08-25T19:47:02.101188Z","end":"2026-08-25T19:47:02.355384Z","steps":["trace[962641110] 'process raft request'  (duration: 254.016716ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.039369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.785853ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971208991 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:17895 > 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-08-25T19:47:03.039635Z","caller":"traceutil/trace.go:171","msg":"trace[588789217] linearizableReadLoop","detail":"{readStateIndex:18594; appliedIndex:18592; }","duration":"760.365722ms","start":"2026-08-25T19:47:02.279242Z","end":"2026-08-25T19:47:03.039608Z","steps":["trace[588789217] 'read index received'  (duration: 76.002996ms)","trace[588789217] 'applied index is now lower than readState.Index'  (duration: 684.361376ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:03.039772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.43008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"warn","ts":"2026-08-25T19:47:03.039823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.801189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:03.03985Z","caller":"traceutil/trace.go:171","msg":"trace[220834931] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17977; }","duration":"936.535923ms","start":"2026-08-25T19:47:02.103295Z","end":"2026-08-25T19:47:03.039831Z","steps":["trace[220834931] 'agreement among raft nodes before linearized reading'  (duration: 936.346608ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:03.039858Z","caller":"traceutil/trace.go:171","msg":"trace[1558681534] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:17977; }","duration":"936.86121ms","start":"2026-08-25T19:47:02.102986Z","end":"2026-08-25T19:47:03.039847Z","steps":["trace[1558681534] 'agreement among raft nodes before linearized reading'  (duration: 936.782678ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.039884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.103286Z","time spent":"936.592064ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:03.039885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.709333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:03.039942Z","caller":"traceutil/trace.go:171","msg":"trace[2126675076] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17977; }","duration":"939.800354ms","start":"2026-08-25T19:47:02.100123Z","end":"2026-08-25T19:47:03.039923Z","steps":["trace[2126675076] 'agreement among raft nodes before linearized reading'  (duration: 939.557418ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.039973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.102974Z","time spent":"936.991603ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-ks-user\" "}
{"level":"warn","ts":"2026-08-25T19:47:03.039995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.100102Z","time spent":"939.882646ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:03.040062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.738806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-25T19:47:03.040035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.925797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"warn","ts":"2026-08-25T19:47:03.040114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.425001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:1 size:12626"}
{"level":"info","ts":"2026-08-25T19:47:03.04006Z","caller":"traceutil/trace.go:171","msg":"trace[1019335272] transaction","detail":"{read_only:false; response_revision:17977; number_of_response:1; }","duration":"806.536259ms","start":"2026-08-25T19:47:02.233484Z","end":"2026-08-25T19:47:03.04002Z","steps":["trace[1019335272] 'process raft request'  (duration: 338.955938ms)","trace[1019335272] 'compare'  (duration: 466.248261ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:03.04009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.045685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:03.04012Z","caller":"traceutil/trace.go:171","msg":"trace[625099528] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:17977; }","duration":"757.89924ms","start":"2026-08-25T19:47:02.282211Z","end":"2026-08-25T19:47:03.04011Z","steps":["trace[625099528] 'agreement among raft nodes before linearized reading'  (duration: 757.596753ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.040155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.942835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:03.040185Z","caller":"traceutil/trace.go:171","msg":"trace[1642379348] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17977; }","duration":"940.06833ms","start":"2026-08-25T19:47:02.10007Z","end":"2026-08-25T19:47:03.040138Z","steps":["trace[1642379348] 'agreement among raft nodes before linearized reading'  (duration: 939.68788ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:03.04025Z","caller":"traceutil/trace.go:171","msg":"trace[2836833] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:17977; }","duration":"549.105709ms","start":"2026-08-25T19:47:02.491121Z","end":"2026-08-25T19:47:03.040227Z","steps":["trace[2836833] 'agreement among raft nodes before linearized reading'  (duration: 548.939305ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.040278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.100063Z","time spent":"940.203553ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:03.040308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.491082Z","time spent":"549.210981ms","remote":"127.0.0.1:50470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:03.040327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.233454Z","time spent":"806.714133ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" mod_revision:17895 > 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\" > >"}
{"level":"info","ts":"2026-08-25T19:47:03.040188Z","caller":"traceutil/trace.go:171","msg":"trace[1602404357] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:17977; }","duration":"932.180138ms","start":"2026-08-25T19:47:02.107987Z","end":"2026-08-25T19:47:03.040167Z","steps":["trace[1602404357] 'agreement among raft nodes before linearized reading'  (duration: 931.997994ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.040412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.052096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" ","response":"range_response_count:1 size:12626"}
{"level":"info","ts":"2026-08-25T19:47:03.040145Z","caller":"traceutil/trace.go:171","msg":"trace[200796154] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:1; response_revision:17977; }","duration":"936.453732ms","start":"2026-08-25T19:47:02.103682Z","end":"2026-08-25T19:47:03.040136Z","steps":["trace[200796154] 'agreement among raft nodes before linearized reading'  (duration: 936.36066ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.040589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.103663Z","time spent":"936.917151ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12649,"request content":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" "}
{"level":"warn","ts":"2026-08-25T19:47:03.040277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.28219Z","time spent":"758.020132ms","remote":"127.0.0.1:44518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-08-25T19:47:03.040509Z","caller":"traceutil/trace.go:171","msg":"trace[456492890] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-endpoints; range_end:; response_count:1; response_revision:17977; }","duration":"938.214089ms","start":"2026-08-25T19:47:02.102273Z","end":"2026-08-25T19:47:03.040487Z","steps":["trace[456492890] 'agreement among raft nodes before linearized reading'  (duration: 937.39464ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.040735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.102246Z","time spent":"938.465985ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12649,"request content":"key:\"/registry/jobs/openstack/neutron-ks-endpoints\" "}
{"level":"warn","ts":"2026-08-25T19:47:03.040485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.10798Z","time spent":"932.430253ms","remote":"127.0.0.1:49640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:03.04167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.789717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:03.041739Z","caller":"traceutil/trace.go:171","msg":"trace[882215756] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17977; }","duration":"941.89419ms","start":"2026-08-25T19:47:02.099828Z","end":"2026-08-25T19:47:03.041722Z","steps":["trace[882215756] 'agreement among raft nodes before linearized reading'  (duration: 939.988999ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.041783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:02.099825Z","time spent":"941.949691ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:03.72543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.917742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:03.72553Z","caller":"traceutil/trace.go:171","msg":"trace[835175767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17977; }","duration":"565.071285ms","start":"2026-08-25T19:47:03.160433Z","end":"2026-08-25T19:47:03.725504Z","steps":["trace[835175767] 'range keys from in-memory index tree'  (duration: 564.835241ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:03.725586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.160413Z","time spent":"565.161068ms","remote":"127.0.0.1:44330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-25T19:47:03.726194Z","caller":"traceutil/trace.go:171","msg":"trace[981673096] linearizableReadLoop","detail":"{readStateIndex:18595; appliedIndex:18594; }","duration":"153.953946ms","start":"2026-08-25T19:47:03.572222Z","end":"2026-08-25T19:47:03.726176Z","steps":["trace[981673096] 'read index received'  (duration: 63.897542ms)","trace[981673096] 'applied index is now lower than readState.Index'  (duration: 90.055194ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:47:03.726213Z","caller":"traceutil/trace.go:171","msg":"trace[491895901] transaction","detail":"{read_only:false; response_revision:17978; number_of_response:1; }","duration":"307.667506ms","start":"2026-08-25T19:47:03.418521Z","end":"2026-08-25T19:47:03.726188Z","steps":["trace[491895901] 'process raft request'  (duration: 217.598242ms)","trace[491895901] 'compare'  (duration: 89.47205ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:03.726326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.418483Z","time spent":"307.773208ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:17951 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:03.726415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.18509ms","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-08-25T19:47:03.72647Z","caller":"traceutil/trace.go:171","msg":"trace[1883546672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17978; }","duration":"154.278873ms","start":"2026-08-25T19:47:03.572176Z","end":"2026-08-25T19:47:03.726455Z","steps":["trace[1883546672] 'agreement among raft nodes before linearized reading'  (duration: 154.115699ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:04.180848Z","caller":"traceutil/trace.go:171","msg":"trace[1259116880] linearizableReadLoop","detail":"{readStateIndex:18596; appliedIndex:18595; }","duration":"454.573458ms","start":"2026-08-25T19:47:03.726245Z","end":"2026-08-25T19:47:04.180818Z","steps":["trace[1259116880] 'read index received'  (duration: 453.779641ms)","trace[1259116880] 'applied index is now lower than readState.Index'  (duration: 792.627µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:04.181145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.283508ms","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-08-25T19:47:04.181153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.165009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:04.181195Z","caller":"traceutil/trace.go:171","msg":"trace[1282714049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17979; }","duration":"608.36976ms","start":"2026-08-25T19:47:03.57281Z","end":"2026-08-25T19:47:04.18118Z","steps":["trace[1282714049] 'agreement among raft nodes before linearized reading'  (duration: 608.203596ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:04.181222Z","caller":"traceutil/trace.go:171","msg":"trace[1799397342] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17979; }","duration":"599.265801ms","start":"2026-08-25T19:47:03.581938Z","end":"2026-08-25T19:47:04.181204Z","steps":["trace[1799397342] 'agreement among raft nodes before linearized reading'  (duration: 598.998855ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.181243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.5728Z","time spent":"608.429401ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-08-25T19:47:04.18126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.581929Z","time spent":"599.322793ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:04.181313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.596313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-vgzkg\" ","response":"range_response_count:1 size:9791"}
{"level":"info","ts":"2026-08-25T19:47:04.181348Z","caller":"traceutil/trace.go:171","msg":"trace[611879354] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-vgzkg; range_end:; response_count:1; response_revision:17979; }","duration":"557.656675ms","start":"2026-08-25T19:47:03.623682Z","end":"2026-08-25T19:47:04.181339Z","steps":["trace[611879354] 'agreement among raft nodes before linearized reading'  (duration: 557.519592ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.181401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.600875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-b7ncc\" ","response":"range_response_count:1 size:22097"}
{"level":"info","ts":"2026-08-25T19:47:04.181486Z","caller":"traceutil/trace.go:171","msg":"trace[128819487] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-b7ncc; range_end:; response_count:1; response_revision:17979; }","duration":"558.704597ms","start":"2026-08-25T19:47:03.622758Z","end":"2026-08-25T19:47:04.181462Z","steps":["trace[128819487] 'agreement among raft nodes before linearized reading'  (duration: 558.457381ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.181529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.622751Z","time spent":"558.769839ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22120,"request content":"key:\"/registry/pods/openstack/nova-compute-default-b7ncc\" "}
{"level":"warn","ts":"2026-08-25T19:47:04.181375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.623672Z","time spent":"557.696516ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9814,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-vgzkg\" "}
{"level":"warn","ts":"2026-08-25T19:47:04.181803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.177539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-l3-agent-default-8k59f\" ","response":"range_response_count:1 size:18668"}
{"level":"info","ts":"2026-08-25T19:47:04.181837Z","caller":"traceutil/trace.go:171","msg":"trace[1414916067] range","detail":"{range_begin:/registry/pods/openstack/neutron-l3-agent-default-8k59f; range_end:; response_count:1; response_revision:17979; }","duration":"565.282872ms","start":"2026-08-25T19:47:03.616544Z","end":"2026-08-25T19:47:04.181827Z","steps":["trace[1414916067] 'agreement among raft nodes before linearized reading'  (duration: 564.901613ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.18182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.868721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-b7ncc\" ","response":"range_response_count:1 size:22097"}
{"level":"warn","ts":"2026-08-25T19:47:04.181864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.616479Z","time spent":"565.376623ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":18691,"request content":"key:\"/registry/pods/openstack/neutron-l3-agent-default-8k59f\" "}
{"level":"info","ts":"2026-08-25T19:47:04.181894Z","caller":"traceutil/trace.go:171","msg":"trace[1993221891] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-b7ncc; range_end:; response_count:1; response_revision:17979; }","duration":"559.011664ms","start":"2026-08-25T19:47:03.622865Z","end":"2026-08-25T19:47:04.181877Z","steps":["trace[1993221891] 'agreement among raft nodes before linearized reading'  (duration: 558.538503ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.181809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.33582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fq8n5\" ","response":"range_response_count:1 size:6528"}
{"level":"warn","ts":"2026-08-25T19:47:04.18192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.499474ms","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-08-25T19:47:04.181917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.519546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-pcjnq\" ","response":"range_response_count:1 size:20639"}
{"level":"warn","ts":"2026-08-25T19:47:04.181936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.622837Z","time spent":"559.089656ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22120,"request content":"key:\"/registry/pods/openstack/nova-compute-default-b7ncc\" "}
{"level":"info","ts":"2026-08-25T19:47:04.181947Z","caller":"traceutil/trace.go:171","msg":"trace[1147605942] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fq8n5; range_end:; response_count:1; response_revision:17979; }","duration":"592.525924ms","start":"2026-08-25T19:47:03.589412Z","end":"2026-08-25T19:47:04.181938Z","steps":["trace[1147605942] 'agreement among raft nodes before linearized reading'  (duration: 592.077274ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:04.181949Z","caller":"traceutil/trace.go:171","msg":"trace[1528734568] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17979; }","duration":"609.578846ms","start":"2026-08-25T19:47:03.572361Z","end":"2026-08-25T19:47:04.18194Z","steps":["trace[1528734568] 'agreement among raft nodes before linearized reading'  (duration: 609.496144ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:04.181969Z","caller":"traceutil/trace.go:171","msg":"trace[706718963] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-pcjnq; range_end:; response_count:1; response_revision:17979; }","duration":"565.619488ms","start":"2026-08-25T19:47:03.616338Z","end":"2026-08-25T19:47:04.181957Z","steps":["trace[706718963] 'agreement among raft nodes before linearized reading'  (duration: 565.458095ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.181977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.589386Z","time spent":"592.583736ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6551,"request content":"key:\"/registry/pods/openstack/keepalived-fq8n5\" "}
{"level":"info","ts":"2026-08-25T19:47:04.181937Z","caller":"traceutil/trace.go:171","msg":"trace[1379111523] transaction","detail":"{read_only:false; response_revision:17979; number_of_response:1; }","duration":"609.559526ms","start":"2026-08-25T19:47:03.572365Z","end":"2026-08-25T19:47:04.181924Z","steps":["trace[1379111523] 'process raft request'  (duration: 607.632734ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.182307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.572342Z","time spent":"609.905073ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:17973 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:04.181976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.572336Z","time spent":"609.634307ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-25T19:47:04.181992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.616319Z","time spent":"565.669169ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20662,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-pcjnq\" "}
{"level":"warn","ts":"2026-08-25T19:47:04.18204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.539605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-25T19:47:04.182591Z","caller":"traceutil/trace.go:171","msg":"trace[129942146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17979; }","duration":"610.157739ms","start":"2026-08-25T19:47:03.572415Z","end":"2026-08-25T19:47:04.182573Z","steps":["trace[129942146] 'agreement among raft nodes before linearized reading'  (duration: 609.557956ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.182628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.572386Z","time spent":"610.229519ms","remote":"127.0.0.1:44608","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":"warn","ts":"2026-08-25T19:47:04.182059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.726389ms","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-08-25T19:47:04.182717Z","caller":"traceutil/trace.go:171","msg":"trace[1615844331] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17979; }","duration":"610.411313ms","start":"2026-08-25T19:47:03.572289Z","end":"2026-08-25T19:47:04.182701Z","steps":["trace[1615844331] 'agreement among raft nodes before linearized reading'  (duration: 609.715628ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.182757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.572262Z","time spent":"610.482326ms","remote":"127.0.0.1:44608","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":"warn","ts":"2026-08-25T19:47:04.182083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.848343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-dhcp-agent-default-9r5mc\" ","response":"range_response_count:1 size:18643"}
{"level":"info","ts":"2026-08-25T19:47:04.182835Z","caller":"traceutil/trace.go:171","msg":"trace[455025938] range","detail":"{range_begin:/registry/pods/openstack/neutron-dhcp-agent-default-9r5mc; range_end:; response_count:1; response_revision:17979; }","duration":"560.62105ms","start":"2026-08-25T19:47:03.622205Z","end":"2026-08-25T19:47:04.182826Z","steps":["trace[455025938] 'agreement among raft nodes before linearized reading'  (duration: 559.803631ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.18286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.622197Z","time spent":"560.655712ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":18666,"request content":"key:\"/registry/pods/openstack/neutron-dhcp-agent-default-9r5mc\" "}
{"level":"warn","ts":"2026-08-25T19:47:04.182104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.923614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-br9kg\" ","response":"range_response_count:1 size:14274"}
{"level":"info","ts":"2026-08-25T19:47:04.182938Z","caller":"traceutil/trace.go:171","msg":"trace[1035929815] range","detail":"{range_begin:/registry/pods/openstack/neutron-metadata-agent-default-br9kg; range_end:; response_count:1; response_revision:17979; }","duration":"560.814744ms","start":"2026-08-25T19:47:03.622116Z","end":"2026-08-25T19:47:04.182931Z","steps":["trace[1035929815] 'agreement among raft nodes before linearized reading'  (duration: 558.704928ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:04.182961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.62209Z","time spent":"560.863866ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":14297,"request content":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-br9kg\" "}
{"level":"warn","ts":"2026-08-25T19:47:04.681146Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4078185634971209005,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-25T19:47:05.025538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.705368ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971209002 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:17972 > 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-08-25T19:47:05.026353Z","caller":"traceutil/trace.go:171","msg":"trace[413351204] transaction","detail":"{read_only:false; response_revision:17980; number_of_response:1; }","duration":"1.295433846s","start":"2026-08-25T19:47:03.730869Z","end":"2026-08-25T19:47:05.026303Z","steps":["trace[413351204] 'process raft request'  (duration: 1.18089325s)","trace[413351204] 'compare'  (duration: 113.286078ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:47:05.026646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.730849Z","time spent":"1.29561029s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:17972 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-25T19:47:05.078284Z","caller":"traceutil/trace.go:171","msg":"trace[43424923] transaction","detail":"{read_only:false; response_revision:17983; number_of_response:1; }","duration":"889.858534ms","start":"2026-08-25T19:47:04.188407Z","end":"2026-08-25T19:47:05.078266Z","steps":["trace[43424923] 'process raft request'  (duration: 889.810273ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:05.078312Z","caller":"traceutil/trace.go:171","msg":"trace[877371073] transaction","detail":"{read_only:false; response_revision:17981; number_of_response:1; }","duration":"1.183901414s","start":"2026-08-25T19:47:03.894369Z","end":"2026-08-25T19:47:05.078271Z","steps":["trace[877371073] 'process raft request'  (duration: 1.183517015s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.078703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.894352Z","time spent":"1.184223461s","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:17905 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-08-25T19:47:05.078758Z","caller":"traceutil/trace.go:171","msg":"trace[175915095] linearizableReadLoop","detail":"{readStateIndex:18606; appliedIndex:18596; }","duration":"897.764598ms","start":"2026-08-25T19:47:04.180978Z","end":"2026-08-25T19:47:05.078742Z","steps":["trace[175915095] 'read index received'  (duration: 730.794549ms)","trace[175915095] 'applied index is now lower than readState.Index'  (duration: 166.969079ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:47:05.078772Z","caller":"traceutil/trace.go:171","msg":"trace[386267267] transaction","detail":"{read_only:false; response_revision:17988; number_of_response:1; }","duration":"717.56744ms","start":"2026-08-25T19:47:04.361195Z","end":"2026-08-25T19:47:05.078762Z","steps":["trace[386267267] 'process raft request'  (duration: 717.514409ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.078879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.835088ms","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-08-25T19:47:05.078919Z","caller":"traceutil/trace.go:171","msg":"trace[222479813] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17988; }","duration":"997.91018ms","start":"2026-08-25T19:47:04.080997Z","end":"2026-08-25T19:47:05.078907Z","steps":["trace[222479813] 'agreement among raft nodes before linearized reading'  (duration: 997.839749ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.078954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.080981Z","time spent":"997.963651ms","remote":"127.0.0.1:49816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:05.078992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.36117Z","time spent":"717.626402ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:17976 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:05.078405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.188395Z","time spent":"889.946706ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:17968 > 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-08-25T19:47:05.079166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.028770862s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:05.079198Z","caller":"traceutil/trace.go:171","msg":"trace[813444987] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:17988; }","duration":"1.028850575s","start":"2026-08-25T19:47:04.050338Z","end":"2026-08-25T19:47:05.079189Z","steps":["trace[813444987] 'agreement among raft nodes before linearized reading'  (duration: 1.028795563s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.079235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.050314Z","time spent":"1.028910527s","remote":"127.0.0.1:37642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "}
{"level":"info","ts":"2026-08-25T19:47:05.079231Z","caller":"traceutil/trace.go:171","msg":"trace[1099152539] transaction","detail":"{read_only:false; response_revision:17986; number_of_response:1; }","duration":"794.793844ms","start":"2026-08-25T19:47:04.28443Z","end":"2026-08-25T19:47:05.079224Z","steps":["trace[1099152539] 'process raft request'  (duration: 794.20076ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.07937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.284412Z","time spent":"794.861805ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:17975 > 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-08-25T19:47:05.079406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081153195s","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-08-25T19:47:05.07944Z","caller":"traceutil/trace.go:171","msg":"trace[1286219974] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17988; }","duration":"1.081224326s","start":"2026-08-25T19:47:03.998203Z","end":"2026-08-25T19:47:05.079427Z","steps":["trace[1286219974] 'agreement among raft nodes before linearized reading'  (duration: 1.081172025s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.079475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.998184Z","time spent":"1.081282498s","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"info","ts":"2026-08-25T19:47:05.079619Z","caller":"traceutil/trace.go:171","msg":"trace[1823318837] transaction","detail":"{read_only:false; response_revision:17987; number_of_response:1; }","duration":"795.170532ms","start":"2026-08-25T19:47:04.284436Z","end":"2026-08-25T19:47:05.079606Z","steps":["trace[1823318837] 'process raft request'  (duration: 794.245751ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:05.079202Z","caller":"traceutil/trace.go:171","msg":"trace[458592970] transaction","detail":"{read_only:false; response_revision:17985; number_of_response:1; }","duration":"888.731211ms","start":"2026-08-25T19:47:04.190461Z","end":"2026-08-25T19:47:05.079192Z","steps":["trace[458592970] 'process raft request'  (duration: 887.949774ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.079944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.190449Z","time spent":"889.461327ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:17970 > 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-08-25T19:47:05.078495Z","caller":"traceutil/trace.go:171","msg":"trace[1206427511] transaction","detail":"{read_only:false; response_revision:17982; number_of_response:1; }","duration":"891.380668ms","start":"2026-08-25T19:47:04.18706Z","end":"2026-08-25T19:47:05.07844Z","steps":["trace[1206427511] 'process raft request'  (duration: 891.122573ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.08015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.187041Z","time spent":"893.073266ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:17971 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-25T19:47:05.078475Z","caller":"traceutil/trace.go:171","msg":"trace[1810891061] transaction","detail":"{read_only:false; response_revision:17984; number_of_response:1; }","duration":"888.310772ms","start":"2026-08-25T19:47:04.19015Z","end":"2026-08-25T19:47:05.078461Z","steps":["trace[1810891061] 'process raft request'  (duration: 888.089997ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.080265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.190135Z","time spent":"890.090821ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:17969 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:05.080347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.280594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-25T19:47:05.080415Z","caller":"traceutil/trace.go:171","msg":"trace[121844812] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:17988; }","duration":"678.375245ms","start":"2026-08-25T19:47:04.402026Z","end":"2026-08-25T19:47:05.080402Z","steps":["trace[121844812] 'agreement among raft nodes before linearized reading'  (duration: 678.286963ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.080451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.402009Z","time spent":"678.432297ms","remote":"127.0.0.1:44626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":4,"response size":31,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:05.080838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.371903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-08-25T19:47:05.08085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.160757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:05.080877Z","caller":"traceutil/trace.go:171","msg":"trace[488181] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:17988; }","duration":"482.448775ms","start":"2026-08-25T19:47:04.598417Z","end":"2026-08-25T19:47:05.080866Z","steps":["trace[488181] 'agreement among raft nodes before linearized reading'  (duration: 482.385014ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:05.080901Z","caller":"traceutil/trace.go:171","msg":"trace[557288788] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17988; }","duration":"893.24678ms","start":"2026-08-25T19:47:04.187642Z","end":"2026-08-25T19:47:05.080888Z","steps":["trace[557288788] 'agreement among raft nodes before linearized reading'  (duration: 892.377321ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.080951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.187633Z","time spent":"893.303751ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.081109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.714945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:05.08114Z","caller":"traceutil/trace.go:171","msg":"trace[1379321891] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:0; response_revision:17988; }","duration":"796.784236ms","start":"2026-08-25T19:47:04.284349Z","end":"2026-08-25T19:47:05.081133Z","steps":["trace[1379321891] 'agreement among raft nodes before linearized reading'  (duration: 796.740835ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.081158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.284325Z","time spent":"796.827997ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/neutron-ks-user\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.081245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.29643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:05.081267Z","caller":"traceutil/trace.go:171","msg":"trace[91439426] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:17988; }","duration":"748.359722ms","start":"2026-08-25T19:47:04.332901Z","end":"2026-08-25T19:47:05.08126Z","steps":["trace[91439426] 'agreement among raft nodes before linearized reading'  (duration: 748.321111ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.081283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.332878Z","time spent":"748.399682ms","remote":"127.0.0.1:50486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:05.080907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.598399Z","time spent":"482.498757ms","remote":"127.0.0.1:37598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":6,"response size":31,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "}
{"level":"warn","ts":"2026-08-25T19:47:05.079692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.284399Z","time spent":"795.264523ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17974 > 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-08-25T19:47:05.079626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.351848755s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:47:05.08179Z","caller":"traceutil/trace.go:171","msg":"trace[1971764960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17988; }","duration":"1.354058003s","start":"2026-08-25T19:47:03.727724Z","end":"2026-08-25T19:47:05.081782Z","steps":["trace[1971764960] 'agreement among raft nodes before linearized reading'  (duration: 1.351877996s)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.081814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:03.727704Z","time spent":"1.354101684s","remote":"127.0.0.1:44342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.082044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.977291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:05.082109Z","caller":"traceutil/trace.go:171","msg":"trace[734288011] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17988; }","duration":"891.047933ms","start":"2026-08-25T19:47:04.191046Z","end":"2026-08-25T19:47:05.082094Z","steps":["trace[734288011] 'agreement among raft nodes before linearized reading'  (duration: 889.871736ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.082164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.191022Z","time spent":"891.125234ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.083183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.020245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:05.083215Z","caller":"traceutil/trace.go:171","msg":"trace[1432017367] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17988; }","duration":"893.056045ms","start":"2026-08-25T19:47:04.190152Z","end":"2026-08-25T19:47:05.083208Z","steps":["trace[1432017367] 'agreement among raft nodes before linearized reading'  (duration: 891.197045ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.083247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.190124Z","time spent":"893.115866ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.083586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.741021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:05.083687Z","caller":"traceutil/trace.go:171","msg":"trace[698018056] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17988; }","duration":"894.855863ms","start":"2026-08-25T19:47:04.188817Z","end":"2026-08-25T19:47:05.083673Z","steps":["trace[698018056] 'agreement among raft nodes before linearized reading'  (duration: 892.612454ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.083694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.638572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:05.08372Z","caller":"traceutil/trace.go:171","msg":"trace[857690074] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17988; }","duration":"895.678712ms","start":"2026-08-25T19:47:04.188033Z","end":"2026-08-25T19:47:05.083712Z","steps":["trace[857690074] 'agreement among raft nodes before linearized reading'  (duration: 893.29503ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.083723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.188811Z","time spent":"894.901105ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.083738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.188027Z","time spent":"895.704673ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.084199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.788504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:05.084237Z","caller":"traceutil/trace.go:171","msg":"trace[680818363] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17988; }","duration":"895.828684ms","start":"2026-08-25T19:47:04.1884Z","end":"2026-08-25T19:47:05.084229Z","steps":["trace[680818363] 'agreement among raft nodes before linearized reading'  (duration: 892.919211ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.08427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.188344Z","time spent":"895.916437ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.084695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.672566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:05.084734Z","caller":"traceutil/trace.go:171","msg":"trace[639728641] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17988; }","duration":"886.734517ms","start":"2026-08-25T19:47:04.197991Z","end":"2026-08-25T19:47:05.084725Z","steps":["trace[639728641] 'agreement among raft nodes before linearized reading'  (duration: 883.513397ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.084763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.197982Z","time spent":"886.770608ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"warn","ts":"2026-08-25T19:47:05.0858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.184298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:05.085846Z","caller":"traceutil/trace.go:171","msg":"trace[1837560979] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17988; }","duration":"893.2512ms","start":"2026-08-25T19:47:04.192584Z","end":"2026-08-25T19:47:05.085835Z","steps":["trace[1837560979] 'agreement among raft nodes before linearized reading'  (duration: 889.013387ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:05.086029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:04.192574Z","time spent":"893.292971ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":93,"response size":935238,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "}
{"level":"info","ts":"2026-08-25T19:47:07.289057Z","caller":"traceutil/trace.go:171","msg":"trace[1733207902] transaction","detail":"{read_only:false; response_revision:17998; number_of_response:1; }","duration":"101.497702ms","start":"2026-08-25T19:47:07.187538Z","end":"2026-08-25T19:47:07.289035Z","steps":["trace[1733207902] 'process raft request'  (duration: 101.455351ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:07.289429Z","caller":"traceutil/trace.go:171","msg":"trace[869623453] transaction","detail":"{read_only:false; response_revision:17996; number_of_response:1; }","duration":"107.797799ms","start":"2026-08-25T19:47:07.181615Z","end":"2026-08-25T19:47:07.289413Z","steps":["trace[869623453] 'process raft request'  (duration: 39.956961ms)","trace[869623453] 'compare'  (duration: 67.100193ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:47:07.289561Z","caller":"traceutil/trace.go:171","msg":"trace[810252014] linearizableReadLoop","detail":"{readStateIndex:18614; appliedIndex:18613; }","duration":"106.750367ms","start":"2026-08-25T19:47:07.182802Z","end":"2026-08-25T19:47:07.289552Z","steps":["trace[810252014] 'read index received'  (duration: 38.932228ms)","trace[810252014] 'applied index is now lower than readState.Index'  (duration: 67.816059ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:47:07.289708Z","caller":"traceutil/trace.go:171","msg":"trace[975442157] transaction","detail":"{read_only:false; response_revision:17997; number_of_response:1; }","duration":"106.688616ms","start":"2026-08-25T19:47:07.182943Z","end":"2026-08-25T19:47:07.289632Z","steps":["trace[975442157] 'process raft request'  (duration: 106.00218ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:07.290673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.852081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:07.290719Z","caller":"traceutil/trace.go:171","msg":"trace[1586414111] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17998; }","duration":"107.928433ms","start":"2026-08-25T19:47:07.18278Z","end":"2026-08-25T19:47:07.290708Z","steps":["trace[1586414111] 'agreement among raft nodes before linearized reading'  (duration: 107.131166ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:07.29175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.664246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:07.291799Z","caller":"traceutil/trace.go:171","msg":"trace[667134719] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17998; }","duration":"107.727637ms","start":"2026-08-25T19:47:07.184062Z","end":"2026-08-25T19:47:07.29179Z","steps":["trace[667134719] 'agreement among raft nodes before linearized reading'  (duration: 107.025522ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:07.292784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.830539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:07.292812Z","caller":"traceutil/trace.go:171","msg":"trace[796066091] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17998; }","duration":"106.860019ms","start":"2026-08-25T19:47:07.185946Z","end":"2026-08-25T19:47:07.292806Z","steps":["trace[796066091] 'agreement among raft nodes before linearized reading'  (duration: 106.399169ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:07.293494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.649626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:07.293521Z","caller":"traceutil/trace.go:171","msg":"trace[1719596698] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17998; }","duration":"107.693286ms","start":"2026-08-25T19:47:07.185822Z","end":"2026-08-25T19:47:07.293515Z","steps":["trace[1719596698] 'agreement among raft nodes before linearized reading'  (duration: 107.268227ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:07.294617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.411136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:07.294696Z","caller":"traceutil/trace.go:171","msg":"trace[1040027470] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17998; }","duration":"110.514128ms","start":"2026-08-25T19:47:07.184165Z","end":"2026-08-25T19:47:07.294679Z","steps":["trace[1040027470] 'agreement among raft nodes before linearized reading'  (duration: 109.796543ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:07.294854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.643051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:07.294914Z","caller":"traceutil/trace.go:171","msg":"trace[1170818190] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17998; }","duration":"110.714803ms","start":"2026-08-25T19:47:07.184187Z","end":"2026-08-25T19:47:07.294901Z","steps":["trace[1170818190] 'agreement among raft nodes before linearized reading'  (duration: 109.761273ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:07.295027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.464776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:07.29506Z","caller":"traceutil/trace.go:171","msg":"trace[1298738044] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17998; }","duration":"109.508276ms","start":"2026-08-25T19:47:07.185544Z","end":"2026-08-25T19:47:07.295052Z","steps":["trace[1298738044] 'agreement among raft nodes before linearized reading'  (duration: 108.520405ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:07.295119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.274802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:93 size:935215"}
{"level":"info","ts":"2026-08-25T19:47:07.295205Z","caller":"traceutil/trace.go:171","msg":"trace[685074551] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:93; response_revision:17998; }","duration":"109.386855ms","start":"2026-08-25T19:47:07.185801Z","end":"2026-08-25T19:47:07.295188Z","steps":["trace[685074551] 'agreement among raft nodes before linearized reading'  (duration: 108.164418ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:15.391053Z","caller":"traceutil/trace.go:171","msg":"trace[2142213187] transaction","detail":"{read_only:false; response_revision:18054; number_of_response:1; }","duration":"227.042939ms","start":"2026-08-25T19:47:15.163981Z","end":"2026-08-25T19:47:15.391024Z","steps":["trace[2142213187] 'process raft request'  (duration: 226.876535ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:15.582623Z","caller":"traceutil/trace.go:171","msg":"trace[1195274779] linearizableReadLoop","detail":"{readStateIndex:18677; appliedIndex:18674; }","duration":"326.892616ms","start":"2026-08-25T19:47:15.255705Z","end":"2026-08-25T19:47:15.582597Z","steps":["trace[1195274779] 'read index received'  (duration: 135.150546ms)","trace[1195274779] 'applied index is now lower than readState.Index'  (duration: 191.74117ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:47:15.582745Z","caller":"traceutil/trace.go:171","msg":"trace[900504248] transaction","detail":"{read_only:false; response_revision:18055; number_of_response:1; }","duration":"392.130077ms","start":"2026-08-25T19:47:15.190604Z","end":"2026-08-25T19:47:15.582734Z","steps":["trace[900504248] 'process raft request'  (duration: 391.620626ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.58286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.190578Z","time spent":"392.196168ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:18044 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-25T19:47:15.58292Z","caller":"traceutil/trace.go:171","msg":"trace[404622490] transaction","detail":"{read_only:false; response_revision:18057; number_of_response:1; }","duration":"319.125696ms","start":"2026-08-25T19:47:15.263767Z","end":"2026-08-25T19:47:15.582893Z","steps":["trace[404622490] 'process raft request'  (duration: 318.779289ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.583049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.263744Z","time spent":"319.230358ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:18046 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:15.583123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.411017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:1 size:7382"}
{"level":"info","ts":"2026-08-25T19:47:15.583193Z","caller":"traceutil/trace.go:171","msg":"trace[1726783778] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:1; response_revision:18057; }","duration":"327.513929ms","start":"2026-08-25T19:47:15.255667Z","end":"2026-08-25T19:47:15.583181Z","steps":["trace[1726783778] 'agreement among raft nodes before linearized reading'  (duration: 327.326455ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.583229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.25565Z","time spent":"327.57193ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7405,"request content":"key:\"/registry/jobs/openstack/neutron-ks-user\" "}
{"level":"info","ts":"2026-08-25T19:47:15.58314Z","caller":"traceutil/trace.go:171","msg":"trace[861185219] transaction","detail":"{read_only:false; response_revision:18056; number_of_response:1; }","duration":"387.205519ms","start":"2026-08-25T19:47:15.195929Z","end":"2026-08-25T19:47:15.583134Z","steps":["trace[861185219] 'process raft request'  (duration: 386.477534ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.583277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.195903Z","time spent":"387.356063ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:18045 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-25T19:47:15.612408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.188754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"warn","ts":"2026-08-25T19:47:15.612531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.934687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-l3-agent-default-8k59f\" ","response":"range_response_count:1 size:18668"}
{"level":"info","ts":"2026-08-25T19:47:15.612532Z","caller":"traceutil/trace.go:171","msg":"trace[2100200074] transaction","detail":"{read_only:false; response_revision:18058; number_of_response:1; }","duration":"132.461068ms","start":"2026-08-25T19:47:15.480047Z","end":"2026-08-25T19:47:15.612508Z","steps":["trace[2100200074] 'process raft request'  (duration: 132.089659ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:15.612569Z","caller":"traceutil/trace.go:171","msg":"trace[735517714] range","detail":"{range_begin:/registry/pods/openstack/neutron-l3-agent-default-8k59f; range_end:; response_count:1; response_revision:18058; }","duration":"159.992198ms","start":"2026-08-25T19:47:15.452568Z","end":"2026-08-25T19:47:15.61256Z","steps":["trace[735517714] 'agreement among raft nodes before linearized reading'  (duration: 159.909506ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.612567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.07132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-25T19:47:15.612553Z","caller":"traceutil/trace.go:171","msg":"trace[2100532905] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18058; }","duration":"356.372798ms","start":"2026-08-25T19:47:15.256162Z","end":"2026-08-25T19:47:15.612534Z","steps":["trace[2100532905] 'agreement among raft nodes before linearized reading'  (duration: 356.094791ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.61268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.256147Z","time spent":"356.519631ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-25T19:47:15.612701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.137947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-08-25T19:47:15.612783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.033766ms","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-08-25T19:47:15.612828Z","caller":"traceutil/trace.go:171","msg":"trace[1807769303] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18058; }","duration":"231.120178ms","start":"2026-08-25T19:47:15.381693Z","end":"2026-08-25T19:47:15.612813Z","steps":["trace[1807769303] 'agreement among raft nodes before linearized reading'  (duration: 230.965885ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:47:15.612833Z","caller":"traceutil/trace.go:171","msg":"trace[965853722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18058; }","duration":"214.317981ms","start":"2026-08-25T19:47:15.398494Z","end":"2026-08-25T19:47:15.612812Z","steps":["trace[965853722] 'agreement among raft nodes before linearized reading'  (duration: 214.045425ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.61304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.542345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-ks-user\" ","response":"range_response_count:1 size:7382"}
{"level":"info","ts":"2026-08-25T19:47:15.613117Z","caller":"traceutil/trace.go:171","msg":"trace[759857197] range","detail":"{range_begin:/registry/jobs/openstack/neutron-ks-user; range_end:; response_count:1; response_revision:18058; }","duration":"347.638637ms","start":"2026-08-25T19:47:15.265467Z","end":"2026-08-25T19:47:15.613106Z","steps":["trace[759857197] 'agreement among raft nodes before linearized reading'  (duration: 347.491363ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.613173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.265457Z","time spent":"347.705908ms","remote":"127.0.0.1:44578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7405,"request content":"key:\"/registry/jobs/openstack/neutron-ks-user\" "}
{"level":"info","ts":"2026-08-25T19:47:15.612632Z","caller":"traceutil/trace.go:171","msg":"trace[1602786138] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18058; }","duration":"305.178362ms","start":"2026-08-25T19:47:15.307439Z","end":"2026-08-25T19:47:15.612617Z","steps":["trace[1602786138] 'agreement among raft nodes before linearized reading'  (duration: 304.900516ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.613321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.307419Z","time spent":"305.888077ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-25T19:47:15.612452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.653292ms","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-08-25T19:47:15.613464Z","caller":"traceutil/trace.go:171","msg":"trace[228865140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18058; }","duration":"189.690555ms","start":"2026-08-25T19:47:15.423759Z","end":"2026-08-25T19:47:15.613449Z","steps":["trace[228865140] 'agreement among raft nodes before linearized reading'  (duration: 188.614272ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.613474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.166573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:15.613513Z","caller":"traceutil/trace.go:171","msg":"trace[1208774299] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18058; }","duration":"351.315197ms","start":"2026-08-25T19:47:15.262187Z","end":"2026-08-25T19:47:15.613503Z","steps":["trace[1208774299] 'agreement among raft nodes before linearized reading'  (duration: 351.089332ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.612438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.562194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-08-25T19:47:15.613547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.262176Z","time spent":"351.363518ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"info","ts":"2026-08-25T19:47:15.613583Z","caller":"traceutil/trace.go:171","msg":"trace[1238420495] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:18058; }","duration":"152.76296ms","start":"2026-08-25T19:47:15.460807Z","end":"2026-08-25T19:47:15.61357Z","steps":["trace[1238420495] 'agreement among raft nodes before linearized reading'  (duration: 151.480062ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.613674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.416999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"warn","ts":"2026-08-25T19:47:15.613634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.12358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"}
{"level":"info","ts":"2026-08-25T19:47:15.613729Z","caller":"traceutil/trace.go:171","msg":"trace[137567990] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18058; }","duration":"351.496371ms","start":"2026-08-25T19:47:15.262221Z","end":"2026-08-25T19:47:15.613717Z","steps":["trace[137567990] 'agreement among raft nodes before linearized reading'  (duration: 351.335647ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.613765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.262186Z","time spent":"351.570802ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"info","ts":"2026-08-25T19:47:15.613763Z","caller":"traceutil/trace.go:171","msg":"trace[1853815561] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18058; }","duration":"349.288503ms","start":"2026-08-25T19:47:15.264445Z","end":"2026-08-25T19:47:15.613734Z","steps":["trace[1853815561] 'agreement among raft nodes before linearized reading'  (duration: 349.073898ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:47:15.6138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:47:15.26443Z","time spent":"349.361744ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"info","ts":"2026-08-25T19:47:16.11984Z","caller":"traceutil/trace.go:171","msg":"trace[2130084256] transaction","detail":"{read_only:false; response_revision:18064; number_of_response:1; }","duration":"105.701684ms","start":"2026-08-25T19:47:16.014115Z","end":"2026-08-25T19:47:16.119817Z","steps":["trace[2130084256] 'process raft request'  (duration: 83.330286ms)","trace[2130084256] 'compare'  (duration: 22.082052ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:48:42.379919Z","caller":"traceutil/trace.go:171","msg":"trace[1727556862] linearizableReadLoop","detail":"{readStateIndex:19264; appliedIndex:19263; }","duration":"106.073562ms","start":"2026-08-25T19:48:42.273819Z","end":"2026-08-25T19:48:42.379892Z","steps":["trace[1727556862] 'read index received'  (duration: 105.885268ms)","trace[1727556862] 'applied index is now lower than readState.Index'  (duration: 187.604µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:48:42.380046Z","caller":"traceutil/trace.go:171","msg":"trace[1364820020] transaction","detail":"{read_only:false; response_revision:18622; number_of_response:1; }","duration":"121.896017ms","start":"2026-08-25T19:48:42.258116Z","end":"2026-08-25T19:48:42.380012Z","steps":["trace[1364820020] 'process raft request'  (duration: 121.631102ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:48:42.380325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.485881ms","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-08-25T19:48:42.380368Z","caller":"traceutil/trace.go:171","msg":"trace[181369423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18622; }","duration":"106.611654ms","start":"2026-08-25T19:48:42.273745Z","end":"2026-08-25T19:48:42.380356Z","steps":["trace[181369423] 'agreement among raft nodes before linearized reading'  (duration: 106.327268ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:48:42.545552Z","caller":"traceutil/trace.go:171","msg":"trace[1540718535] transaction","detail":"{read_only:false; response_revision:18623; number_of_response:1; }","duration":"159.992707ms","start":"2026-08-25T19:48:42.385532Z","end":"2026-08-25T19:48:42.545525Z","steps":["trace[1540718535] 'process raft request'  (duration: 159.800173ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:48:42.781763Z","caller":"traceutil/trace.go:171","msg":"trace[839000038] linearizableReadLoop","detail":"{readStateIndex:19267; appliedIndex:19264; }","duration":"385.39926ms","start":"2026-08-25T19:48:42.39634Z","end":"2026-08-25T19:48:42.781739Z","steps":["trace[839000038] 'read index received'  (duration: 149.044419ms)","trace[839000038] 'applied index is now lower than readState.Index'  (duration: 236.353891ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:48:42.781781Z","caller":"traceutil/trace.go:171","msg":"trace[685698361] transaction","detail":"{read_only:false; response_revision:18624; number_of_response:1; }","duration":"395.186043ms","start":"2026-08-25T19:48:42.386566Z","end":"2026-08-25T19:48:42.781752Z","steps":["trace[685698361] 'process raft request'  (duration: 370.503945ms)","trace[685698361] 'compare'  (duration: 24.462564ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:48:42.781812Z","caller":"traceutil/trace.go:171","msg":"trace[193950846] transaction","detail":"{read_only:false; response_revision:18625; number_of_response:1; }","duration":"392.940515ms","start":"2026-08-25T19:48:42.388829Z","end":"2026-08-25T19:48:42.781769Z","steps":["trace[193950846] 'process raft request'  (duration: 392.854563ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:48:42.781946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:48:42.386542Z","time spent":"395.329937ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:18611 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-25T19:48:42.781989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.632865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-pcjnq\" ","response":"range_response_count:1 size:20741"}
{"level":"warn","ts":"2026-08-25T19:48:42.782017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.589791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7697"}
{"level":"warn","ts":"2026-08-25T19:48:42.782011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:48:42.388818Z","time spent":"393.088768ms","remote":"127.0.0.1:44608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:18609 > 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-08-25T19:48:42.782065Z","caller":"traceutil/trace.go:171","msg":"trace[547601153] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:18625; }","duration":"250.686384ms","start":"2026-08-25T19:48:42.531368Z","end":"2026-08-25T19:48:42.782055Z","steps":["trace[547601153] 'agreement among raft nodes before linearized reading'  (duration: 250.51631ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:48:42.782065Z","caller":"traceutil/trace.go:171","msg":"trace[2048770937] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-pcjnq; range_end:; response_count:1; response_revision:18625; }","duration":"385.757908ms","start":"2026-08-25T19:48:42.396288Z","end":"2026-08-25T19:48:42.782046Z","steps":["trace[2048770937] 'agreement among raft nodes before linearized reading'  (duration: 385.534273ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:48:42.782112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:48:42.396263Z","time spent":"385.841709ms","remote":"127.0.0.1:44508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20764,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-pcjnq\" "}
{"level":"info","ts":"2026-08-25T19:48:43.672703Z","caller":"traceutil/trace.go:171","msg":"trace[673186883] transaction","detail":"{read_only:false; response_revision:18628; number_of_response:1; }","duration":"284.852718ms","start":"2026-08-25T19:48:43.387826Z","end":"2026-08-25T19:48:43.672679Z","steps":["trace[673186883] 'process raft request'  (duration: 284.711125ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:48:43.905986Z","caller":"traceutil/trace.go:171","msg":"trace[296765526] transaction","detail":"{read_only:false; response_revision:18629; number_of_response:1; }","duration":"433.452808ms","start":"2026-08-25T19:48:43.472493Z","end":"2026-08-25T19:48:43.905946Z","steps":["trace[296765526] 'process raft request'  (duration: 357.484901ms)","trace[296765526] 'compare'  (duration: 75.658419ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:48:43.906149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:48:43.472459Z","time spent":"433.609501ms","remote":"127.0.0.1:50516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7680,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" mod_revision:18202 > success:<request_put:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" value_size:7622 >> failure:<request_range:<key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" > >"}
{"level":"warn","ts":"2026-08-25T19:48:44.110862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.361923ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971211383 > lease_revoke:<id:3898a03a548f5542>","response":"size:29"}
{"level":"warn","ts":"2026-08-25T19:48:54.836537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.929123ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971211956 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-heat-server-0\" mod_revision:18757 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-heat-server-0\" value_size:10539 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-heat-server-0\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-25T19:48:54.836631Z","caller":"traceutil/trace.go:171","msg":"trace[544827758] linearizableReadLoop","detail":"{readStateIndex:19485; appliedIndex:19484; }","duration":"161.844697ms","start":"2026-08-25T19:48:54.674771Z","end":"2026-08-25T19:48:54.836616Z","steps":["trace[544827758] 'read index received'  (duration: 58.688509ms)","trace[544827758] 'applied index is now lower than readState.Index'  (duration: 103.154718ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:48:54.836898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.091082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0\" ","response":"range_response_count:1 size:1852"}
{"level":"info","ts":"2026-08-25T19:48:54.836938Z","caller":"traceutil/trace.go:171","msg":"trace[1407042829] transaction","detail":"{read_only:false; response_revision:18835; number_of_response:1; }","duration":"182.54566ms","start":"2026-08-25T19:48:54.65436Z","end":"2026-08-25T19:48:54.836906Z","steps":["trace[1407042829] 'process raft request'  (duration: 79.172467ms)","trace[1407042829] 'compare'  (duration: 102.750069ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:48:54.836999Z","caller":"traceutil/trace.go:171","msg":"trace[399691946] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-heat-server-0; range_end:; response_count:1; response_revision:18835; }","duration":"162.268617ms","start":"2026-08-25T19:48:54.674716Z","end":"2026-08-25T19:48:54.836985Z","steps":["trace[399691946] 'agreement among raft nodes before linearized reading'  (duration: 161.938479ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:49:43.58512Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c9fb5245756f3898","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-25T19:49:43.597168Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-25T19:49:43.597287Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-25T19:50:15.65848Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17326}
{"level":"info","ts":"2026-08-25T19:50:15.765157Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17326,"took":"104.131748ms","hash":468751685,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":33628160,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-25T19:50:15.765222Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":468751685,"revision":17326,"compact-revision":14731}
{"level":"info","ts":"2026-08-25T19:55:03.487172Z","caller":"traceutil/trace.go:171","msg":"trace[284099676] transaction","detail":"{read_only:false; response_revision:21505; number_of_response:1; }","duration":"155.544548ms","start":"2026-08-25T19:55:03.331594Z","end":"2026-08-25T19:55:03.487139Z","steps":["trace[284099676] 'process raft request'  (duration: 155.312453ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:55:03.604921Z","caller":"traceutil/trace.go:171","msg":"trace[931358168] transaction","detail":"{read_only:false; response_revision:21506; number_of_response:1; }","duration":"203.85481ms","start":"2026-08-25T19:55:03.401024Z","end":"2026-08-25T19:55:03.604878Z","steps":["trace[931358168] 'process raft request'  (duration: 184.764054ms)","trace[931358168] 'compare'  (duration: 18.902772ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:55:03.75822Z","caller":"traceutil/trace.go:171","msg":"trace[715915277] transaction","detail":"{read_only:false; response_revision:21507; number_of_response:1; }","duration":"219.379119ms","start":"2026-08-25T19:55:03.538798Z","end":"2026-08-25T19:55:03.758177Z","steps":["trace[715915277] 'process raft request'  (duration: 184.017408ms)","trace[715915277] 'compare'  (duration: 35.134596ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:55:04.297548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.762181ms","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-08-25T19:55:04.297723Z","caller":"traceutil/trace.go:171","msg":"trace[2057498149] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:21510; }","duration":"199.945045ms","start":"2026-08-25T19:55:04.097754Z","end":"2026-08-25T19:55:04.297699Z","steps":["trace[2057498149] 'range keys from in-memory index tree'  (duration: 199.74666ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:55:04.311115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.731116ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971219661 > lease_revoke:<id:3898a03a548f75e4>","response":"size:29"}
{"level":"info","ts":"2026-08-25T19:55:09.895949Z","caller":"traceutil/trace.go:171","msg":"trace[1591706241] transaction","detail":"{read_only:false; response_revision:21545; number_of_response:1; }","duration":"116.58472ms","start":"2026-08-25T19:55:09.779342Z","end":"2026-08-25T19:55:09.895927Z","steps":["trace[1591706241] 'process raft request'  (duration: 116.414566ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:55:09.935755Z","caller":"traceutil/trace.go:171","msg":"trace[754379962] transaction","detail":"{read_only:false; response_revision:21546; number_of_response:1; }","duration":"156.351165ms","start":"2026-08-25T19:55:09.779369Z","end":"2026-08-25T19:55:09.93572Z","steps":["trace[754379962] 'process raft request'  (duration: 156.142101ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:55:09.935891Z","caller":"traceutil/trace.go:171","msg":"trace[1528955723] transaction","detail":"{read_only:false; response_revision:21547; number_of_response:1; }","duration":"156.435837ms","start":"2026-08-25T19:55:09.779419Z","end":"2026-08-25T19:55:09.935855Z","steps":["trace[1528955723] 'process raft request'  (duration: 156.214042ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:55:10.206772Z","caller":"traceutil/trace.go:171","msg":"trace[1468007474] transaction","detail":"{read_only:false; response_revision:21548; number_of_response:1; }","duration":"267.063647ms","start":"2026-08-25T19:55:09.939685Z","end":"2026-08-25T19:55:10.206749Z","steps":["trace[1468007474] 'process raft request'  (duration: 266.627537ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:55:10.492579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.216782ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971219755 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:21538 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-25T19:55:10.492667Z","caller":"traceutil/trace.go:171","msg":"trace[906876885] linearizableReadLoop","detail":"{readStateIndex:22288; appliedIndex:22287; }","duration":"150.681822ms","start":"2026-08-25T19:55:10.341972Z","end":"2026-08-25T19:55:10.492654Z","steps":["trace[906876885] 'read index received'  (duration: 17.248635ms)","trace[906876885] 'applied index is now lower than readState.Index'  (duration: 133.432167ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:55:10.49273Z","caller":"traceutil/trace.go:171","msg":"trace[929684904] transaction","detail":"{read_only:false; response_revision:21549; number_of_response:1; }","duration":"160.818623ms","start":"2026-08-25T19:55:10.331904Z","end":"2026-08-25T19:55:10.492723Z","steps":["trace[929684904] 'process raft request'  (duration: 27.368647ms)","trace[929684904] 'compare'  (duration: 133.112479ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:55:10.492998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.491273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"}
{"level":"warn","ts":"2026-08-25T19:55:10.493017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.031399ms","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-08-25T19:55:10.493095Z","caller":"traceutil/trace.go:171","msg":"trace[1806306588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21549; }","duration":"151.157902ms","start":"2026-08-25T19:55:10.341919Z","end":"2026-08-25T19:55:10.493077Z","steps":["trace[1806306588] 'agreement among raft nodes before linearized reading'  (duration: 150.920397ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:55:10.49312Z","caller":"traceutil/trace.go:171","msg":"trace[264472425] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:21549; }","duration":"108.624486ms","start":"2026-08-25T19:55:10.384441Z","end":"2026-08-25T19:55:10.493065Z","steps":["trace[264472425] 'agreement among raft nodes before linearized reading'  (duration: 108.386291ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:55:10.793951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.723458ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4078185634971219761 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:21540 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-25T19:55:10.794118Z","caller":"traceutil/trace.go:171","msg":"trace[644878559] transaction","detail":"{read_only:false; response_revision:21551; number_of_response:1; }","duration":"221.903223ms","start":"2026-08-25T19:55:10.572183Z","end":"2026-08-25T19:55:10.794086Z","steps":["trace[644878559] 'process raft request'  (duration: 73.93718ms)","trace[644878559] 'compare'  (duration: 147.597825ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:55:15.665587Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19574}
{"level":"info","ts":"2026-08-25T19:55:15.792954Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19574,"took":"124.270237ms","hash":1487502729,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":28995584,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-08-25T19:55:15.793103Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1487502729,"revision":19574,"compact-revision":17326}
{"level":"info","ts":"2026-08-25T19:59:49.515504Z","caller":"traceutil/trace.go:171","msg":"trace[885402543] transaction","detail":"{read_only:false; response_revision:24237; number_of_response:1; }","duration":"128.13755ms","start":"2026-08-25T19:59:49.387339Z","end":"2026-08-25T19:59:49.515477Z","steps":["trace[885402543] 'process raft request'  (duration: 127.985136ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T20:00:15.672991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21586}
{"level":"info","ts":"2026-08-25T20:00:15.779304Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21586,"took":"102.491241ms","hash":912171702,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":42504192,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-08-25T20:00:15.781392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":912171702,"revision":21586,"compact-revision":19574}
{"level":"info","ts":"2026-08-25T20:02:15.570444Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067cf.wal"}
{"level":"info","ts":"2026-08-25T20:05:15.679343Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24561}
{"level":"info","ts":"2026-08-25T20:05:15.823582Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24561,"took":"139.965787ms","hash":595810794,"current-db-size-bytes":58335232,"current-db-size":"58 MB","current-db-size-in-use-bytes":32555008,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-08-25T20:05:15.823656Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":595810794,"revision":24561,"compact-revision":21586}
{"level":"info","ts":"2026-08-25T20:09:41.207346Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c9fb5245756f3898","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-25T20:09:41.221706Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-08-25T20:09:41.221826Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}