{"level":"warn","ts":"2026-08-06T07:06:01.822558Z","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-06T07:06:01.822693Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.108:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.108:2380","--initial-cluster=instance=https://199.19.213.108:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.108:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.108: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-06T07:06:01.822791Z","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-06T07:06:01.822807Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.108:2380"]} {"level":"info","ts":"2026-08-06T07:06:01.822832Z","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-06T07:06:01.82361Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"]} {"level":"info","ts":"2026-08-06T07:06:01.823713Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.108:2380"],"listen-peer-urls":["https://199.19.213.108:2380"],"advertise-client-urls":["https://199.19.213.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.108: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-06T07:06:01.830333Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.326186ms"} {"level":"info","ts":"2026-08-06T07:06:01.836593Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e9047e95cdba2056","cluster-id":"51f5e218724a48a2"} {"level":"info","ts":"2026-08-06T07:06:01.836786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=()"} {"level":"info","ts":"2026-08-06T07:06:01.836878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became follower at term 0"} {"level":"info","ts":"2026-08-06T07:06:01.836901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e9047e95cdba2056 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-06T07:06:01.836928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became follower at term 1"} {"level":"info","ts":"2026-08-06T07:06:01.837058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=(16790684492610805846)"} {"level":"warn","ts":"2026-08-06T07:06:01.842123Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-06T07:06:01.843843Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-06T07:06:01.845094Z","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-06T07:06:01.847653Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e9047e95cdba2056","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-06T07:06:01.847898Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e9047e95cdba2056","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-06T07:06:01.848055Z","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-06T07:06:01.848282Z","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-06T07:06:01.848307Z","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-06T07:06:01.849703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=(16790684492610805846)"} {"level":"info","ts":"2026-08-06T07:06:01.850127Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"51f5e218724a48a2","local-member-id":"e9047e95cdba2056","added-peer-id":"e9047e95cdba2056","added-peer-peer-urls":["https://199.19.213.108:2380"]} {"level":"info","ts":"2026-08-06T07:06:01.855577Z","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-06T07:06:01.856064Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e9047e95cdba2056","initial-advertise-peer-urls":["https://199.19.213.108:2380"],"listen-peer-urls":["https://199.19.213.108:2380"],"advertise-client-urls":["https://199.19.213.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-06T07:06:01.85618Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-06T07:06:01.856799Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.108:2380"} {"level":"info","ts":"2026-08-06T07:06:01.85685Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.108:2380"} {"level":"info","ts":"2026-08-06T07:06:02.137515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 is starting a new election at term 1"} {"level":"info","ts":"2026-08-06T07:06:02.13763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-06T07:06:02.137703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 received MsgPreVoteResp from e9047e95cdba2056 at term 1"} {"level":"info","ts":"2026-08-06T07:06:02.137742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became candidate at term 2"} {"level":"info","ts":"2026-08-06T07:06:02.137763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 received MsgVoteResp from e9047e95cdba2056 at term 2"} {"level":"info","ts":"2026-08-06T07:06:02.137786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became leader at term 2"} {"level":"info","ts":"2026-08-06T07:06:02.13791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e9047e95cdba2056 elected leader e9047e95cdba2056 at term 2"} {"level":"info","ts":"2026-08-06T07:06:02.139962Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T07:06:02.142197Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e9047e95cdba2056","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.108:2379]}","request-path":"/0/members/e9047e95cdba2056/attributes","cluster-id":"51f5e218724a48a2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-06T07:06:02.142549Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"51f5e218724a48a2","local-member-id":"e9047e95cdba2056","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T07:06:02.142645Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T07:06:02.142671Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T07:06:02.142687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T07:06:02.143091Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T07:06:02.143281Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-06T07:06:02.143303Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-06T07:06:02.145329Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-06T07:06:02.148384Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.108:2379"} {"level":"info","ts":"2026-08-06T07:06:28.516409Z","caller":"traceutil/trace.go:171","msg":"trace[954146705] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"235.411471ms","start":"2026-08-06T07:06:28.28096Z","end":"2026-08-06T07:06:28.516371Z","steps":["trace[954146705] 'process raft request' (duration: 232.0564ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.831114Z","caller":"traceutil/trace.go:171","msg":"trace[1180736844] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"144.507314ms","start":"2026-08-06T07:06:41.686581Z","end":"2026-08-06T07:06:41.831088Z","steps":["trace[1180736844] 'process raft request' (duration: 144.338091ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.835394Z","caller":"traceutil/trace.go:171","msg":"trace[1393213082] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"143.417171ms","start":"2026-08-06T07:06:41.691922Z","end":"2026-08-06T07:06:41.835339Z","steps":["trace[1393213082] 'process raft request' (duration: 143.166256ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.835447Z","caller":"traceutil/trace.go:171","msg":"trace[874758556] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"143.175977ms","start":"2026-08-06T07:06:41.692194Z","end":"2026-08-06T07:06:41.835369Z","steps":["trace[874758556] 'process raft request' (duration: 143.025943ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.835598Z","caller":"traceutil/trace.go:171","msg":"trace[405288627] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"116.592427ms","start":"2026-08-06T07:06:41.718992Z","end":"2026-08-06T07:06:41.835585Z","steps":["trace[405288627] 'process raft request' (duration: 116.432004ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.83563Z","caller":"traceutil/trace.go:171","msg":"trace[207216211] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"113.533662ms","start":"2026-08-06T07:06:41.722073Z","end":"2026-08-06T07:06:41.835607Z","steps":["trace[207216211] 'process raft request' (duration: 113.403969ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.835695Z","caller":"traceutil/trace.go:171","msg":"trace[1298236339] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"116.750461ms","start":"2026-08-06T07:06:41.71893Z","end":"2026-08-06T07:06:41.83568Z","steps":["trace[1298236339] 'process raft request' (duration: 116.420204ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.835543Z","caller":"traceutil/trace.go:171","msg":"trace[824823527] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"117.325193ms","start":"2026-08-06T07:06:41.71819Z","end":"2026-08-06T07:06:41.835515Z","steps":["trace[824823527] 'process raft request' (duration: 117.082798ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.835862Z","caller":"traceutil/trace.go:171","msg":"trace[360774207] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"106.084162ms","start":"2026-08-06T07:06:41.72972Z","end":"2026-08-06T07:06:41.835804Z","steps":["trace[360774207] 'process raft request' (duration: 105.855217ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:06:41.835832Z","caller":"traceutil/trace.go:171","msg":"trace[619039828] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"110.67743ms","start":"2026-08-06T07:06:41.725082Z","end":"2026-08-06T07:06:41.835759Z","steps":["trace[619039828] 'process raft request' (duration: 110.437845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:48.6025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.96801ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-06T07:06:48.602665Z","caller":"traceutil/trace.go:171","msg":"trace[574061466] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"267.689383ms","start":"2026-08-06T07:06:48.334948Z","end":"2026-08-06T07:06:48.602638Z","steps":["trace[574061466] 'process raft request' (duration: 138.993417ms)","trace[574061466] 'compare' (duration: 127.817976ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:06:49.187116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.018791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-prkxn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-06T07:06:49.187219Z","caller":"traceutil/trace.go:171","msg":"trace[1629730053] range","detail":"{range_begin:/registry/pods/kube-system/cilium-prkxn; range_end:; response_count:1; response_revision:642; }","duration":"403.148033ms","start":"2026-08-06T07:06:48.784047Z","end":"2026-08-06T07:06:49.187195Z","steps":["trace[1629730053] 'range keys from in-memory index tree' (duration: 402.842238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:49.187153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.078543ms","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-06T07:06:49.187343Z","caller":"traceutil/trace.go:171","msg":"trace[2136873094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"404.259787ms","start":"2026-08-06T07:06:48.783039Z","end":"2026-08-06T07:06:49.187299Z","steps":["trace[2136873094] 'range keys from in-memory index tree' (duration: 403.974811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:06:49.187466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:06:48.783025Z","time spent":"404.39783ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-06T07:06:49.187274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:06:48.784044Z","time spent":"403.216055ms","remote":"127.0.0.1:34804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-prkxn\" "} {"level":"info","ts":"2026-08-06T07:06:49.191418Z","caller":"traceutil/trace.go:171","msg":"trace[394197341] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"122.189837ms","start":"2026-08-06T07:06:49.0692Z","end":"2026-08-06T07:06:49.19139Z","steps":["trace[394197341] 'process raft request' (duration: 121.145004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:07:04.858121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.641447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-06T07:07:04.858279Z","caller":"traceutil/trace.go:171","msg":"trace[836610269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:804; }","duration":"111.855622ms","start":"2026-08-06T07:07:04.746406Z","end":"2026-08-06T07:07:04.858262Z","steps":["trace[836610269] 'range keys from in-memory index tree' (duration: 111.474434ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:08:18.556271Z","caller":"traceutil/trace.go:171","msg":"trace[1073896708] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"282.571368ms","start":"2026-08-06T07:08:18.273664Z","end":"2026-08-06T07:08:18.556235Z","steps":["trace[1073896708] 'process raft request' (duration: 282.326763ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:18.946348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.68984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T07:08:18.946426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.454374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d751bab7-82e6-419d-a2bf-73b0245e6678\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-08-06T07:08:18.946501Z","caller":"traceutil/trace.go:171","msg":"trace[640067245] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1857; }","duration":"168.935096ms","start":"2026-08-06T07:08:18.777534Z","end":"2026-08-06T07:08:18.946469Z","steps":["trace[640067245] 'count revisions from in-memory index tree' (duration: 168.530777ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:08:18.946555Z","caller":"traceutil/trace.go:171","msg":"trace[323544507] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d751bab7-82e6-419d-a2bf-73b0245e6678; range_end:; response_count:1; response_revision:1857; }","duration":"295.640647ms","start":"2026-08-06T07:08:18.650888Z","end":"2026-08-06T07:08:18.946529Z","steps":["trace[323544507] 'range keys from in-memory index tree' (duration: 295.342451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:08:18.946375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.950569ms","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-06T07:08:18.946675Z","caller":"traceutil/trace.go:171","msg":"trace[1337051572] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1857; }","duration":"200.298127ms","start":"2026-08-06T07:08:18.746341Z","end":"2026-08-06T07:08:18.946639Z","steps":["trace[1337051572] 'range keys from in-memory index tree' (duration: 199.635712ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:09:02.881065Z","caller":"traceutil/trace.go:171","msg":"trace[1486891625] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"106.49994ms","start":"2026-08-06T07:09:02.774535Z","end":"2026-08-06T07:09:02.881035Z","steps":["trace[1486891625] 'process raft request' (duration: 106.323996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:09:09.723534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.852445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-06T07:09:09.723639Z","caller":"traceutil/trace.go:171","msg":"trace[991389756] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2186; }","duration":"127.009119ms","start":"2026-08-06T07:09:09.596605Z","end":"2026-08-06T07:09:09.723614Z","steps":["trace[991389756] 'range keys from in-memory index tree' (duration: 126.60225ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:09:09.858532Z","caller":"traceutil/trace.go:171","msg":"trace[812316780] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"129.826929ms","start":"2026-08-06T07:09:09.728649Z","end":"2026-08-06T07:09:09.858476Z","steps":["trace[812316780] 'process raft request' (duration: 129.530203ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:10:32.551022Z","caller":"traceutil/trace.go:171","msg":"trace[1840124391] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"176.348037ms","start":"2026-08-06T07:10:32.374641Z","end":"2026-08-06T07:10:32.550989Z","steps":["trace[1840124391] 'process raft request' (duration: 122.473557ms)","trace[1840124391] 'compare' (duration: 53.196126ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:10:32.551284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.313825ms","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-06T07:10:32.55107Z","caller":"traceutil/trace.go:171","msg":"trace[1700783108] linearizableReadLoop","detail":"{readStateIndex:2936; appliedIndex:2935; }","duration":"175.08464ms","start":"2026-08-06T07:10:32.375943Z","end":"2026-08-06T07:10:32.551028Z","steps":["trace[1700783108] 'read index received' (duration: 121.145979ms)","trace[1700783108] 'applied index is now lower than readState.Index' (duration: 53.932471ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:10:32.551362Z","caller":"traceutil/trace.go:171","msg":"trace[813108339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2832; }","duration":"175.417577ms","start":"2026-08-06T07:10:32.375926Z","end":"2026-08-06T07:10:32.551344Z","steps":["trace[813108339] 'agreement among raft nodes before linearized reading' (duration: 175.194312ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:10:38.802133Z","caller":"traceutil/trace.go:171","msg":"trace[777521440] transaction","detail":"{read_only:false; response_revision:2868; number_of_response:1; }","duration":"106.465773ms","start":"2026-08-06T07:10:38.695634Z","end":"2026-08-06T07:10:38.802099Z","steps":["trace[777521440] 'process raft request' (duration: 37.812825ms)","trace[777521440] 'compare' (duration: 68.523255ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:14:31.620946Z","caller":"traceutil/trace.go:171","msg":"trace[1800646953] linearizableReadLoop","detail":"{readStateIndex:5090; appliedIndex:5089; }","duration":"192.116596ms","start":"2026-08-06T07:14:31.428805Z","end":"2026-08-06T07:14:31.620921Z","steps":["trace[1800646953] 'read index received' (duration: 191.784759ms)","trace[1800646953] 'applied index is now lower than readState.Index' (duration: 330.827µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:14:31.621081Z","caller":"traceutil/trace.go:171","msg":"trace[936334978] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"236.3355ms","start":"2026-08-06T07:14:31.384729Z","end":"2026-08-06T07:14:31.621064Z","steps":["trace[936334978] 'process raft request' (duration: 235.978573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:31.621318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.504175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-06T07:14:31.621362Z","caller":"traceutil/trace.go:171","msg":"trace[758627816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4905; }","duration":"192.594967ms","start":"2026-08-06T07:14:31.428757Z","end":"2026-08-06T07:14:31.621352Z","steps":["trace[758627816] 'agreement among raft nodes before linearized reading' (duration: 192.456304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:31.622871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.257103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2210296"} {"level":"info","ts":"2026-08-06T07:14:31.622992Z","caller":"traceutil/trace.go:171","msg":"trace[180035216] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:4905; }","duration":"131.631311ms","start":"2026-08-06T07:14:31.491334Z","end":"2026-08-06T07:14:31.622966Z","steps":["trace[180035216] 'agreement among raft nodes before linearized reading' (duration: 130.028227ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:35.700684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.979329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:14:35.70078Z","caller":"traceutil/trace.go:171","msg":"trace[35172798] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5036; }","duration":"170.095452ms","start":"2026-08-06T07:14:35.530666Z","end":"2026-08-06T07:14:35.700761Z","steps":["trace[35172798] 'range keys from in-memory index tree' (duration: 169.938498ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:35.70086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.738228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-12a6c046-4160-4569-8d41-d3ccc0aee868\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-06T07:14:35.700949Z","caller":"traceutil/trace.go:171","msg":"trace[355244149] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-12a6c046-4160-4569-8d41-d3ccc0aee868; range_end:; response_count:1; response_revision:5036; }","duration":"172.899332ms","start":"2026-08-06T07:14:35.52803Z","end":"2026-08-06T07:14:35.70093Z","steps":["trace[355244149] 'range keys from in-memory index tree' (duration: 172.515024ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:48.619679Z","caller":"traceutil/trace.go:171","msg":"trace[820811391] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"195.282764ms","start":"2026-08-06T07:14:48.424366Z","end":"2026-08-06T07:14:48.619649Z","steps":["trace[820811391] 'process raft request' (duration: 195.059879ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:48.63325Z","caller":"traceutil/trace.go:171","msg":"trace[657144725] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"118.897956ms","start":"2026-08-06T07:14:48.514332Z","end":"2026-08-06T07:14:48.633229Z","steps":["trace[657144725] 'process raft request' (duration: 118.767443ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:49.296883Z","caller":"traceutil/trace.go:171","msg":"trace[473262994] linearizableReadLoop","detail":"{readStateIndex:5504; appliedIndex:5503; }","duration":"196.392289ms","start":"2026-08-06T07:14:49.100474Z","end":"2026-08-06T07:14:49.296866Z","steps":["trace[473262994] 'read index received' (duration: 155.004725ms)","trace[473262994] 'applied index is now lower than readState.Index' (duration: 41.386594ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:14:49.296903Z","caller":"traceutil/trace.go:171","msg":"trace[92509] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"229.100525ms","start":"2026-08-06T07:14:49.067775Z","end":"2026-08-06T07:14:49.296875Z","steps":["trace[92509] 'process raft request' (duration: 187.771942ms)","trace[92509] 'compare' (duration: 41.155179ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:14:49.297023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.527231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T07:14:49.297112Z","caller":"traceutil/trace.go:171","msg":"trace[1458005813] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5308; }","duration":"196.665604ms","start":"2026-08-06T07:14:49.100424Z","end":"2026-08-06T07:14:49.29709Z","steps":["trace[1458005813] 'agreement among raft nodes before linearized reading' (duration: 196.503911ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:14:49.297146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.15736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-06T07:14:49.297216Z","caller":"traceutil/trace.go:171","msg":"trace[221737312] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5308; }","duration":"175.286823ms","start":"2026-08-06T07:14:49.121913Z","end":"2026-08-06T07:14:49.297199Z","steps":["trace[221737312] 'agreement among raft nodes before linearized reading' (duration: 175.082798ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:14:57.526229Z","caller":"traceutil/trace.go:171","msg":"trace[1577880387] linearizableReadLoop","detail":"{readStateIndex:5705; appliedIndex:5704; }","duration":"133.984322ms","start":"2026-08-06T07:14:57.392207Z","end":"2026-08-06T07:14:57.526191Z","steps":["trace[1577880387] 'read index received' (duration: 39.046522ms)","trace[1577880387] 'applied index is now lower than readState.Index' (duration: 94.936639ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:14:57.526295Z","caller":"traceutil/trace.go:171","msg":"trace[1591770459] transaction","detail":"{read_only:false; response_revision:5505; number_of_response:1; }","duration":"171.571723ms","start":"2026-08-06T07:14:57.354674Z","end":"2026-08-06T07:14:57.526246Z","steps":["trace[1591770459] 'process raft request' (duration: 76.572772ms)","trace[1591770459] 'compare' (duration: 94.761066ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:14:57.526513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.295599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dcc4ef26-50d8-4538-9c7e-adae846e43d3\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-06T07:14:57.52658Z","caller":"traceutil/trace.go:171","msg":"trace[1422196209] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dcc4ef26-50d8-4538-9c7e-adae846e43d3; range_end:; response_count:1; response_revision:5505; }","duration":"134.39227ms","start":"2026-08-06T07:14:57.392158Z","end":"2026-08-06T07:14:57.526551Z","steps":["trace[1422196209] 'agreement among raft nodes before linearized reading' (duration: 134.160775ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:16:02.703356Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2997} {"level":"info","ts":"2026-08-06T07:16:02.776337Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2997,"took":"71.025983ms","hash":2415060858,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":33853440,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-06T07:16:02.776418Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2415060858,"revision":2997,"compact-revision":-1} {"level":"info","ts":"2026-08-06T07:21:00.810587Z","caller":"traceutil/trace.go:171","msg":"trace[27534183] transaction","detail":"{read_only:false; response_revision:8285; number_of_response:1; }","duration":"147.449212ms","start":"2026-08-06T07:21:00.66311Z","end":"2026-08-06T07:21:00.810559Z","steps":["trace[27534183] 'process raft request' (duration: 132.70248ms)","trace[27534183] 'compare' (duration: 14.629289ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:21:02.709345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6076} {"level":"info","ts":"2026-08-06T07:21:02.805771Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6076,"took":"94.61358ms","hash":4047996972,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":23781376,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-08-06T07:21:02.80585Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4047996972,"revision":6076,"compact-revision":2997} {"level":"info","ts":"2026-08-06T07:21:12.202975Z","caller":"traceutil/trace.go:171","msg":"trace[988595828] transaction","detail":"{read_only:false; response_revision:8345; number_of_response:1; }","duration":"107.401839ms","start":"2026-08-06T07:21:12.095551Z","end":"2026-08-06T07:21:12.202953Z","steps":["trace[988595828] 'process raft request' (duration: 107.265716ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:12.883129Z","caller":"traceutil/trace.go:171","msg":"trace[2136105887] linearizableReadLoop","detail":"{readStateIndex:8639; appliedIndex:8638; }","duration":"153.449262ms","start":"2026-08-06T07:21:12.729653Z","end":"2026-08-06T07:21:12.883102Z","steps":["trace[2136105887] 'read index received' (duration: 153.35297ms)","trace[2136105887] 'applied index is now lower than readState.Index' (duration: 95.432µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:21:12.883164Z","caller":"traceutil/trace.go:171","msg":"trace[1963900541] transaction","detail":"{read_only:false; response_revision:8347; number_of_response:1; }","duration":"174.455649ms","start":"2026-08-06T07:21:12.708684Z","end":"2026-08-06T07:21:12.883139Z","steps":["trace[1963900541] 'process raft request' (duration: 174.264525ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:21:12.883396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.703927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:21:12.883532Z","caller":"traceutil/trace.go:171","msg":"trace[585478567] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8347; }","duration":"153.896132ms","start":"2026-08-06T07:21:12.729603Z","end":"2026-08-06T07:21:12.883499Z","steps":["trace[585478567] 'agreement among raft nodes before linearized reading' (duration: 153.627786ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:12.896884Z","caller":"traceutil/trace.go:171","msg":"trace[1274729772] transaction","detail":"{read_only:false; response_revision:8348; number_of_response:1; }","duration":"157.205044ms","start":"2026-08-06T07:21:12.739644Z","end":"2026-08-06T07:21:12.896849Z","steps":["trace[1274729772] 'process raft request' (duration: 156.903407ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:15.004313Z","caller":"traceutil/trace.go:171","msg":"trace[123279925] transaction","detail":"{read_only:false; response_revision:8358; number_of_response:1; }","duration":"113.579833ms","start":"2026-08-06T07:21:14.890714Z","end":"2026-08-06T07:21:15.004294Z","steps":["trace[123279925] 'process raft request' (duration: 113.45916ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:15.006729Z","caller":"traceutil/trace.go:171","msg":"trace[1596776490] transaction","detail":"{read_only:false; response_revision:8359; number_of_response:1; }","duration":"104.753001ms","start":"2026-08-06T07:21:14.901965Z","end":"2026-08-06T07:21:15.006718Z","steps":["trace[1596776490] 'process raft request' (duration: 104.69266ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:42.094468Z","caller":"traceutil/trace.go:171","msg":"trace[488812427] linearizableReadLoop","detail":"{readStateIndex:8857; appliedIndex:8856; }","duration":"239.472346ms","start":"2026-08-06T07:21:41.854966Z","end":"2026-08-06T07:21:42.094438Z","steps":["trace[488812427] 'read index received' (duration: 239.288232ms)","trace[488812427] 'applied index is now lower than readState.Index' (duration: 183.054µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:21:42.094485Z","caller":"traceutil/trace.go:171","msg":"trace[565767156] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"293.294438ms","start":"2026-08-06T07:21:41.801155Z","end":"2026-08-06T07:21:42.09445Z","steps":["trace[565767156] 'process raft request' (duration: 293.002832ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:21:42.094778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.786413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-06T07:21:42.09488Z","caller":"traceutil/trace.go:171","msg":"trace[2041555570] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8557; }","duration":"239.927376ms","start":"2026-08-06T07:21:41.854928Z","end":"2026-08-06T07:21:42.094856Z","steps":["trace[2041555570] 'agreement among raft nodes before linearized reading' (duration: 239.67144ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:42.258439Z","caller":"traceutil/trace.go:171","msg":"trace[629220492] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"157.598433ms","start":"2026-08-06T07:21:42.100819Z","end":"2026-08-06T07:21:42.258417Z","steps":["trace[629220492] 'process raft request' (duration: 152.649306ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:42.258621Z","caller":"traceutil/trace.go:171","msg":"trace[1427423518] transaction","detail":"{read_only:false; response_revision:8559; number_of_response:1; }","duration":"157.776057ms","start":"2026-08-06T07:21:42.100822Z","end":"2026-08-06T07:21:42.258598Z","steps":["trace[1427423518] 'process raft request' (duration: 157.557522ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:42.258959Z","caller":"traceutil/trace.go:171","msg":"trace[538244734] transaction","detail":"{read_only:false; response_revision:8560; number_of_response:1; }","duration":"156.933058ms","start":"2026-08-06T07:21:42.102015Z","end":"2026-08-06T07:21:42.258948Z","steps":["trace[538244734] 'process raft request' (duration: 156.517219ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:55.460746Z","caller":"traceutil/trace.go:171","msg":"trace[558155593] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"168.367047ms","start":"2026-08-06T07:21:55.292356Z","end":"2026-08-06T07:21:55.460723Z","steps":["trace[558155593] 'process raft request' (duration: 159.673997ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:21:56.343472Z","caller":"traceutil/trace.go:171","msg":"trace[350462089] linearizableReadLoop","detail":"{readStateIndex:8983; appliedIndex:8982; }","duration":"179.934738ms","start":"2026-08-06T07:21:56.163508Z","end":"2026-08-06T07:21:56.343443Z","steps":["trace[350462089] 'read index received' (duration: 179.720914ms)","trace[350462089] 'applied index is now lower than readState.Index' (duration: 212.834µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:21:56.343792Z","caller":"traceutil/trace.go:171","msg":"trace[399718982] transaction","detail":"{read_only:false; response_revision:8677; number_of_response:1; }","duration":"188.119747ms","start":"2026-08-06T07:21:56.155658Z","end":"2026-08-06T07:21:56.343778Z","steps":["trace[399718982] 'process raft request' (duration: 187.630797ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:21:56.344231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.707856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-06T07:21:56.344315Z","caller":"traceutil/trace.go:171","msg":"trace[527371748] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8677; }","duration":"180.833338ms","start":"2026-08-06T07:21:56.163466Z","end":"2026-08-06T07:21:56.344299Z","steps":["trace[527371748] 'agreement among raft nodes before linearized reading' (duration: 180.688134ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:22:10.616205Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023a5.wal"} {"level":"info","ts":"2026-08-06T07:23:45.918041Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e9047e95cdba2056","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-06T07:23:45.928213Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-06T07:23:45.92841Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-06T07:26:02.717829Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8295} {"level":"info","ts":"2026-08-06T07:26:02.800443Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8295,"took":"80.434145ms","hash":3909819796,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":26513408,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-06T07:26:02.800501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3909819796,"revision":8295,"compact-revision":6076} {"level":"warn","ts":"2026-08-06T07:26:54.068861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.002414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-06T07:26:54.068934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.657066ms","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-06T07:26:54.068916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.26627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-06T07:26:54.069019Z","caller":"traceutil/trace.go:171","msg":"trace[87139090] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:11261; }","duration":"145.245269ms","start":"2026-08-06T07:26:53.923727Z","end":"2026-08-06T07:26:54.068972Z","steps":["trace[87139090] 'count revisions from in-memory index tree' (duration: 129.900564ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:26:54.069056Z","caller":"traceutil/trace.go:171","msg":"trace[1203846669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11261; }","duration":"199.801809ms","start":"2026-08-06T07:26:53.869228Z","end":"2026-08-06T07:26:54.069029Z","steps":["trace[1203846669] 'agreement among raft nodes before linearized reading' (duration: 69.614639ms)","trace[1203846669] 'range keys from in-memory index tree' (duration: 129.926405ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:26:54.069085Z","caller":"traceutil/trace.go:171","msg":"trace[1959193364] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11261; }","duration":"195.439794ms","start":"2026-08-06T07:26:53.873616Z","end":"2026-08-06T07:26:54.069056Z","steps":["trace[1959193364] 'agreement among raft nodes before linearized reading' (duration: 65.237843ms)","trace[1959193364] 'range keys from in-memory index tree' (duration: 129.888584ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:26:54.069024Z","caller":"traceutil/trace.go:171","msg":"trace[1422246728] transaction","detail":"{read_only:false; response_revision:11262; number_of_response:1; }","duration":"126.116121ms","start":"2026-08-06T07:26:53.942877Z","end":"2026-08-06T07:26:54.068993Z","steps":["trace[1422246728] 'process raft request' (duration: 65.278054ms)","trace[1422246728] 'compare' (duration: 60.583162ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:26:54.211624Z","caller":"traceutil/trace.go:171","msg":"trace[86839911] transaction","detail":"{read_only:false; response_revision:11264; number_of_response:1; }","duration":"137.9227ms","start":"2026-08-06T07:26:54.073675Z","end":"2026-08-06T07:26:54.211598Z","steps":["trace[86839911] 'process raft request' (duration: 98.889398ms)","trace[86839911] 'compare' (duration: 38.919879ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:31:02.723868Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10784} {"level":"info","ts":"2026-08-06T07:31:02.810508Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10784,"took":"83.465393ms","hash":4136920419,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":27426816,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-06T07:31:02.810583Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4136920419,"revision":10784,"compact-revision":8295} {"level":"info","ts":"2026-08-06T07:33:11.71679Z","caller":"traceutil/trace.go:171","msg":"trace[1511000754] transaction","detail":"{read_only:false; response_revision:13802; number_of_response:1; }","duration":"147.523873ms","start":"2026-08-06T07:33:11.569239Z","end":"2026-08-06T07:33:11.716763Z","steps":["trace[1511000754] 'process raft request' (duration: 147.330299ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:33:19.96375Z","caller":"traceutil/trace.go:171","msg":"trace[509242407] transaction","detail":"{read_only:false; response_revision:13860; number_of_response:1; }","duration":"168.642224ms","start":"2026-08-06T07:33:19.795066Z","end":"2026-08-06T07:33:19.963708Z","steps":["trace[509242407] 'process raft request' (duration: 168.305537ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:33:41.063231Z","caller":"traceutil/trace.go:171","msg":"trace[1391013488] transaction","detail":"{read_only:false; response_revision:14164; number_of_response:1; }","duration":"285.671271ms","start":"2026-08-06T07:33:40.777531Z","end":"2026-08-06T07:33:41.063202Z","steps":["trace[1391013488] 'process raft request' (duration: 285.499247ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:33:41.145136Z","caller":"traceutil/trace.go:171","msg":"trace[1417368711] linearizableReadLoop","detail":"{readStateIndex:14650; appliedIndex:14648; }","duration":"274.965637ms","start":"2026-08-06T07:33:40.870137Z","end":"2026-08-06T07:33:41.145103Z","steps":["trace[1417368711] 'read index received' (duration: 192.862404ms)","trace[1417368711] 'applied index is now lower than readState.Index' (duration: 82.100753ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:33:41.145534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.345175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3dc5de06-94f8-4f6f-8572-fd954c48b0d6\" ","response":"range_response_count:1 size:3754"} {"level":"warn","ts":"2026-08-06T07:33:41.145603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.784652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T07:33:41.145787Z","caller":"traceutil/trace.go:171","msg":"trace[1285716145] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:14165; }","duration":"101.064488ms","start":"2026-08-06T07:33:41.044706Z","end":"2026-08-06T07:33:41.145771Z","steps":["trace[1285716145] 'agreement among raft nodes before linearized reading' (duration: 100.68692ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:33:41.146267Z","caller":"traceutil/trace.go:171","msg":"trace[711555168] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3dc5de06-94f8-4f6f-8572-fd954c48b0d6; range_end:; response_count:1; response_revision:14165; }","duration":"275.520459ms","start":"2026-08-06T07:33:40.870132Z","end":"2026-08-06T07:33:41.145652Z","steps":["trace[711555168] 'agreement among raft nodes before linearized reading' (duration: 275.175561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:33:41.146603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.42932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T07:33:41.146669Z","caller":"traceutil/trace.go:171","msg":"trace[21196937] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:14165; }","duration":"228.547793ms","start":"2026-08-06T07:33:40.918103Z","end":"2026-08-06T07:33:41.146651Z","steps":["trace[21196937] 'agreement among raft nodes before linearized reading' (duration: 227.222154ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:35:13.15781Z","caller":"traceutil/trace.go:171","msg":"trace[359945039] linearizableReadLoop","detail":"{readStateIndex:15519; appliedIndex:15518; }","duration":"117.762105ms","start":"2026-08-06T07:35:13.040015Z","end":"2026-08-06T07:35:13.157777Z","steps":["trace[359945039] 'read index received' (duration: 117.465258ms)","trace[359945039] 'applied index is now lower than readState.Index' (duration: 295.657µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:35:13.158137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.091472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-x8sx2\" ","response":"range_response_count:1 size:22132"} {"level":"info","ts":"2026-08-06T07:35:13.15819Z","caller":"traceutil/trace.go:171","msg":"trace[1597757274] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-x8sx2; range_end:; response_count:1; response_revision:15010; }","duration":"118.186905ms","start":"2026-08-06T07:35:13.039989Z","end":"2026-08-06T07:35:13.158176Z","steps":["trace[1597757274] 'agreement among raft nodes before linearized reading' (duration: 117.98239ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:35:13.158357Z","caller":"traceutil/trace.go:171","msg":"trace[1396961644] transaction","detail":"{read_only:false; response_revision:15010; number_of_response:1; }","duration":"125.816671ms","start":"2026-08-06T07:35:13.032091Z","end":"2026-08-06T07:35:13.157907Z","steps":["trace[1396961644] 'process raft request' (duration: 125.450042ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:36:02.730992Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12860} {"level":"info","ts":"2026-08-06T07:36:02.806209Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12860,"took":"72.70223ms","hash":2877682576,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":30515200,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-06T07:36:02.806273Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2877682576,"revision":12860,"compact-revision":10784} {"level":"info","ts":"2026-08-06T07:40:54.390031Z","caller":"traceutil/trace.go:171","msg":"trace[273361563] linearizableReadLoop","detail":"{readStateIndex:18147; appliedIndex:18146; }","duration":"167.947387ms","start":"2026-08-06T07:40:54.222062Z","end":"2026-08-06T07:40:54.390009Z","steps":["trace[273361563] 'read index received' (duration: 167.709611ms)","trace[273361563] 'applied index is now lower than readState.Index' (duration: 237.076µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:40:54.390215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.140901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:40:54.390244Z","caller":"traceutil/trace.go:171","msg":"trace[516198184] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17555; }","duration":"168.214883ms","start":"2026-08-06T07:40:54.22202Z","end":"2026-08-06T07:40:54.390235Z","steps":["trace[516198184] 'agreement among raft nodes before linearized reading' (duration: 168.0961ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:40:54.390801Z","caller":"traceutil/trace.go:171","msg":"trace[228505544] transaction","detail":"{read_only:false; response_revision:17555; number_of_response:1; }","duration":"259.205485ms","start":"2026-08-06T07:40:54.13158Z","end":"2026-08-06T07:40:54.390785Z","steps":["trace[228505544] 'process raft request' (duration: 258.287716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:40:54.709894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.890159ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:40:54.71003Z","caller":"traceutil/trace.go:171","msg":"trace[487543246] linearizableReadLoop","detail":"{readStateIndex:18148; appliedIndex:18147; }","duration":"255.828922ms","start":"2026-08-06T07:40:54.454169Z","end":"2026-08-06T07:40:54.709998Z","steps":["trace[487543246] 'read index received' (duration: 17.544005ms)","trace[487543246] 'applied index is now lower than readState.Index' (duration: 238.283657ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:40:54.710101Z","caller":"traceutil/trace.go:171","msg":"trace[539459942] transaction","detail":"{read_only:false; response_revision:17556; number_of_response:1; }","duration":"309.247901ms","start":"2026-08-06T07:40:54.400805Z","end":"2026-08-06T07:40:54.710053Z","steps":["trace[539459942] 'process raft request' (duration: 70.973885ms)","trace[539459942] 'compare' (duration: 237.673723ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:40:54.710206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.021156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-06T07:40:54.71028Z","caller":"traceutil/trace.go:171","msg":"trace[528562984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17556; }","duration":"256.138449ms","start":"2026-08-06T07:40:54.454123Z","end":"2026-08-06T07:40:54.710262Z","steps":["trace[528562984] 'agreement among raft nodes before linearized reading' (duration: 255.934704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:40:54.710331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:40:54.400788Z","time spent":"309.409464ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:40:54.710326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.178229ms","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-06T07:40:54.710405Z","caller":"traceutil/trace.go:171","msg":"trace[1301140200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17556; }","duration":"203.355473ms","start":"2026-08-06T07:40:54.507032Z","end":"2026-08-06T07:40:54.710387Z","steps":["trace[1301140200] 'agreement among raft nodes before linearized reading' (duration: 203.096547ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:40:54.893992Z","caller":"traceutil/trace.go:171","msg":"trace[212274695] transaction","detail":"{read_only:false; response_revision:17557; number_of_response:1; }","duration":"179.248685ms","start":"2026-08-06T07:40:54.714657Z","end":"2026-08-06T07:40:54.893906Z","steps":["trace[212274695] 'process raft request' (duration: 152.097911ms)","trace[212274695] 'compare' (duration: 26.97283ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:40:54.938515Z","caller":"traceutil/trace.go:171","msg":"trace[914181033] transaction","detail":"{read_only:false; response_revision:17558; number_of_response:1; }","duration":"223.615685ms","start":"2026-08-06T07:40:54.714855Z","end":"2026-08-06T07:40:54.93847Z","steps":["trace[914181033] 'process raft request' (duration: 223.42118ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:40:54.938857Z","caller":"traceutil/trace.go:171","msg":"trace[51053975] transaction","detail":"{read_only:false; response_revision:17559; number_of_response:1; }","duration":"223.807029ms","start":"2026-08-06T07:40:54.715022Z","end":"2026-08-06T07:40:54.938829Z","steps":["trace[51053975] 'process raft request' (duration: 223.407031ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:40:54.93893Z","caller":"traceutil/trace.go:171","msg":"trace[962853395] transaction","detail":"{read_only:false; response_revision:17560; number_of_response:1; }","duration":"134.963516ms","start":"2026-08-06T07:40:54.803935Z","end":"2026-08-06T07:40:54.938898Z","steps":["trace[962853395] 'process raft request' (duration: 134.717669ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:41:02.739869Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15328} {"level":"info","ts":"2026-08-06T07:41:02.833979Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15328,"took":"90.427741ms","hash":701299379,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":32415744,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-06T07:41:02.834054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":701299379,"revision":15328,"compact-revision":12860} {"level":"info","ts":"2026-08-06T07:44:32.065367Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e9047e95cdba2056","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-06T07:44:32.06947Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-06T07:44:32.069564Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-06T07:46:02.746784Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17744} {"level":"info","ts":"2026-08-06T07:46:02.844592Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17744,"took":"94.986873ms","hash":291910665,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":33890304,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-06T07:46:02.844663Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":291910665,"revision":17744,"compact-revision":15328} {"level":"warn","ts":"2026-08-06T07:46:36.703911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.693812ms","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-06T07:46:36.704026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.999156ms","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-06T07:46:36.704051Z","caller":"traceutil/trace.go:171","msg":"trace[1690717138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20217; }","duration":"112.885617ms","start":"2026-08-06T07:46:36.591144Z","end":"2026-08-06T07:46:36.704029Z","steps":["trace[1690717138] 'range keys from in-memory index tree' (duration: 112.449466ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:46:36.704078Z","caller":"traceutil/trace.go:171","msg":"trace[1544161905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20217; }","duration":"278.080337ms","start":"2026-08-06T07:46:36.425984Z","end":"2026-08-06T07:46:36.704064Z","steps":["trace[1544161905] 'range keys from in-memory index tree' (duration: 277.814562ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:46:36.8247Z","caller":"traceutil/trace.go:171","msg":"trace[1309989711] transaction","detail":"{read_only:false; response_revision:20218; number_of_response:1; }","duration":"116.462884ms","start":"2026-08-06T07:46:36.708208Z","end":"2026-08-06T07:46:36.82467Z","steps":["trace[1309989711] 'process raft request' (duration: 116.153778ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:46:36.961288Z","caller":"traceutil/trace.go:171","msg":"trace[846303775] transaction","detail":"{read_only:false; response_revision:20219; number_of_response:1; }","duration":"252.524188ms","start":"2026-08-06T07:46:36.708731Z","end":"2026-08-06T07:46:36.961255Z","steps":["trace[846303775] 'process raft request' (duration: 234.463072ms)","trace[846303775] 'compare' (duration: 17.562114ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:46:36.961487Z","caller":"traceutil/trace.go:171","msg":"trace[427365063] linearizableReadLoop","detail":"{readStateIndex:20902; appliedIndex:20899; }","duration":"185.528669ms","start":"2026-08-06T07:46:36.775928Z","end":"2026-08-06T07:46:36.961457Z","steps":["trace[427365063] 'read index received' (duration: 48.518094ms)","trace[427365063] 'applied index is now lower than readState.Index' (duration: 137.008965ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:46:36.961619Z","caller":"traceutil/trace.go:171","msg":"trace[475005777] transaction","detail":"{read_only:false; response_revision:20220; number_of_response:1; }","duration":"252.774153ms","start":"2026-08-06T07:46:36.708798Z","end":"2026-08-06T07:46:36.961573Z","steps":["trace[475005777] 'process raft request' (duration: 252.355364ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:46:36.961802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.960359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-08-06T07:46:36.961908Z","caller":"traceutil/trace.go:171","msg":"trace[1290186971] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20220; }","duration":"119.125583ms","start":"2026-08-06T07:46:36.842766Z","end":"2026-08-06T07:46:36.961892Z","steps":["trace[1290186971] 'agreement among raft nodes before linearized reading' (duration: 118.873998ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:46:36.961913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.826426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T07:46:36.962688Z","caller":"traceutil/trace.go:171","msg":"trace[2121410855] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:20220; }","duration":"186.791976ms","start":"2026-08-06T07:46:36.775865Z","end":"2026-08-06T07:46:36.962657Z","steps":["trace[2121410855] 'agreement among raft nodes before linearized reading' (duration: 185.749874ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:46:37.239391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.2896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:46:37.239531Z","caller":"traceutil/trace.go:171","msg":"trace[10902645] transaction","detail":"{read_only:false; response_revision:20221; number_of_response:1; }","duration":"273.055028ms","start":"2026-08-06T07:46:36.966422Z","end":"2026-08-06T07:46:37.239478Z","steps":["trace[10902645] 'process raft request' (duration: 130.568643ms)","trace[10902645] 'compare' (duration: 142.050875ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:46:37.316484Z","caller":"traceutil/trace.go:171","msg":"trace[316853655] linearizableReadLoop","detail":"{readStateIndex:20906; appliedIndex:20902; }","duration":"229.683806ms","start":"2026-08-06T07:46:37.086771Z","end":"2026-08-06T07:46:37.316455Z","steps":["trace[316853655] 'read index received' (duration: 10.359037ms)","trace[316853655] 'applied index is now lower than readState.Index' (duration: 219.323499ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:46:37.316552Z","caller":"traceutil/trace.go:171","msg":"trace[1428710171] transaction","detail":"{read_only:false; response_revision:20223; number_of_response:1; }","duration":"294.330573ms","start":"2026-08-06T07:46:37.02218Z","end":"2026-08-06T07:46:37.316511Z","steps":["trace[1428710171] 'process raft request' (duration: 294.197881ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:46:37.316584Z","caller":"traceutil/trace.go:171","msg":"trace[2120866382] transaction","detail":"{read_only:false; response_revision:20224; number_of_response:1; }","duration":"293.624707ms","start":"2026-08-06T07:46:37.02293Z","end":"2026-08-06T07:46:37.316555Z","steps":["trace[2120866382] 'process raft request' (duration: 293.486554ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:46:37.316947Z","caller":"traceutil/trace.go:171","msg":"trace[1096391651] transaction","detail":"{read_only:false; response_revision:20222; number_of_response:1; }","duration":"335.674131ms","start":"2026-08-06T07:46:36.981229Z","end":"2026-08-06T07:46:37.316903Z","steps":["trace[1096391651] 'process raft request' (duration: 334.999725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:46:37.316956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.136047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-06T07:46:37.317139Z","caller":"traceutil/trace.go:171","msg":"trace[794756029] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20224; }","duration":"230.430774ms","start":"2026-08-06T07:46:37.086644Z","end":"2026-08-06T07:46:37.317074Z","steps":["trace[794756029] 'agreement among raft nodes before linearized reading' (duration: 229.971163ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:46:37.317153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:46:36.9812Z","time spent":"335.841164ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:50:16.629017Z","caller":"traceutil/trace.go:171","msg":"trace[736138839] linearizableReadLoop","detail":"{readStateIndex:23357; appliedIndex:23356; }","duration":"161.201176ms","start":"2026-08-06T07:50:16.467796Z","end":"2026-08-06T07:50:16.628997Z","steps":["trace[736138839] 'read index received' (duration: 160.973951ms)","trace[736138839] 'applied index is now lower than readState.Index' (duration: 226.645µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:50:16.629088Z","caller":"traceutil/trace.go:171","msg":"trace[1626356565] transaction","detail":"{read_only:false; response_revision:22605; number_of_response:1; }","duration":"162.517314ms","start":"2026-08-06T07:50:16.466534Z","end":"2026-08-06T07:50:16.629051Z","steps":["trace[1626356565] 'process raft request' (duration: 162.32585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:50:16.629206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.3898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/capi-kubeadm-control-plane-system/capi-kubeadm-control-plane-manager\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-08-06T07:50:16.629234Z","caller":"traceutil/trace.go:171","msg":"trace[731803515] range","detail":"{range_begin:/registry/serviceaccounts/capi-kubeadm-control-plane-system/capi-kubeadm-control-plane-manager; range_end:; response_count:1; response_revision:22605; }","duration":"161.453141ms","start":"2026-08-06T07:50:16.467774Z","end":"2026-08-06T07:50:16.629227Z","steps":["trace[731803515] 'agreement among raft nodes before linearized reading' (duration: 161.332738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:50:16.629403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.147212ms","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-06T07:50:16.629501Z","caller":"traceutil/trace.go:171","msg":"trace[691225733] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22605; }","duration":"134.293675ms","start":"2026-08-06T07:50:16.495187Z","end":"2026-08-06T07:50:16.629481Z","steps":["trace[691225733] 'agreement among raft nodes before linearized reading' (duration: 134.022559ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:51:02.751581Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20048} {"level":"info","ts":"2026-08-06T07:51:02.857131Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20048,"took":"102.293118ms","hash":3810212626,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":42541056,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-08-06T07:51:02.857204Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3810212626,"revision":20048,"compact-revision":17744} {"level":"info","ts":"2026-08-06T07:53:27.037778Z","caller":"traceutil/trace.go:171","msg":"trace[1529527964] transaction","detail":"{read_only:false; response_revision:24545; number_of_response:1; }","duration":"272.035996ms","start":"2026-08-06T07:53:26.765704Z","end":"2026-08-06T07:53:27.03774Z","steps":["trace[1529527964] 'process raft request' (duration: 271.783411ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:27.233667Z","caller":"traceutil/trace.go:171","msg":"trace[1349960658] linearizableReadLoop","detail":"{readStateIndex:25350; appliedIndex:25346; }","duration":"195.672349ms","start":"2026-08-06T07:53:27.03797Z","end":"2026-08-06T07:53:27.233643Z","steps":["trace[1349960658] 'read index received' (duration: 195.480775ms)","trace[1349960658] 'applied index is now lower than readState.Index' (duration: 190.624µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:27.233972Z","caller":"traceutil/trace.go:171","msg":"trace[694173308] transaction","detail":"{read_only:false; response_revision:24546; number_of_response:1; }","duration":"467.113071ms","start":"2026-08-06T07:53:26.76684Z","end":"2026-08-06T07:53:27.233953Z","steps":["trace[694173308] 'process raft request' (duration: 466.535729ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.23409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:26.766805Z","time spent":"467.192683ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:27.234209Z","caller":"traceutil/trace.go:171","msg":"trace[1260022] transaction","detail":"{read_only:false; response_revision:24549; number_of_response:1; }","duration":"375.461828ms","start":"2026-08-06T07:53:26.858691Z","end":"2026-08-06T07:53:27.234153Z","steps":["trace[1260022] 'process raft request' (duration: 374.918486ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.234371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.369923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-08-06T07:53:27.234402Z","caller":"traceutil/trace.go:171","msg":"trace[207181220] transaction","detail":"{read_only:false; response_revision:24548; number_of_response:1; }","duration":"465.632839ms","start":"2026-08-06T07:53:26.768749Z","end":"2026-08-06T07:53:27.234382Z","steps":["trace[207181220] 'process raft request' (duration: 464.829511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.234428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:26.858656Z","time spent":"375.651922ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:27.23445Z","caller":"traceutil/trace.go:171","msg":"trace[469027718] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24549; }","duration":"196.524097ms","start":"2026-08-06T07:53:27.037905Z","end":"2026-08-06T07:53:27.234429Z","steps":["trace[469027718] 'agreement among raft nodes before linearized reading' (duration: 196.241961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.23447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:26.76871Z","time spent":"465.728851ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:27.234864Z","caller":"traceutil/trace.go:171","msg":"trace[1576107212] transaction","detail":"{read_only:false; response_revision:24547; number_of_response:1; }","duration":"465.794463ms","start":"2026-08-06T07:53:26.768549Z","end":"2026-08-06T07:53:27.234344Z","steps":["trace[1576107212] 'process raft request' (duration: 464.986515ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.234947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:26.768535Z","time spent":"466.351804ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:27.485201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.587875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:53:27.485328Z","caller":"traceutil/trace.go:171","msg":"trace[858959881] linearizableReadLoop","detail":"{readStateIndex:25351; appliedIndex:25350; }","duration":"251.567206ms","start":"2026-08-06T07:53:27.233736Z","end":"2026-08-06T07:53:27.485303Z","steps":["trace[858959881] 'read index received' (duration: 117.754627ms)","trace[858959881] 'applied index is now lower than readState.Index' (duration: 133.810149ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:27.48542Z","caller":"traceutil/trace.go:171","msg":"trace[1035955517] transaction","detail":"{read_only:false; response_revision:24550; number_of_response:1; }","duration":"351.903271ms","start":"2026-08-06T07:53:27.133505Z","end":"2026-08-06T07:53:27.485408Z","steps":["trace[1035955517] 'process raft request' (duration: 218.004039ms)","trace[1035955517] 'compare' (duration: 133.40378ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:27.485497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:27.133456Z","time spent":"351.999823ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:27.485593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.054944ms","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-06T07:53:27.485689Z","caller":"traceutil/trace.go:171","msg":"trace[1852205109] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24550; }","duration":"433.192646ms","start":"2026-08-06T07:53:27.052475Z","end":"2026-08-06T07:53:27.485667Z","steps":["trace[1852205109] 'agreement among raft nodes before linearized reading' (duration: 432.944131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.485729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:27.052461Z","time spent":"433.258978ms","remote":"127.0.0.1:34898","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-06T07:53:27.485764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.551133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:27.485854Z","caller":"traceutil/trace.go:171","msg":"trace[563004586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24550; }","duration":"264.687616ms","start":"2026-08-06T07:53:27.221139Z","end":"2026-08-06T07:53:27.485826Z","steps":["trace[563004586] 'agreement among raft nodes before linearized reading' (duration: 264.521132ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.485932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.15769ms","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-06T07:53:27.486046Z","caller":"traceutil/trace.go:171","msg":"trace[661037893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24550; }","duration":"445.412825ms","start":"2026-08-06T07:53:27.04061Z","end":"2026-08-06T07:53:27.486023Z","steps":["trace[661037893] 'agreement among raft nodes before linearized reading' (duration: 445.047797ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.486124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:27.040587Z","time spent":"445.526447ms","remote":"127.0.0.1:34898","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-06T07:53:27.486299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.9861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-06T07:53:27.486406Z","caller":"traceutil/trace.go:171","msg":"trace[443808691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24550; }","duration":"442.153653ms","start":"2026-08-06T07:53:27.044229Z","end":"2026-08-06T07:53:27.486382Z","steps":["trace[443808691] 'agreement among raft nodes before linearized reading' (duration: 441.755314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:27.48648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:27.044219Z","time spent":"442.225705ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-06T07:53:27.536305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.189153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-06T07:53:27.536327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.717541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-08-06T07:53:27.536391Z","caller":"traceutil/trace.go:171","msg":"trace[677723062] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24551; }","duration":"228.325086ms","start":"2026-08-06T07:53:27.308044Z","end":"2026-08-06T07:53:27.536369Z","steps":["trace[677723062] 'agreement among raft nodes before linearized reading' (duration: 228.184963ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:27.536421Z","caller":"traceutil/trace.go:171","msg":"trace[111594522] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24551; }","duration":"292.857094ms","start":"2026-08-06T07:53:27.243541Z","end":"2026-08-06T07:53:27.536398Z","steps":["trace[111594522] 'agreement among raft nodes before linearized reading' (duration: 292.580538ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:31.734057Z","caller":"traceutil/trace.go:171","msg":"trace[1224398142] transaction","detail":"{read_only:false; response_revision:24582; number_of_response:1; }","duration":"120.184ms","start":"2026-08-06T07:53:31.613825Z","end":"2026-08-06T07:53:31.734009Z","steps":["trace[1224398142] 'process raft request' (duration: 114.070796ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:31.969056Z","caller":"traceutil/trace.go:171","msg":"trace[65824095] transaction","detail":"{read_only:false; response_revision:24587; number_of_response:1; }","duration":"353.086506ms","start":"2026-08-06T07:53:31.615947Z","end":"2026-08-06T07:53:31.969034Z","steps":["trace[65824095] 'process raft request' (duration: 353.054896ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:31.9692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:31.615923Z","time spent":"353.200539ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:31.969288Z","caller":"traceutil/trace.go:171","msg":"trace[1916028210] transaction","detail":"{read_only:false; response_revision:24583; number_of_response:1; }","duration":"355.052ms","start":"2026-08-06T07:53:31.614199Z","end":"2026-08-06T07:53:31.969251Z","steps":["trace[1916028210] 'process raft request' (duration: 354.539849ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:31.969295Z","caller":"traceutil/trace.go:171","msg":"trace[1584148111] transaction","detail":"{read_only:false; response_revision:24585; number_of_response:1; }","duration":"354.371355ms","start":"2026-08-06T07:53:31.614898Z","end":"2026-08-06T07:53:31.96927Z","steps":["trace[1584148111] 'process raft request' (duration: 354.055518ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:31.969475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:31.614189Z","time spent":"355.186933ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:31.969501Z","caller":"traceutil/trace.go:171","msg":"trace[1137557336] transaction","detail":"{read_only:false; response_revision:24586; number_of_response:1; }","duration":"354.443835ms","start":"2026-08-06T07:53:31.615048Z","end":"2026-08-06T07:53:31.969492Z","steps":["trace[1137557336] 'process raft request' (duration: 353.931534ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:31.969581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:31.615012Z","time spent":"354.514127ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:31.969733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:31.614874Z","time spent":"354.563338ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:31.971855Z","caller":"traceutil/trace.go:171","msg":"trace[805576257] transaction","detail":"{read_only:false; response_revision:24584; number_of_response:1; }","duration":"354.294383ms","start":"2026-08-06T07:53:31.614885Z","end":"2026-08-06T07:53:31.969179Z","steps":["trace[805576257] 'process raft request' (duration: 354.037397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:31.972315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:31.614865Z","time spent":"357.079324ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:32.154997Z","caller":"traceutil/trace.go:171","msg":"trace[19311766] transaction","detail":"{read_only:false; response_revision:24588; number_of_response:1; }","duration":"106.94251ms","start":"2026-08-06T07:53:32.048028Z","end":"2026-08-06T07:53:32.15497Z","steps":["trace[19311766] 'process raft request' (duration: 102.784578ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:32.644426Z","caller":"traceutil/trace.go:171","msg":"trace[305270940] transaction","detail":"{read_only:false; response_revision:24589; number_of_response:1; }","duration":"151.742433ms","start":"2026-08-06T07:53:32.492645Z","end":"2026-08-06T07:53:32.644387Z","steps":["trace[305270940] 'process raft request' (duration: 151.507608ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:33.387753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.857329ms","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-06T07:53:33.387883Z","caller":"traceutil/trace.go:171","msg":"trace[413649955] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24590; }","duration":"183.999572ms","start":"2026-08-06T07:53:33.203865Z","end":"2026-08-06T07:53:33.387864Z","steps":["trace[413649955] 'range keys from in-memory index tree' (duration: 183.812828ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:33.417541Z","caller":"traceutil/trace.go:171","msg":"trace[118774092] linearizableReadLoop","detail":"{readStateIndex:25393; appliedIndex:25392; }","duration":"196.353674ms","start":"2026-08-06T07:53:33.221163Z","end":"2026-08-06T07:53:33.417517Z","steps":["trace[118774092] 'read index received' (duration: 196.095758ms)","trace[118774092] 'applied index is now lower than readState.Index' (duration: 257.036µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:33.417682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.513857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:33.417723Z","caller":"traceutil/trace.go:171","msg":"trace[684632394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24591; }","duration":"196.627669ms","start":"2026-08-06T07:53:33.221086Z","end":"2026-08-06T07:53:33.417714Z","steps":["trace[684632394] 'agreement among raft nodes before linearized reading' (duration: 196.526687ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:33.418019Z","caller":"traceutil/trace.go:171","msg":"trace[481168226] transaction","detail":"{read_only:false; response_revision:24591; number_of_response:1; }","duration":"342.32753ms","start":"2026-08-06T07:53:33.075672Z","end":"2026-08-06T07:53:33.418Z","steps":["trace[481168226] 'process raft request' (duration: 341.674766ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:33.418136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:33.075653Z","time spent":"342.421262ms","remote":"127.0.0.1:50010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7897,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:33.662443Z","caller":"traceutil/trace.go:171","msg":"trace[1495547913] transaction","detail":"{read_only:false; response_revision:24592; number_of_response:1; }","duration":"406.589362ms","start":"2026-08-06T07:53:33.25583Z","end":"2026-08-06T07:53:33.66242Z","steps":["trace[1495547913] 'process raft request' (duration: 397.607634ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:33.662586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:33.255791Z","time spent":"406.722765ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:33.662715Z","caller":"traceutil/trace.go:171","msg":"trace[193995510] transaction","detail":"{read_only:false; response_revision:24593; number_of_response:1; }","duration":"404.098678ms","start":"2026-08-06T07:53:33.258594Z","end":"2026-08-06T07:53:33.662692Z","steps":["trace[193995510] 'process raft request' (duration: 403.785421ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:33.66287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:33.258569Z","time spent":"404.21771ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:33.663195Z","caller":"traceutil/trace.go:171","msg":"trace[351912538] transaction","detail":"{read_only:false; response_revision:24594; number_of_response:1; }","duration":"404.227ms","start":"2026-08-06T07:53:33.258949Z","end":"2026-08-06T07:53:33.663177Z","steps":["trace[351912538] 'process raft request' (duration: 403.659727ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:33.663228Z","caller":"traceutil/trace.go:171","msg":"trace[1068238231] transaction","detail":"{read_only:false; response_revision:24595; number_of_response:1; }","duration":"403.519054ms","start":"2026-08-06T07:53:33.259693Z","end":"2026-08-06T07:53:33.663212Z","steps":["trace[1068238231] 'process raft request' (duration: 403.394822ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:33.663209Z","caller":"traceutil/trace.go:171","msg":"trace[48324773] linearizableReadLoop","detail":"{readStateIndex:25397; appliedIndex:25393; }","duration":"242.868756ms","start":"2026-08-06T07:53:33.420316Z","end":"2026-08-06T07:53:33.663185Z","steps":["trace[48324773] 'read index received' (duration: 233.133522ms)","trace[48324773] 'applied index is now lower than readState.Index' (duration: 9.734254ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:33.663274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:33.258906Z","time spent":"404.332322ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:33.663292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:33.259678Z","time spent":"403.579645ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:33.66341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.07741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:33.663495Z","caller":"traceutil/trace.go:171","msg":"trace[402859548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24595; }","duration":"243.311625ms","start":"2026-08-06T07:53:33.420162Z","end":"2026-08-06T07:53:33.663474Z","steps":["trace[402859548] 'agreement among raft nodes before linearized reading' (duration: 243.177212ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:33.84755Z","caller":"traceutil/trace.go:171","msg":"trace[1140385868] linearizableReadLoop","detail":"{readStateIndex:25398; appliedIndex:25397; }","duration":"184.219528ms","start":"2026-08-06T07:53:33.663308Z","end":"2026-08-06T07:53:33.847528Z","steps":["trace[1140385868] 'read index received' (duration: 173.84575ms)","trace[1140385868] 'applied index is now lower than readState.Index' (duration: 10.372848ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:33.847804Z","caller":"traceutil/trace.go:171","msg":"trace[1891360634] transaction","detail":"{read_only:false; response_revision:24596; number_of_response:1; }","duration":"229.559714ms","start":"2026-08-06T07:53:33.61823Z","end":"2026-08-06T07:53:33.84779Z","steps":["trace[1891360634] 'process raft request' (duration: 218.985701ms)","trace[1891360634] 'compare' (duration: 10.170824ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:33.848035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.882705ms","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":"info","ts":"2026-08-06T07:53:33.84808Z","caller":"traceutil/trace.go:171","msg":"trace[1807921256] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:24596; }","duration":"262.945157ms","start":"2026-08-06T07:53:33.585123Z","end":"2026-08-06T07:53:33.848068Z","steps":["trace[1807921256] 'agreement among raft nodes before linearized reading' (duration: 262.857465ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:33.84817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.159314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18230"} {"level":"warn","ts":"2026-08-06T07:53:33.848205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.820701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-06T07:53:33.848262Z","caller":"traceutil/trace.go:171","msg":"trace[487173025] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:24596; }","duration":"422.288127ms","start":"2026-08-06T07:53:33.425954Z","end":"2026-08-06T07:53:33.848243Z","steps":["trace[487173025] 'agreement among raft nodes before linearized reading' (duration: 422.102313ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:33.848263Z","caller":"traceutil/trace.go:171","msg":"trace[1311426317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24596; }","duration":"108.917842ms","start":"2026-08-06T07:53:33.739332Z","end":"2026-08-06T07:53:33.84825Z","steps":["trace[1311426317] 'agreement among raft nodes before linearized reading' (duration: 108.763369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:33.848305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:33.425942Z","time spent":"422.353778ms","remote":"127.0.0.1:34794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":18253,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" "} {"level":"warn","ts":"2026-08-06T07:53:34.111309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.806175ms","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-06T07:53:34.111399Z","caller":"traceutil/trace.go:171","msg":"trace[1804455190] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24597; }","duration":"126.948229ms","start":"2026-08-06T07:53:33.984431Z","end":"2026-08-06T07:53:34.111379Z","steps":["trace[1804455190] 'range keys from in-memory index tree' (duration: 126.660003ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:34.111882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.090551ms","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-06T07:53:34.111931Z","caller":"traceutil/trace.go:171","msg":"trace[806342362] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24597; }","duration":"136.186163ms","start":"2026-08-06T07:53:33.975731Z","end":"2026-08-06T07:53:34.111917Z","steps":["trace[806342362] 'range keys from in-memory index tree' (duration: 135.937926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:34.111999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.734626ms","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-06T07:53:34.112077Z","caller":"traceutil/trace.go:171","msg":"trace[901899257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24597; }","duration":"132.836698ms","start":"2026-08-06T07:53:33.979223Z","end":"2026-08-06T07:53:34.11206Z","steps":["trace[901899257] 'range keys from in-memory index tree' (duration: 132.597802ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:34.112406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.707061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-08-06T07:53:34.112457Z","caller":"traceutil/trace.go:171","msg":"trace[2118175541] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24597; }","duration":"135.774333ms","start":"2026-08-06T07:53:33.976661Z","end":"2026-08-06T07:53:34.112435Z","steps":["trace[2118175541] 'range keys from in-memory index tree' (duration: 135.595269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:34.112728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.455114ms","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-06T07:53:34.112805Z","caller":"traceutil/trace.go:171","msg":"trace[1757281027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24597; }","duration":"134.571186ms","start":"2026-08-06T07:53:33.978216Z","end":"2026-08-06T07:53:34.112788Z","steps":["trace[1757281027] 'range keys from in-memory index tree' (duration: 134.127307ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:34.298735Z","caller":"traceutil/trace.go:171","msg":"trace[1691627734] transaction","detail":"{read_only:false; response_revision:24599; number_of_response:1; }","duration":"180.964646ms","start":"2026-08-06T07:53:34.117744Z","end":"2026-08-06T07:53:34.298709Z","steps":["trace[1691627734] 'process raft request' (duration: 180.517667ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:34.298853Z","caller":"traceutil/trace.go:171","msg":"trace[496950854] transaction","detail":"{read_only:false; response_revision:24602; number_of_response:1; }","duration":"176.410185ms","start":"2026-08-06T07:53:34.122336Z","end":"2026-08-06T07:53:34.298746Z","steps":["trace[496950854] 'process raft request' (duration: 176.360074ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:34.298948Z","caller":"traceutil/trace.go:171","msg":"trace[2038425381] transaction","detail":"{read_only:false; response_revision:24601; number_of_response:1; }","duration":"178.120063ms","start":"2026-08-06T07:53:34.120816Z","end":"2026-08-06T07:53:34.298936Z","steps":["trace[2038425381] 'process raft request' (duration: 177.831567ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:34.298867Z","caller":"traceutil/trace.go:171","msg":"trace[1444346501] transaction","detail":"{read_only:false; response_revision:24600; number_of_response:1; }","duration":"180.856354ms","start":"2026-08-06T07:53:34.117978Z","end":"2026-08-06T07:53:34.298834Z","steps":["trace[1444346501] 'process raft request' (duration: 180.626059ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:34.299344Z","caller":"traceutil/trace.go:171","msg":"trace[487407643] transaction","detail":"{read_only:false; response_revision:24603; number_of_response:1; }","duration":"135.20271ms","start":"2026-08-06T07:53:34.164124Z","end":"2026-08-06T07:53:34.299326Z","steps":["trace[487407643] 'process raft request' (duration: 135.057586ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:35.233574Z","caller":"traceutil/trace.go:171","msg":"trace[1524281693] transaction","detail":"{read_only:false; response_revision:24604; number_of_response:1; }","duration":"311.659526ms","start":"2026-08-06T07:53:34.921863Z","end":"2026-08-06T07:53:35.233522Z","steps":["trace[1524281693] 'process raft request' (duration: 311.329489ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:35.23366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.668943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:35.23371Z","caller":"traceutil/trace.go:171","msg":"trace[1955439817] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24604; }","duration":"238.739895ms","start":"2026-08-06T07:53:34.994956Z","end":"2026-08-06T07:53:35.233696Z","steps":["trace[1955439817] 'agreement among raft nodes before linearized reading' (duration: 238.631502ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:35.233787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:34.921833Z","time spent":"311.839111ms","remote":"127.0.0.1:41724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418382,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:35.233523Z","caller":"traceutil/trace.go:171","msg":"trace[1970831336] linearizableReadLoop","detail":"{readStateIndex:25406; appliedIndex:25405; }","duration":"238.5086ms","start":"2026-08-06T07:53:34.994971Z","end":"2026-08-06T07:53:35.23348Z","steps":["trace[1970831336] 'read index received' (duration: 238.192133ms)","trace[1970831336] 'applied index is now lower than readState.Index' (duration: 315.597µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:35.485651Z","caller":"traceutil/trace.go:171","msg":"trace[1199620556] linearizableReadLoop","detail":"{readStateIndex:25407; appliedIndex:25406; }","duration":"251.606966ms","start":"2026-08-06T07:53:35.233998Z","end":"2026-08-06T07:53:35.485605Z","steps":["trace[1199620556] 'read index received' (duration: 212.628001ms)","trace[1199620556] 'applied index is now lower than readState.Index' (duration: 38.977455ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:35.48572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.122286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-06T07:53:35.485762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.591082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T07:53:35.485842Z","caller":"traceutil/trace.go:171","msg":"trace[1458361144] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:24605; }","duration":"330.737456ms","start":"2026-08-06T07:53:35.155084Z","end":"2026-08-06T07:53:35.485821Z","steps":["trace[1458361144] 'agreement among raft nodes before linearized reading' (duration: 330.563321ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:35.485794Z","caller":"traceutil/trace.go:171","msg":"trace[1038722708] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24605; }","duration":"266.244059ms","start":"2026-08-06T07:53:35.219532Z","end":"2026-08-06T07:53:35.485777Z","steps":["trace[1038722708] 'agreement among raft nodes before linearized reading' (duration: 266.105316ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:35.48585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.781191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-06T07:53:35.485895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:35.155062Z","time spent":"330.821908ms","remote":"127.0.0.1:34766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":14,"response size":31,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-08-06T07:53:35.485949Z","caller":"traceutil/trace.go:171","msg":"trace[1951728815] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:24605; }","duration":"418.929133ms","start":"2026-08-06T07:53:35.066996Z","end":"2026-08-06T07:53:35.485926Z","steps":["trace[1951728815] 'agreement among raft nodes before linearized reading' (duration: 418.754099ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:35.485964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.854446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T07:53:35.486024Z","caller":"traceutil/trace.go:171","msg":"trace[680465280] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:24605; }","duration":"120.962838ms","start":"2026-08-06T07:53:35.365045Z","end":"2026-08-06T07:53:35.486008Z","steps":["trace[680465280] 'agreement among raft nodes before linearized reading' (duration: 120.807075ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:35.486021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:35.06698Z","time spent":"419.029086ms","remote":"127.0.0.1:36198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "} {"level":"info","ts":"2026-08-06T07:53:35.48566Z","caller":"traceutil/trace.go:171","msg":"trace[1805734497] transaction","detail":"{read_only:false; response_revision:24605; number_of_response:1; }","duration":"348.011076ms","start":"2026-08-06T07:53:35.137601Z","end":"2026-08-06T07:53:35.485612Z","steps":["trace[1805734497] 'process raft request' (duration: 308.989419ms)","trace[1805734497] 'compare' (duration: 38.795062ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:35.486413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:35.137572Z","time spent":"348.687281ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:35.485864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.803184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:35.486519Z","caller":"traceutil/trace.go:171","msg":"trace[602571858] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24605; }","duration":"248.463719ms","start":"2026-08-06T07:53:35.238038Z","end":"2026-08-06T07:53:35.486501Z","steps":["trace[602571858] 'agreement among raft nodes before linearized reading' (duration: 247.800775ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:35.813852Z","caller":"traceutil/trace.go:171","msg":"trace[899227863] transaction","detail":"{read_only:false; response_revision:24606; number_of_response:1; }","duration":"145.483316ms","start":"2026-08-06T07:53:35.668325Z","end":"2026-08-06T07:53:35.813809Z","steps":["trace[899227863] 'process raft request' (duration: 145.175449ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:36.105031Z","caller":"traceutil/trace.go:171","msg":"trace[2101571574] transaction","detail":"{read_only:false; response_revision:24607; number_of_response:1; }","duration":"432.922071ms","start":"2026-08-06T07:53:35.67208Z","end":"2026-08-06T07:53:36.105002Z","steps":["trace[2101571574] 'process raft request' (duration: 407.329958ms)","trace[2101571574] 'compare' (duration: 25.369427ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:36.105208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:35.67205Z","time spent":"433.058325ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:36.105317Z","caller":"traceutil/trace.go:171","msg":"trace[2109299763] linearizableReadLoop","detail":"{readStateIndex:25411; appliedIndex:25408; }","duration":"285.834509ms","start":"2026-08-06T07:53:35.819451Z","end":"2026-08-06T07:53:36.105285Z","steps":["trace[2109299763] 'read index received' (duration: 259.883479ms)","trace[2109299763] 'applied index is now lower than readState.Index' (duration: 25.94953ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:36.105449Z","caller":"traceutil/trace.go:171","msg":"trace[354216453] transaction","detail":"{read_only:false; response_revision:24609; number_of_response:1; }","duration":"421.846028ms","start":"2026-08-06T07:53:35.683589Z","end":"2026-08-06T07:53:36.105435Z","steps":["trace[354216453] 'process raft request' (duration: 421.590142ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:36.105437Z","caller":"traceutil/trace.go:171","msg":"trace[125354516] transaction","detail":"{read_only:false; response_revision:24608; number_of_response:1; }","duration":"432.667896ms","start":"2026-08-06T07:53:35.672724Z","end":"2026-08-06T07:53:36.105391Z","steps":["trace[125354516] 'process raft request' (duration: 432.231326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.105594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:35.683567Z","time spent":"421.90954ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:36.105661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:35.672693Z","time spent":"432.86391ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:36.105736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.269458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.108\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-08-06T07:53:36.105825Z","caller":"traceutil/trace.go:171","msg":"trace[277690753] range","detail":"{range_begin:/registry/masterleases/199.19.213.108; range_end:; response_count:1; response_revision:24609; }","duration":"286.430053ms","start":"2026-08-06T07:53:35.819373Z","end":"2026-08-06T07:53:36.105803Z","steps":["trace[277690753] 'agreement among raft nodes before linearized reading' (duration: 286.093525ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.1084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.267648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-06T07:53:36.108525Z","caller":"traceutil/trace.go:171","msg":"trace[1722612157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24610; }","duration":"245.418222ms","start":"2026-08-06T07:53:35.863076Z","end":"2026-08-06T07:53:36.108494Z","steps":["trace[1722612157] 'agreement among raft nodes before linearized reading' (duration: 245.050694ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:36.108745Z","caller":"traceutil/trace.go:171","msg":"trace[1029156216] transaction","detail":"{read_only:false; response_revision:24610; number_of_response:1; }","duration":"251.094837ms","start":"2026-08-06T07:53:35.857633Z","end":"2026-08-06T07:53:36.108728Z","steps":["trace[1029156216] 'process raft request' (duration: 250.295159ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:36.308511Z","caller":"traceutil/trace.go:171","msg":"trace[1267221793] linearizableReadLoop","detail":"{readStateIndex:25414; appliedIndex:25412; }","duration":"169.729638ms","start":"2026-08-06T07:53:36.138759Z","end":"2026-08-06T07:53:36.308488Z","steps":["trace[1267221793] 'read index received' (duration: 102.656564ms)","trace[1267221793] 'applied index is now lower than readState.Index' (duration: 67.071964ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:36.309027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.690847ms","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-06T07:53:36.309004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.227219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18230"} {"level":"info","ts":"2026-08-06T07:53:36.30906Z","caller":"traceutil/trace.go:171","msg":"trace[1732184408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24611; }","duration":"164.775389ms","start":"2026-08-06T07:53:36.144274Z","end":"2026-08-06T07:53:36.309049Z","steps":["trace[1732184408] 'agreement among raft nodes before linearized reading' (duration: 164.548764ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:36.309091Z","caller":"traceutil/trace.go:171","msg":"trace[1135841982] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24611; }","duration":"170.363272ms","start":"2026-08-06T07:53:36.138706Z","end":"2026-08-06T07:53:36.30907Z","steps":["trace[1135841982] 'agreement among raft nodes before linearized reading' (duration: 170.067836ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:36.309514Z","caller":"traceutil/trace.go:171","msg":"trace[10704208] transaction","detail":"{read_only:false; response_revision:24611; number_of_response:1; }","duration":"195.192569ms","start":"2026-08-06T07:53:36.114305Z","end":"2026-08-06T07:53:36.309498Z","steps":["trace[10704208] 'process raft request' (duration: 194.044563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.623352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.645662ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:53:36.623479Z","caller":"traceutil/trace.go:171","msg":"trace[925498059] linearizableReadLoop","detail":"{readStateIndex:25415; appliedIndex:25414; }","duration":"304.601332ms","start":"2026-08-06T07:53:36.318857Z","end":"2026-08-06T07:53:36.623459Z","steps":["trace[925498059] 'read index received' (duration: 157.765325ms)","trace[925498059] 'applied index is now lower than readState.Index' (duration: 146.834387ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:36.623521Z","caller":"traceutil/trace.go:171","msg":"trace[1563308416] transaction","detail":"{read_only:false; response_revision:24612; number_of_response:1; }","duration":"304.896798ms","start":"2026-08-06T07:53:36.318593Z","end":"2026-08-06T07:53:36.62349Z","steps":["trace[1563308416] 'process raft request' (duration: 158.013841ms)","trace[1563308416] 'compare' (duration: 146.505348ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:36.623643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:36.318572Z","time spent":"305.01321ms","remote":"127.0.0.1:34662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:36.623712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.849347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-06T07:53:36.623778Z","caller":"traceutil/trace.go:171","msg":"trace[1407824679] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24612; }","duration":"304.94204ms","start":"2026-08-06T07:53:36.3188Z","end":"2026-08-06T07:53:36.623742Z","steps":["trace[1407824679] 'agreement among raft nodes before linearized reading' (duration: 304.739315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.623828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:36.318775Z","time spent":"305.041811ms","remote":"127.0.0.1:34804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-06T07:53:36.765689Z","caller":"traceutil/trace.go:171","msg":"trace[629655341] transaction","detail":"{read_only:false; response_revision:24613; number_of_response:1; }","duration":"446.735834ms","start":"2026-08-06T07:53:36.318911Z","end":"2026-08-06T07:53:36.765647Z","steps":["trace[629655341] 'process raft request' (duration: 424.140997ms)","trace[629655341] 'compare' (duration: 22.382552ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:36.765812Z","caller":"traceutil/trace.go:171","msg":"trace[1140673910] linearizableReadLoop","detail":"{readStateIndex:25421; appliedIndex:25415; }","duration":"142.279545ms","start":"2026-08-06T07:53:36.623511Z","end":"2026-08-06T07:53:36.765791Z","steps":["trace[1140673910] 'read index received' (duration: 119.558545ms)","trace[1140673910] 'applied index is now lower than readState.Index' (duration: 22.71964ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:36.765838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:36.318898Z","time spent":"446.862306ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:36.765914Z","caller":"traceutil/trace.go:171","msg":"trace[540086407] transaction","detail":"{read_only:false; response_revision:24614; number_of_response:1; }","duration":"446.981299ms","start":"2026-08-06T07:53:36.318922Z","end":"2026-08-06T07:53:36.765904Z","steps":["trace[540086407] 'process raft request' (duration: 446.657602ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.765986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:36.318915Z","time spent":"447.02161ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:36.766036Z","caller":"traceutil/trace.go:171","msg":"trace[1418931478] transaction","detail":"{read_only:false; response_revision:24618; number_of_response:1; }","duration":"444.052504ms","start":"2026-08-06T07:53:36.321951Z","end":"2026-08-06T07:53:36.766003Z","steps":["trace[1418931478] 'process raft request' (duration: 443.798639ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.766109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.987309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:36.766149Z","caller":"traceutil/trace.go:171","msg":"trace[2017278091] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:24618; }","duration":"213.056532ms","start":"2026-08-06T07:53:36.553078Z","end":"2026-08-06T07:53:36.766135Z","steps":["trace[2017278091] 'agreement among raft nodes before linearized reading' (duration: 212.992161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.766189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:36.321939Z","time spent":"444.163698ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:36.766371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.860695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18230"} {"level":"info","ts":"2026-08-06T07:53:36.766395Z","caller":"traceutil/trace.go:171","msg":"trace[1782267702] transaction","detail":"{read_only:false; response_revision:24615; number_of_response:1; }","duration":"447.412109ms","start":"2026-08-06T07:53:36.318973Z","end":"2026-08-06T07:53:36.766385Z","steps":["trace[1782267702] 'process raft request' (duration: 446.657402ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:36.766411Z","caller":"traceutil/trace.go:171","msg":"trace[1693741201] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24618; }","duration":"140.921687ms","start":"2026-08-06T07:53:36.625478Z","end":"2026-08-06T07:53:36.766399Z","steps":["trace[1693741201] 'agreement among raft nodes before linearized reading' (duration: 140.842675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.766455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:36.318965Z","time spent":"447.4553ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:36.766471Z","caller":"traceutil/trace.go:171","msg":"trace[762322912] transaction","detail":"{read_only:false; response_revision:24617; number_of_response:1; }","duration":"447.43764ms","start":"2026-08-06T07:53:36.31902Z","end":"2026-08-06T07:53:36.766457Z","steps":["trace[762322912] 'process raft request' (duration: 446.686353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.766534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:36.318986Z","time spent":"447.513902ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:36.766615Z","caller":"traceutil/trace.go:171","msg":"trace[1682448935] transaction","detail":"{read_only:false; response_revision:24616; number_of_response:1; }","duration":"447.629184ms","start":"2026-08-06T07:53:36.318977Z","end":"2026-08-06T07:53:36.766606Z","steps":["trace[1682448935] 'process raft request' (duration: 446.693393ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:36.766664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.353923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"} {"level":"warn","ts":"2026-08-06T07:53:36.766663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:36.318955Z","time spent":"447.680585ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:36.7667Z","caller":"traceutil/trace.go:171","msg":"trace[575591032] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:24618; }","duration":"140.434935ms","start":"2026-08-06T07:53:36.626255Z","end":"2026-08-06T07:53:36.76669Z","steps":["trace[575591032] 'agreement among raft nodes before linearized reading' (duration: 140.314252ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.211268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.959853ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:53:38.211502Z","caller":"traceutil/trace.go:171","msg":"trace[1147386625] transaction","detail":"{read_only:false; response_revision:24622; number_of_response:1; }","duration":"391.078731ms","start":"2026-08-06T07:53:37.820403Z","end":"2026-08-06T07:53:38.211482Z","steps":["trace[1147386625] 'process raft request' (duration: 390.972688ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:38.211533Z","caller":"traceutil/trace.go:171","msg":"trace[1828354084] transaction","detail":"{read_only:false; response_revision:24621; number_of_response:1; }","duration":"428.438451ms","start":"2026-08-06T07:53:37.783058Z","end":"2026-08-06T07:53:38.211496Z","steps":["trace[1828354084] 'process raft request' (duration: 126.155761ms)","trace[1828354084] 'compare' (duration: 301.35362ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:38.211579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:37.820375Z","time spent":"391.159234ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:38.211706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:37.783035Z","time spent":"428.575175ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:38.472994Z","caller":"traceutil/trace.go:171","msg":"trace[313576914] transaction","detail":"{read_only:false; response_revision:24623; number_of_response:1; }","duration":"359.074138ms","start":"2026-08-06T07:53:38.1139Z","end":"2026-08-06T07:53:38.472974Z","steps":["trace[313576914] 'process raft request' (duration: 337.653927ms)","trace[313576914] 'compare' (duration: 21.240797ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:38.473129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:38.113876Z","time spent":"359.17636ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:38.473351Z","caller":"traceutil/trace.go:171","msg":"trace[377671546] linearizableReadLoop","detail":"{readStateIndex:25429; appliedIndex:25425; }","duration":"338.867034ms","start":"2026-08-06T07:53:38.13446Z","end":"2026-08-06T07:53:38.473327Z","steps":["trace[377671546] 'read index received' (duration: 317.3108ms)","trace[377671546] 'applied index is now lower than readState.Index' (duration: 21.555094ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:38.473407Z","caller":"traceutil/trace.go:171","msg":"trace[42036778] transaction","detail":"{read_only:false; response_revision:24625; number_of_response:1; }","duration":"357.183257ms","start":"2026-08-06T07:53:38.116216Z","end":"2026-08-06T07:53:38.473399Z","steps":["trace[42036778] 'process raft request' (duration: 356.954452ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:38.473358Z","caller":"traceutil/trace.go:171","msg":"trace[206971978] transaction","detail":"{read_only:false; response_revision:24624; number_of_response:1; }","duration":"357.166927ms","start":"2026-08-06T07:53:38.116144Z","end":"2026-08-06T07:53:38.473311Z","steps":["trace[206971978] 'process raft request' (duration: 356.795529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.473455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:38.116211Z","time spent":"357.218417ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:38.473486Z","caller":"traceutil/trace.go:171","msg":"trace[156209966] transaction","detail":"{read_only:false; response_revision:24626; number_of_response:1; }","duration":"357.036593ms","start":"2026-08-06T07:53:38.116436Z","end":"2026-08-06T07:53:38.473473Z","steps":["trace[156209966] 'process raft request' (duration: 356.837229ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.473584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:38.11612Z","time spent":"357.33475ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:38.47361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:38.116418Z","time spent":"357.104254ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:38.473751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.286683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:38.473797Z","caller":"traceutil/trace.go:171","msg":"trace[1943806264] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:24626; }","duration":"339.330234ms","start":"2026-08-06T07:53:38.134451Z","end":"2026-08-06T07:53:38.473782Z","steps":["trace[1943806264] 'agreement among raft nodes before linearized reading' (duration: 339.262273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.473837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:38.134399Z","time spent":"339.428597ms","remote":"127.0.0.1:40570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":144,"response count":0,"response size":29,"request content":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true "} {"level":"warn","ts":"2026-08-06T07:53:38.474044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.11888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:38.474079Z","caller":"traceutil/trace.go:171","msg":"trace[87263875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24626; }","duration":"253.185121ms","start":"2026-08-06T07:53:38.220885Z","end":"2026-08-06T07:53:38.47407Z","steps":["trace[87263875] 'agreement among raft nodes before linearized reading' (duration: 253.13195ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.474537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.836183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-06T07:53:38.474579Z","caller":"traceutil/trace.go:171","msg":"trace[570628848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24626; }","duration":"150.902924ms","start":"2026-08-06T07:53:38.323666Z","end":"2026-08-06T07:53:38.474569Z","steps":["trace[570628848] 'agreement among raft nodes before linearized reading' (duration: 150.774291ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:38.886296Z","caller":"traceutil/trace.go:171","msg":"trace[786948096] linearizableReadLoop","detail":"{readStateIndex:25431; appliedIndex:25430; }","duration":"114.148726ms","start":"2026-08-06T07:53:38.77212Z","end":"2026-08-06T07:53:38.886269Z","steps":["trace[786948096] 'read index received' (duration: 114.003083ms)","trace[786948096] 'applied index is now lower than readState.Index' (duration: 144.313µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:38.886443Z","caller":"traceutil/trace.go:171","msg":"trace[1343064429] transaction","detail":"{read_only:false; response_revision:24628; number_of_response:1; }","duration":"115.481327ms","start":"2026-08-06T07:53:38.770914Z","end":"2026-08-06T07:53:38.886395Z","steps":["trace[1343064429] 'process raft request' (duration: 115.15901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.88875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.512619ms","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-06T07:53:38.888893Z","caller":"traceutil/trace.go:171","msg":"trace[1657111392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24628; }","duration":"116.794394ms","start":"2026-08-06T07:53:38.772075Z","end":"2026-08-06T07:53:38.888869Z","steps":["trace[1657111392] 'agreement among raft nodes before linearized reading' (duration: 114.32372ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:38.987727Z","caller":"traceutil/trace.go:171","msg":"trace[600313680] linearizableReadLoop","detail":"{readStateIndex:25432; appliedIndex:25431; }","duration":"101.334257ms","start":"2026-08-06T07:53:38.886367Z","end":"2026-08-06T07:53:38.987702Z","steps":["trace[600313680] 'read index received' (duration: 101.285636ms)","trace[600313680] 'applied index is now lower than readState.Index' (duration: 46.971µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:38.987945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.733479ms","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-06T07:53:38.987983Z","caller":"traceutil/trace.go:171","msg":"trace[617671728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24629; }","duration":"215.8063ms","start":"2026-08-06T07:53:38.772167Z","end":"2026-08-06T07:53:38.987973Z","steps":["trace[617671728] 'agreement among raft nodes before linearized reading' (duration: 215.629616ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:38.98828Z","caller":"traceutil/trace.go:171","msg":"trace[1655407386] transaction","detail":"{read_only:false; response_revision:24629; number_of_response:1; }","duration":"216.009685ms","start":"2026-08-06T07:53:38.77226Z","end":"2026-08-06T07:53:38.988269Z","steps":["trace[1655407386] 'process raft request' (duration: 215.278149ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.988466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.678187ms","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-06T07:53:38.9885Z","caller":"traceutil/trace.go:171","msg":"trace[540904205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24629; }","duration":"209.730447ms","start":"2026-08-06T07:53:38.778762Z","end":"2026-08-06T07:53:38.988492Z","steps":["trace[540904205] 'agreement among raft nodes before linearized reading' (duration: 209.634415ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.990568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.42884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-08-06T07:53:38.990652Z","caller":"traceutil/trace.go:171","msg":"trace[509036987] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24630; }","duration":"214.531574ms","start":"2026-08-06T07:53:38.776099Z","end":"2026-08-06T07:53:38.99063Z","steps":["trace[509036987] 'agreement among raft nodes before linearized reading' (duration: 212.505689ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:38.991111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.911887ms","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-06T07:53:38.991142Z","caller":"traceutil/trace.go:171","msg":"trace[674744956] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24630; }","duration":"217.977219ms","start":"2026-08-06T07:53:38.773157Z","end":"2026-08-06T07:53:38.991134Z","steps":["trace[674744956] 'agreement among raft nodes before linearized reading' (duration: 215.434762ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:42.329984Z","caller":"traceutil/trace.go:171","msg":"trace[900255787] transaction","detail":"{read_only:false; response_revision:24651; number_of_response:1; }","duration":"102.524003ms","start":"2026-08-06T07:53:42.227433Z","end":"2026-08-06T07:53:42.329957Z","steps":["trace[900255787] 'process raft request' (duration: 102.357159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:42.903168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.378345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:53:42.903316Z","caller":"traceutil/trace.go:171","msg":"trace[1990342077] transaction","detail":"{read_only:false; response_revision:24652; number_of_response:1; }","duration":"417.673196ms","start":"2026-08-06T07:53:42.485617Z","end":"2026-08-06T07:53:42.90329Z","steps":["trace[1990342077] 'process raft request' (duration: 200.041355ms)","trace[1990342077] 'compare' (duration: 216.297112ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:42.903385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.485591Z","time spent":"417.763938ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:43.398978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.40053ms","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-06T07:53:43.399102Z","caller":"traceutil/trace.go:171","msg":"trace[834370633] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24652; }","duration":"194.540073ms","start":"2026-08-06T07:53:43.204543Z","end":"2026-08-06T07:53:43.399083Z","steps":["trace[834370633] 'range keys from in-memory index tree' (duration: 194.38407ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:43.399794Z","caller":"traceutil/trace.go:171","msg":"trace[2021537817] linearizableReadLoop","detail":"{readStateIndex:25459; appliedIndex:25455; }","duration":"884.263076ms","start":"2026-08-06T07:53:42.515502Z","end":"2026-08-06T07:53:43.399765Z","steps":["trace[2021537817] 'read index received' (duration: 170.081207ms)","trace[2021537817] 'applied index is now lower than readState.Index' (duration: 714.180749ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:43.40011Z","caller":"traceutil/trace.go:171","msg":"trace[115636150] transaction","detail":"{read_only:false; response_revision:24653; number_of_response:1; }","duration":"913.419976ms","start":"2026-08-06T07:53:42.486676Z","end":"2026-08-06T07:53:43.400097Z","steps":["trace[115636150] 'process raft request' (duration: 909.853887ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.400243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.486663Z","time spent":"913.482617ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:43.400296Z","caller":"traceutil/trace.go:171","msg":"trace[1987173165] transaction","detail":"{read_only:false; response_revision:24654; number_of_response:1; }","duration":"913.6161ms","start":"2026-08-06T07:53:42.486658Z","end":"2026-08-06T07:53:43.400274Z","steps":["trace[1987173165] 'process raft request' (duration: 912.919654ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:43.400275Z","caller":"traceutil/trace.go:171","msg":"trace[788599344] transaction","detail":"{read_only:false; response_revision:24655; number_of_response:1; }","duration":"910.497072ms","start":"2026-08-06T07:53:42.489732Z","end":"2026-08-06T07:53:43.400229Z","steps":["trace[788599344] 'process raft request' (duration: 909.972371ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.400438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.486619Z","time spent":"913.736373ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:43.400438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.900589ms","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-06T07:53:43.400458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.489716Z","time spent":"910.653195ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:43.400526Z","caller":"traceutil/trace.go:171","msg":"trace[98742732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24655; }","duration":"885.041573ms","start":"2026-08-06T07:53:42.515465Z","end":"2026-08-06T07:53:43.400507Z","steps":["trace[98742732] 'agreement among raft nodes before linearized reading' (duration: 884.734246ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.400579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.515453Z","time spent":"885.116594ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-06T07:53:43.401383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.865653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-08-06T07:53:43.401431Z","caller":"traceutil/trace.go:171","msg":"trace[1700059720] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24657; }","duration":"815.972545ms","start":"2026-08-06T07:53:42.585447Z","end":"2026-08-06T07:53:43.40142Z","steps":["trace[1700059720] 'agreement among raft nodes before linearized reading' (duration: 815.837332ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.401461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.585401Z","time spent":"816.053776ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":556,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-08-06T07:53:43.401475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.996155ms","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-06T07:53:43.401489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.635416ms","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-06T07:53:43.401535Z","caller":"traceutil/trace.go:171","msg":"trace[910575989] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24657; }","duration":"384.091298ms","start":"2026-08-06T07:53:43.01743Z","end":"2026-08-06T07:53:43.401521Z","steps":["trace[910575989] 'agreement among raft nodes before linearized reading' (duration: 383.892673ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:43.401546Z","caller":"traceutil/trace.go:171","msg":"trace[81511204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24657; }","duration":"377.722818ms","start":"2026-08-06T07:53:43.023805Z","end":"2026-08-06T07:53:43.401528Z","steps":["trace[81511204] 'agreement among raft nodes before linearized reading' (duration: 377.491633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.401576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:43.017412Z","time spent":"384.157119ms","remote":"127.0.0.1:34898","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-06T07:53:43.401619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.435398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:43.401656Z","caller":"traceutil/trace.go:171","msg":"trace[975154592] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:24657; }","duration":"741.517839ms","start":"2026-08-06T07:53:42.660129Z","end":"2026-08-06T07:53:43.401647Z","steps":["trace[975154592] 'agreement among raft nodes before linearized reading' (duration: 741.458938ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.401683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.660072Z","time spent":"741.604422ms","remote":"127.0.0.1:34750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-08-06T07:53:43.401696Z","caller":"traceutil/trace.go:171","msg":"trace[108652316] transaction","detail":"{read_only:false; response_revision:24656; number_of_response:1; }","duration":"694.548158ms","start":"2026-08-06T07:53:42.707138Z","end":"2026-08-06T07:53:43.401686Z","steps":["trace[108652316] 'process raft request' (duration: 693.989956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.401761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.707116Z","time spent":"694.608899ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:43.401845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.418953ms","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-06T07:53:43.401891Z","caller":"traceutil/trace.go:171","msg":"trace[865975271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24657; }","duration":"378.464464ms","start":"2026-08-06T07:53:43.023417Z","end":"2026-08-06T07:53:43.401881Z","steps":["trace[865975271] 'agreement among raft nodes before linearized reading' (duration: 378.346631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.40192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:43.023373Z","time spent":"378.540915ms","remote":"127.0.0.1:34898","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-06T07:53:43.402128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.594797ms","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-06T07:53:43.402179Z","caller":"traceutil/trace.go:171","msg":"trace[1801949352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24657; }","duration":"383.666898ms","start":"2026-08-06T07:53:43.018488Z","end":"2026-08-06T07:53:43.402155Z","steps":["trace[1801949352] 'agreement among raft nodes before linearized reading' (duration: 383.574986ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.402215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:43.018469Z","time spent":"383.73944ms","remote":"127.0.0.1:34898","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":"info","ts":"2026-08-06T07:53:43.401963Z","caller":"traceutil/trace.go:171","msg":"trace[1546980393] transaction","detail":"{read_only:false; response_revision:24657; number_of_response:1; }","duration":"396.379047ms","start":"2026-08-06T07:53:43.005571Z","end":"2026-08-06T07:53:43.40195Z","steps":["trace[1546980393] 'process raft request' (duration: 395.666342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.401582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:43.023789Z","time spent":"377.782909ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-06T07:53:43.402364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:43.005545Z","time spent":"396.777566ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:43.402476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.705948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:43.402513Z","caller":"traceutil/trace.go:171","msg":"trace[440847693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24657; }","duration":"184.772609ms","start":"2026-08-06T07:53:43.217729Z","end":"2026-08-06T07:53:43.402502Z","steps":["trace[440847693] 'agreement among raft nodes before linearized reading' (duration: 184.719477ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.401859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.187084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T07:53:43.402632Z","caller":"traceutil/trace.go:171","msg":"trace[2043468745] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:24657; }","duration":"768.028693ms","start":"2026-08-06T07:53:42.634577Z","end":"2026-08-06T07:53:43.402605Z","steps":["trace[2043468745] 'agreement among raft nodes before linearized reading' (duration: 767.237955ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.402693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:42.634554Z","time spent":"768.123125ms","remote":"127.0.0.1:34954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":20,"response size":31,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-08-06T07:53:43.402918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.385249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-06T07:53:43.402974Z","caller":"traceutil/trace.go:171","msg":"trace[1306889221] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24657; }","duration":"376.457031ms","start":"2026-08-06T07:53:43.0265Z","end":"2026-08-06T07:53:43.402957Z","steps":["trace[1306889221] 'agreement among raft nodes before linearized reading' (duration: 376.209475ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:43.403022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:43.026491Z","time spent":"376.517502ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-08-06T07:53:52.499048Z","caller":"traceutil/trace.go:171","msg":"trace[1053213762] transaction","detail":"{read_only:false; response_revision:24780; number_of_response:1; }","duration":"128.524203ms","start":"2026-08-06T07:53:52.370497Z","end":"2026-08-06T07:53:52.499021Z","steps":["trace[1053213762] 'process raft request' (duration: 128.291148ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:52.49927Z","caller":"traceutil/trace.go:171","msg":"trace[827571658] linearizableReadLoop","detail":"{readStateIndex:25586; appliedIndex:25585; }","duration":"122.156264ms","start":"2026-08-06T07:53:52.376811Z","end":"2026-08-06T07:53:52.498967Z","steps":["trace[827571658] 'read index received' (duration: 121.899359ms)","trace[827571658] 'applied index is now lower than readState.Index' (duration: 255.915µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:52.499381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.544352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2937b2f6-f502-416d-a49b-b6e3b1ba16f0\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-08-06T07:53:52.499472Z","caller":"traceutil/trace.go:171","msg":"trace[263838351] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2937b2f6-f502-416d-a49b-b6e3b1ba16f0; range_end:; response_count:1; response_revision:24780; }","duration":"122.652435ms","start":"2026-08-06T07:53:52.376797Z","end":"2026-08-06T07:53:52.49945Z","steps":["trace[263838351] 'agreement among raft nodes before linearized reading' (duration: 122.365468ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:52.956891Z","caller":"traceutil/trace.go:171","msg":"trace[1603816920] linearizableReadLoop","detail":"{readStateIndex:25587; appliedIndex:25586; }","duration":"141.346455ms","start":"2026-08-06T07:53:52.815521Z","end":"2026-08-06T07:53:52.956867Z","steps":["trace[1603816920] 'read index received' (duration: 141.246413ms)","trace[1603816920] 'applied index is now lower than readState.Index' (duration: 99.002µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:52.957248Z","caller":"traceutil/trace.go:171","msg":"trace[249101987] transaction","detail":"{read_only:false; response_revision:24781; number_of_response:1; }","duration":"448.189056ms","start":"2026-08-06T07:53:52.509005Z","end":"2026-08-06T07:53:52.957194Z","steps":["trace[249101987] 'process raft request' (duration: 447.689895ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:52.957405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.874556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"info","ts":"2026-08-06T07:53:52.957454Z","caller":"traceutil/trace.go:171","msg":"trace[1018648171] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24781; }","duration":"141.973088ms","start":"2026-08-06T07:53:52.815466Z","end":"2026-08-06T07:53:52.957439Z","steps":["trace[1018648171] 'agreement among raft nodes before linearized reading' (duration: 141.733763ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:52.957557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:52.508973Z","time spent":"448.40284ms","remote":"127.0.0.1:34804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3746,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:53:53.263576Z","caller":"traceutil/trace.go:171","msg":"trace[1456281857] linearizableReadLoop","detail":"{readStateIndex:25588; appliedIndex:25587; }","duration":"306.607946ms","start":"2026-08-06T07:53:52.956953Z","end":"2026-08-06T07:53:53.263561Z","steps":["trace[1456281857] 'read index received' (duration: 294.259324ms)","trace[1456281857] 'applied index is now lower than readState.Index' (duration: 12.348022ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:53.263762Z","caller":"traceutil/trace.go:171","msg":"trace[291950750] transaction","detail":"{read_only:false; response_revision:24782; number_of_response:1; }","duration":"332.799041ms","start":"2026-08-06T07:53:52.930954Z","end":"2026-08-06T07:53:53.263753Z","steps":["trace[291950750] 'process raft request' (duration: 320.238245ms)","trace[291950750] 'compare' (duration: 12.26858ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:53.263898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:52.930932Z","time spent":"332.903724ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:53.264234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.730875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2937b2f6-f502-416d-a49b-b6e3b1ba16f0\" ","response":"range_response_count:1 size:3764"} {"level":"info","ts":"2026-08-06T07:53:53.264265Z","caller":"traceutil/trace.go:171","msg":"trace[1444238488] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2937b2f6-f502-416d-a49b-b6e3b1ba16f0; range_end:; response_count:1; response_revision:24782; }","duration":"411.798106ms","start":"2026-08-06T07:53:52.852458Z","end":"2026-08-06T07:53:53.264256Z","steps":["trace[1444238488] 'agreement among raft nodes before linearized reading' (duration: 411.687374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:53.264287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:52.852441Z","time spent":"411.839758ms","remote":"127.0.0.1:34804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3787,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2937b2f6-f502-416d-a49b-b6e3b1ba16f0\" "} {"level":"warn","ts":"2026-08-06T07:53:53.264248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.20947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:53.26436Z","caller":"traceutil/trace.go:171","msg":"trace[1579065363] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:24782; }","duration":"409.377903ms","start":"2026-08-06T07:53:52.854959Z","end":"2026-08-06T07:53:53.264337Z","steps":["trace[1579065363] 'agreement among raft nodes before linearized reading' (duration: 409.170698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:53.264407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:52.854945Z","time spent":"409.450265ms","remote":"127.0.0.1:39008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-08-06T07:53:53.265555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.878749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-08-06T07:53:53.265633Z","caller":"traceutil/trace.go:171","msg":"trace[1520603297] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:24782; }","duration":"392.020292ms","start":"2026-08-06T07:53:52.873592Z","end":"2026-08-06T07:53:53.265613Z","steps":["trace[1520603297] 'agreement among raft nodes before linearized reading' (duration: 390.573951ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:53.265701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:52.873557Z","time spent":"392.110315ms","remote":"127.0.0.1:34696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":2646,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-08-06T07:53:53.269619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.90544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-06T07:53:53.269699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.716138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1155"} {"level":"info","ts":"2026-08-06T07:53:53.269717Z","caller":"traceutil/trace.go:171","msg":"trace[1213550535] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackfloatingippools0; response_count:0; response_revision:24783; }","duration":"179.012953ms","start":"2026-08-06T07:53:53.090648Z","end":"2026-08-06T07:53:53.269661Z","steps":["trace[1213550535] 'agreement among raft nodes before linearized reading' (duration: 178.917031ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:53.269749Z","caller":"traceutil/trace.go:171","msg":"trace[1236929765] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:24783; }","duration":"306.852141ms","start":"2026-08-06T07:53:52.962882Z","end":"2026-08-06T07:53:53.269734Z","steps":["trace[1236929765] 'agreement among raft nodes before linearized reading' (duration: 306.629966ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:53.269781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:52.962847Z","time spent":"306.925793ms","remote":"127.0.0.1:34706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":1178,"request content":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" "} {"level":"info","ts":"2026-08-06T07:53:55.781444Z","caller":"traceutil/trace.go:171","msg":"trace[353214635] linearizableReadLoop","detail":"{readStateIndex:25611; appliedIndex:25607; }","duration":"240.539724ms","start":"2026-08-06T07:53:55.540791Z","end":"2026-08-06T07:53:55.78133Z","steps":["trace[353214635] 'read index received' (duration: 3.092199ms)","trace[353214635] 'applied index is now lower than readState.Index' (duration: 237.446655ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:55.781512Z","caller":"traceutil/trace.go:171","msg":"trace[476753672] transaction","detail":"{read_only:false; response_revision:24803; number_of_response:1; }","duration":"248.190061ms","start":"2026-08-06T07:53:55.533287Z","end":"2026-08-06T07:53:55.781477Z","steps":["trace[476753672] 'process raft request' (duration: 247.780383ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:55.78157Z","caller":"traceutil/trace.go:171","msg":"trace[1523717110] transaction","detail":"{read_only:false; response_revision:24805; number_of_response:1; }","duration":"247.760252ms","start":"2026-08-06T07:53:55.533799Z","end":"2026-08-06T07:53:55.781559Z","steps":["trace[1523717110] 'process raft request' (duration: 247.483396ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:55.781582Z","caller":"traceutil/trace.go:171","msg":"trace[632207414] transaction","detail":"{read_only:false; response_revision:24804; number_of_response:1; }","duration":"248.229202ms","start":"2026-08-06T07:53:55.533323Z","end":"2026-08-06T07:53:55.781552Z","steps":["trace[632207414] 'process raft request' (duration: 247.904595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:55.781886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.068867ms","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-06T07:53:55.782069Z","caller":"traceutil/trace.go:171","msg":"trace[649392457] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24805; }","duration":"241.300592ms","start":"2026-08-06T07:53:55.540743Z","end":"2026-08-06T07:53:55.782044Z","steps":["trace[649392457] 'agreement among raft nodes before linearized reading' (duration: 240.868581ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:55.942756Z","caller":"traceutil/trace.go:171","msg":"trace[473026227] transaction","detail":"{read_only:false; response_revision:24806; number_of_response:1; }","duration":"328.67878ms","start":"2026-08-06T07:53:55.614043Z","end":"2026-08-06T07:53:55.942722Z","steps":["trace[473026227] 'process raft request' (duration: 257.093587ms)","trace[473026227] 'compare' (duration: 71.339828ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:53:55.942891Z","caller":"traceutil/trace.go:171","msg":"trace[36768472] linearizableReadLoop","detail":"{readStateIndex:25612; appliedIndex:25611; }","duration":"161.295584ms","start":"2026-08-06T07:53:55.781521Z","end":"2026-08-06T07:53:55.942817Z","steps":["trace[36768472] 'read index received' (duration: 89.560988ms)","trace[36768472] 'applied index is now lower than readState.Index' (duration: 71.703296ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:53:55.942964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.553459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"warn","ts":"2026-08-06T07:53:55.942943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.889051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:53:55.943021Z","caller":"traceutil/trace.go:171","msg":"trace[2051374512] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24807; }","duration":"349.651301ms","start":"2026-08-06T07:53:55.593352Z","end":"2026-08-06T07:53:55.943003Z","steps":["trace[2051374512] 'agreement among raft nodes before linearized reading' (duration: 349.468917ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:55.942934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.614018Z","time spent":"328.813803ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:53:55.943049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.936529ms","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-06T07:53:55.943062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.59333Z","time spent":"349.723502ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-08-06T07:53:55.943045Z","caller":"traceutil/trace.go:171","msg":"trace[171702914] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24807; }","duration":"398.038784ms","start":"2026-08-06T07:53:55.544985Z","end":"2026-08-06T07:53:55.943024Z","steps":["trace[171702914] 'agreement among raft nodes before linearized reading' (duration: 397.824209ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:55.943089Z","caller":"traceutil/trace.go:171","msg":"trace[2082426052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24807; }","duration":"401.99201ms","start":"2026-08-06T07:53:55.541087Z","end":"2026-08-06T07:53:55.943079Z","steps":["trace[2082426052] 'agreement among raft nodes before linearized reading' (duration: 401.881158ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:55.943119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.544977Z","time spent":"398.130177ms","remote":"127.0.0.1:40636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-08-06T07:53:55.943097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.010714ms","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-06T07:53:55.943162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.110953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-08-06T07:53:55.943174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.562987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3236"} {"level":"info","ts":"2026-08-06T07:53:55.943194Z","caller":"traceutil/trace.go:171","msg":"trace[2056867238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24807; }","duration":"398.128076ms","start":"2026-08-06T07:53:55.54504Z","end":"2026-08-06T07:53:55.943169Z","steps":["trace[2056867238] 'agreement among raft nodes before linearized reading' (duration: 397.84948ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:55.942768Z","caller":"traceutil/trace.go:171","msg":"trace[1550794427] transaction","detail":"{read_only:false; response_revision:24807; number_of_response:1; }","duration":"156.744853ms","start":"2026-08-06T07:53:55.786005Z","end":"2026-08-06T07:53:55.94275Z","steps":["trace[1550794427] 'process raft request' (duration: 156.62813ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:55.943255Z","caller":"traceutil/trace.go:171","msg":"trace[604680303] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24807; }","duration":"333.67785ms","start":"2026-08-06T07:53:55.609558Z","end":"2026-08-06T07:53:55.943236Z","steps":["trace[604680303] 'agreement among raft nodes before linearized reading' (duration: 333.358713ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:55.943126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.541075Z","time spent":"402.041162ms","remote":"127.0.0.1:34898","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-06T07:53:55.943295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.609551Z","time spent":"333.736581ms","remote":"127.0.0.1:35992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":3259,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-08-06T07:53:55.94324Z","caller":"traceutil/trace.go:171","msg":"trace[2144768263] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24807; }","duration":"402.224955ms","start":"2026-08-06T07:53:55.540994Z","end":"2026-08-06T07:53:55.943219Z","steps":["trace[2144768263] 'agreement among raft nodes before linearized reading' (duration: 402.057281ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:55.943394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.540972Z","time spent":"402.407769ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-08-06T07:53:55.943391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.284077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-08-06T07:53:55.943267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.545037Z","time spent":"398.216638ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-06T07:53:55.943455Z","caller":"traceutil/trace.go:171","msg":"trace[1024669415] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24807; }","duration":"402.392449ms","start":"2026-08-06T07:53:55.541049Z","end":"2026-08-06T07:53:55.943441Z","steps":["trace[1024669415] 'agreement among raft nodes before linearized reading' (duration: 402.219405ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:55.943201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.083232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-08-06T07:53:55.9435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.541044Z","time spent":"402.44427ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-06T07:53:55.943281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.862701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.108\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-08-06T07:53:55.943518Z","caller":"traceutil/trace.go:171","msg":"trace[875234182] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24807; }","duration":"402.393929ms","start":"2026-08-06T07:53:55.541102Z","end":"2026-08-06T07:53:55.943496Z","steps":["trace[875234182] 'agreement among raft nodes before linearized reading' (duration: 402.042291ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:55.943596Z","caller":"traceutil/trace.go:171","msg":"trace[1427774557] range","detail":"{range_begin:/registry/masterleases/199.19.213.108; range_end:; response_count:1; response_revision:24807; }","duration":"124.188408ms","start":"2026-08-06T07:53:55.819385Z","end":"2026-08-06T07:53:55.943573Z","steps":["trace[1427774557] 'agreement among raft nodes before linearized reading' (duration: 123.806289ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:55.943684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:53:55.541098Z","time spent":"402.520622ms","remote":"127.0.0.1:34898","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-06T07:53:58.610777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.660931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-08-06T07:53:58.6108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.134421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-08-06T07:53:58.610862Z","caller":"traceutil/trace.go:171","msg":"trace[1661611880] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:24845; }","duration":"171.789483ms","start":"2026-08-06T07:53:58.439054Z","end":"2026-08-06T07:53:58.610843Z","steps":["trace[1661611880] 'count revisions from in-memory index tree' (duration: 171.585589ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:58.610871Z","caller":"traceutil/trace.go:171","msg":"trace[257853436] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:24845; }","duration":"187.250382ms","start":"2026-08-06T07:53:58.423603Z","end":"2026-08-06T07:53:58.610853Z","steps":["trace[257853436] 'range keys from in-memory index tree' (duration: 186.992677ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:53:58.611224Z","caller":"traceutil/trace.go:171","msg":"trace[644399811] transaction","detail":"{read_only:false; response_revision:24846; number_of_response:1; }","duration":"118.544045ms","start":"2026-08-06T07:53:58.492664Z","end":"2026-08-06T07:53:58.611208Z","steps":["trace[644399811] 'process raft request' (duration: 115.565059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:53:58.853478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.476175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T07:53:58.853576Z","caller":"traceutil/trace.go:171","msg":"trace[1181555345] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:24848; }","duration":"104.617238ms","start":"2026-08-06T07:53:58.748942Z","end":"2026-08-06T07:53:58.853559Z","steps":["trace[1181555345] 'count revisions from in-memory index tree' (duration: 104.24273ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:07.92875Z","caller":"traceutil/trace.go:171","msg":"trace[516271466] transaction","detail":"{read_only:false; response_revision:24922; number_of_response:1; }","duration":"104.650379ms","start":"2026-08-06T07:54:07.824066Z","end":"2026-08-06T07:54:07.928716Z","steps":["trace[516271466] 'process raft request' (duration: 104.417274ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:08.047485Z","caller":"traceutil/trace.go:171","msg":"trace[1395910102] transaction","detail":"{read_only:false; response_revision:24923; number_of_response:1; }","duration":"218.851637ms","start":"2026-08-06T07:54:07.828597Z","end":"2026-08-06T07:54:08.047449Z","steps":["trace[1395910102] 'process raft request' (duration: 190.420123ms)","trace[1395910102] 'compare' (duration: 28.23989ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:08.047642Z","caller":"traceutil/trace.go:171","msg":"trace[701709571] transaction","detail":"{read_only:false; response_revision:24924; number_of_response:1; }","duration":"218.384587ms","start":"2026-08-06T07:54:07.829235Z","end":"2026-08-06T07:54:08.047619Z","steps":["trace[701709571] 'process raft request' (duration: 218.162802ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:08.251279Z","caller":"traceutil/trace.go:171","msg":"trace[936398528] transaction","detail":"{read_only:false; response_revision:24928; number_of_response:1; }","duration":"146.344596ms","start":"2026-08-06T07:54:08.104913Z","end":"2026-08-06T07:54:08.251257Z","steps":["trace[936398528] 'process raft request' (duration: 146.300505ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:08.251423Z","caller":"traceutil/trace.go:171","msg":"trace[1096713104] transaction","detail":"{read_only:false; response_revision:24927; number_of_response:1; }","duration":"146.466278ms","start":"2026-08-06T07:54:08.1049Z","end":"2026-08-06T07:54:08.251366Z","steps":["trace[1096713104] 'process raft request' (duration: 69.65833ms)","trace[1096713104] 'compare' (duration: 76.532193ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:08.301925Z","caller":"traceutil/trace.go:171","msg":"trace[742352001] linearizableReadLoop","detail":"{readStateIndex:25741; appliedIndex:25736; }","duration":"167.186313ms","start":"2026-08-06T07:54:08.134713Z","end":"2026-08-06T07:54:08.301899Z","steps":["trace[742352001] 'read index received' (duration: 39.942387ms)","trace[742352001] 'applied index is now lower than readState.Index' (duration: 127.243066ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:08.301969Z","caller":"traceutil/trace.go:171","msg":"trace[874819699] transaction","detail":"{read_only:false; response_revision:24931; number_of_response:1; }","duration":"196.602429ms","start":"2026-08-06T07:54:08.105345Z","end":"2026-08-06T07:54:08.301947Z","steps":["trace[874819699] 'process raft request' (duration: 196.508697ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:08.301982Z","caller":"traceutil/trace.go:171","msg":"trace[1510854131] transaction","detail":"{read_only:false; response_revision:24930; number_of_response:1; }","duration":"196.65865ms","start":"2026-08-06T07:54:08.105283Z","end":"2026-08-06T07:54:08.301942Z","steps":["trace[1510854131] 'process raft request' (duration: 196.525047ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:08.302036Z","caller":"traceutil/trace.go:171","msg":"trace[1126200312] transaction","detail":"{read_only:false; response_revision:24929; number_of_response:1; }","duration":"197.09172ms","start":"2026-08-06T07:54:08.104912Z","end":"2026-08-06T07:54:08.302003Z","steps":["trace[1126200312] 'process raft request' (duration: 196.747933ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:08.302246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.501521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-08-06T07:54:08.302321Z","caller":"traceutil/trace.go:171","msg":"trace[157652457] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24931; }","duration":"167.653794ms","start":"2026-08-06T07:54:08.134648Z","end":"2026-08-06T07:54:08.302302Z","steps":["trace[157652457] 'agreement among raft nodes before linearized reading' (duration: 167.390778ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:08.49391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.952921ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:54:08.494001Z","caller":"traceutil/trace.go:171","msg":"trace[1309442405] linearizableReadLoop","detail":"{readStateIndex:25742; appliedIndex:25741; }","duration":"191.988579ms","start":"2026-08-06T07:54:08.301999Z","end":"2026-08-06T07:54:08.493987Z","steps":["trace[1309442405] 'read index received' (duration: 48.993416ms)","trace[1309442405] 'applied index is now lower than readState.Index' (duration: 142.994033ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:08.494155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.016013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:54:08.494262Z","caller":"traceutil/trace.go:171","msg":"trace[1439593515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24932; }","duration":"275.160486ms","start":"2026-08-06T07:54:08.219082Z","end":"2026-08-06T07:54:08.494243Z","steps":["trace[1439593515] 'agreement among raft nodes before linearized reading' (duration: 275.005563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:08.494452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.228909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2937b2f6-f502-416d-a49b-b6e3b1ba16f0\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-08-06T07:54:08.494593Z","caller":"traceutil/trace.go:171","msg":"trace[763126963] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2937b2f6-f502-416d-a49b-b6e3b1ba16f0; range_end:; response_count:1; response_revision:24932; }","duration":"189.404982ms","start":"2026-08-06T07:54:08.305165Z","end":"2026-08-06T07:54:08.49457Z","steps":["trace[763126963] 'agreement among raft nodes before linearized reading' (duration: 189.087465ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:08.494439Z","caller":"traceutil/trace.go:171","msg":"trace[800775411] transaction","detail":"{read_only:false; response_revision:24932; number_of_response:1; }","duration":"210.598808ms","start":"2026-08-06T07:54:08.283785Z","end":"2026-08-06T07:54:08.494384Z","steps":["trace[800775411] 'process raft request' (duration: 67.097504ms)","trace[800775411] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/ingress-nginx/ingress-nginx-leader; req_size:472; } (duration: 142.438341ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:08.726873Z","caller":"traceutil/trace.go:171","msg":"trace[2061555264] linearizableReadLoop","detail":"{readStateIndex:25744; appliedIndex:25743; }","duration":"138.141505ms","start":"2026-08-06T07:54:08.588713Z","end":"2026-08-06T07:54:08.726854Z","steps":["trace[2061555264] 'read index received' (duration: 73.997516ms)","trace[2061555264] 'applied index is now lower than readState.Index' (duration: 64.141258ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:08.72701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.299688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9602"} {"level":"info","ts":"2026-08-06T07:54:08.727005Z","caller":"traceutil/trace.go:171","msg":"trace[969271297] transaction","detail":"{read_only:false; response_revision:24934; number_of_response:1; }","duration":"147.211504ms","start":"2026-08-06T07:54:08.579775Z","end":"2026-08-06T07:54:08.726986Z","steps":["trace[969271297] 'process raft request' (duration: 82.901251ms)","trace[969271297] 'compare' (duration: 64.092037ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:08.727034Z","caller":"traceutil/trace.go:171","msg":"trace[908486062] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:24934; }","duration":"138.3724ms","start":"2026-08-06T07:54:08.588655Z","end":"2026-08-06T07:54:08.727027Z","steps":["trace[908486062] 'agreement among raft nodes before linearized reading' (duration: 138.269607ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:08.756923Z","caller":"traceutil/trace.go:171","msg":"trace[1291916788] transaction","detail":"{read_only:false; response_revision:24935; number_of_response:1; }","duration":"134.421293ms","start":"2026-08-06T07:54:08.622474Z","end":"2026-08-06T07:54:08.756896Z","steps":["trace[1291916788] 'process raft request' (duration: 134.107296ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:08.756938Z","caller":"traceutil/trace.go:171","msg":"trace[984262790] transaction","detail":"{read_only:false; response_revision:24936; number_of_response:1; }","duration":"113.127644ms","start":"2026-08-06T07:54:08.643792Z","end":"2026-08-06T07:54:08.756919Z","steps":["trace[984262790] 'process raft request' (duration: 113.003531ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:23.851796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.495416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3235"} {"level":"warn","ts":"2026-08-06T07:54:23.851835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.354929ms","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":"info","ts":"2026-08-06T07:54:23.851903Z","caller":"traceutil/trace.go:171","msg":"trace[203601777] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25052; }","duration":"114.631879ms","start":"2026-08-06T07:54:23.737231Z","end":"2026-08-06T07:54:23.851863Z","steps":["trace[203601777] 'range keys from in-memory index tree' (duration: 114.21888ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:23.851915Z","caller":"traceutil/trace.go:171","msg":"trace[1898105279] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:25052; }","duration":"102.506373ms","start":"2026-08-06T07:54:23.74939Z","end":"2026-08-06T07:54:23.851896Z","steps":["trace[1898105279] 'count revisions from in-memory index tree' (duration: 102.272798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:23.851294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.49401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-08-06T07:54:23.853077Z","caller":"traceutil/trace.go:171","msg":"trace[78768617] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:25052; }","duration":"184.3176ms","start":"2026-08-06T07:54:23.668734Z","end":"2026-08-06T07:54:23.853051Z","steps":["trace[78768617] 'range keys from in-memory index tree' (duration: 182.320405ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:23.886172Z","caller":"traceutil/trace.go:171","msg":"trace[550998612] transaction","detail":"{read_only:false; response_revision:25054; number_of_response:1; }","duration":"107.637205ms","start":"2026-08-06T07:54:23.778522Z","end":"2026-08-06T07:54:23.886159Z","steps":["trace[550998612] 'process raft request' (duration: 107.365329ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.400594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.708589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:54:24.400709Z","caller":"traceutil/trace.go:171","msg":"trace[401522185] transaction","detail":"{read_only:false; response_revision:25056; number_of_response:1; }","duration":"300.099813ms","start":"2026-08-06T07:54:24.100587Z","end":"2026-08-06T07:54:24.400687Z","steps":["trace[401522185] 'process raft request' (duration: 180.196959ms)","trace[401522185] 'compare' (duration: 119.267689ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:24.400772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.100557Z","time spent":"300.182835ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:54:24.629887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.47728ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:54:24.630082Z","caller":"traceutil/trace.go:171","msg":"trace[121944979] linearizableReadLoop","detail":"{readStateIndex:25872; appliedIndex:25869; }","duration":"464.714378ms","start":"2026-08-06T07:54:24.16535Z","end":"2026-08-06T07:54:24.630064Z","steps":["trace[121944979] 'read index received' (duration: 115.441106ms)","trace[121944979] 'applied index is now lower than readState.Index' (duration: 349.269002ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:24.630573Z","caller":"traceutil/trace.go:171","msg":"trace[805807267] transaction","detail":"{read_only:false; response_revision:25057; number_of_response:1; }","duration":"525.029975ms","start":"2026-08-06T07:54:24.105502Z","end":"2026-08-06T07:54:24.630532Z","steps":["trace[805807267] 'process raft request' (duration: 401.820738ms)","trace[805807267] 'compare' (duration: 121.981409ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:24.630641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.279651ms","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-06T07:54:24.630695Z","caller":"traceutil/trace.go:171","msg":"trace[1820132714] transaction","detail":"{read_only:false; response_revision:25058; number_of_response:1; }","duration":"524.671867ms","start":"2026-08-06T07:54:24.105976Z","end":"2026-08-06T07:54:24.630648Z","steps":["trace[1820132714] 'process raft request' (duration: 524.004892ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:24.630737Z","caller":"traceutil/trace.go:171","msg":"trace[267420992] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25058; }","duration":"465.378674ms","start":"2026-08-06T07:54:24.165342Z","end":"2026-08-06T07:54:24.63072Z","steps":["trace[267420992] 'agreement among raft nodes before linearized reading' (duration: 465.168089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.630748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.10548Z","time spent":"525.175827ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:54:24.630782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.165281Z","time spent":"465.490056ms","remote":"127.0.0.1:34898","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-06T07:54:24.630795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.586345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-06T07:54:24.630818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.105962Z","time spent":"524.790149ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:54:24.63081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.925117ms","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-06T07:54:24.630869Z","caller":"traceutil/trace.go:171","msg":"trace[1715631401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25058; }","duration":"303.987138ms","start":"2026-08-06T07:54:24.326866Z","end":"2026-08-06T07:54:24.630853Z","steps":["trace[1715631401] 'agreement among raft nodes before linearized reading' (duration: 303.823635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.630842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.772269ms","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-06T07:54:24.630865Z","caller":"traceutil/trace.go:171","msg":"trace[1948425470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25058; }","duration":"412.690206ms","start":"2026-08-06T07:54:24.218154Z","end":"2026-08-06T07:54:24.630844Z","steps":["trace[1948425470] 'agreement among raft nodes before linearized reading' (duration: 412.491962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.630911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.3268Z","time spent":"304.104041ms","remote":"127.0.0.1:34898","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-06T07:54:24.630953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.218139Z","time spent":"412.805609ms","remote":"127.0.0.1:34632","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-06T07:54:24.630993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.340477ms","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-06T07:54:24.630959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.489819ms","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-06T07:54:24.631033Z","caller":"traceutil/trace.go:171","msg":"trace[2091292337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25058; }","duration":"305.406129ms","start":"2026-08-06T07:54:24.325618Z","end":"2026-08-06T07:54:24.631024Z","steps":["trace[2091292337] 'agreement among raft nodes before linearized reading' (duration: 305.254186ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:24.63106Z","caller":"traceutil/trace.go:171","msg":"trace[1537116846] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25058; }","duration":"253.601731ms","start":"2026-08-06T07:54:24.377432Z","end":"2026-08-06T07:54:24.631034Z","steps":["trace[1537116846] 'agreement among raft nodes before linearized reading' (duration: 253.456238ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:24.630947Z","caller":"traceutil/trace.go:171","msg":"trace[25517773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25058; }","duration":"255.915943ms","start":"2026-08-06T07:54:24.375004Z","end":"2026-08-06T07:54:24.63092Z","steps":["trace[25517773] 'agreement among raft nodes before linearized reading' (duration: 255.639527ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.630858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.501604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-08-06T07:54:24.631307Z","caller":"traceutil/trace.go:171","msg":"trace[218097881] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25058; }","duration":"210.996825ms","start":"2026-08-06T07:54:24.420291Z","end":"2026-08-06T07:54:24.631288Z","steps":["trace[218097881] 'agreement among raft nodes before linearized reading' (duration: 210.390692ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.631071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.325603Z","time spent":"305.45897ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-06T07:54:24.997418Z","caller":"traceutil/trace.go:171","msg":"trace[359736713] linearizableReadLoop","detail":"{readStateIndex:25877; appliedIndex:25872; }","duration":"357.969534ms","start":"2026-08-06T07:54:24.639423Z","end":"2026-08-06T07:54:24.997393Z","steps":["trace[359736713] 'read index received' (duration: 80.127929ms)","trace[359736713] 'applied index is now lower than readState.Index' (duration: 277.840355ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:24.997541Z","caller":"traceutil/trace.go:171","msg":"trace[271657109] transaction","detail":"{read_only:false; response_revision:25060; number_of_response:1; }","duration":"360.188363ms","start":"2026-08-06T07:54:24.63734Z","end":"2026-08-06T07:54:24.997529Z","steps":["trace[271657109] 'process raft request' (duration: 359.675821ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:24.997628Z","caller":"traceutil/trace.go:171","msg":"trace[1193167118] transaction","detail":"{read_only:false; response_revision:25063; number_of_response:1; }","duration":"358.276501ms","start":"2026-08-06T07:54:24.639331Z","end":"2026-08-06T07:54:24.997607Z","steps":["trace[1193167118] 'process raft request' (duration: 357.943233ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.997665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.637316Z","time spent":"360.254545ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:54:24.997745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.639325Z","time spent":"358.354162ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:54:24.997834Z","caller":"traceutil/trace.go:171","msg":"trace[900473178] transaction","detail":"{read_only:false; response_revision:25061; number_of_response:1; }","duration":"360.252854ms","start":"2026-08-06T07:54:24.637574Z","end":"2026-08-06T07:54:24.997827Z","steps":["trace[900473178] 'process raft request' (duration: 359.610009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.997869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.637565Z","time spent":"360.282005ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:54:24.997925Z","caller":"traceutil/trace.go:171","msg":"trace[1588008742] transaction","detail":"{read_only:false; response_revision:25062; number_of_response:1; }","duration":"359.701672ms","start":"2026-08-06T07:54:24.638215Z","end":"2026-08-06T07:54:24.997917Z","steps":["trace[1588008742] 'process raft request' (duration: 359.017307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.997954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.6382Z","time spent":"359.737034ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:54:24.998015Z","caller":"traceutil/trace.go:171","msg":"trace[1860567777] transaction","detail":"{read_only:false; response_revision:25064; number_of_response:1; }","duration":"357.580946ms","start":"2026-08-06T07:54:24.640422Z","end":"2026-08-06T07:54:24.998003Z","steps":["trace[1860567777] 'process raft request' (duration: 356.925672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.99808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.640407Z","time spent":"357.638197ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:54:24.998299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.866083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-08-06T07:54:24.998336Z","caller":"traceutil/trace.go:171","msg":"trace[2098912415] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:25064; }","duration":"358.923245ms","start":"2026-08-06T07:54:24.639399Z","end":"2026-08-06T07:54:24.998322Z","steps":["trace[2098912415] 'agreement among raft nodes before linearized reading' (duration: 358.757511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:24.99837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.639384Z","time spent":"358.976726ms","remote":"127.0.0.1:34680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":141,"response size":32,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-08-06T07:54:25.2005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.074998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:54:25.200585Z","caller":"traceutil/trace.go:171","msg":"trace[202774444] linearizableReadLoop","detail":"{readStateIndex:25879; appliedIndex:25878; }","duration":"203.082081ms","start":"2026-08-06T07:54:24.99749Z","end":"2026-08-06T07:54:25.200572Z","steps":["trace[202774444] 'read index received' (duration: 67.916072ms)","trace[202774444] 'applied index is now lower than readState.Index' (duration: 135.164969ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:25.200642Z","caller":"traceutil/trace.go:171","msg":"trace[1726205909] transaction","detail":"{read_only:false; response_revision:25065; number_of_response:1; }","duration":"383.70225ms","start":"2026-08-06T07:54:24.816897Z","end":"2026-08-06T07:54:25.200599Z","steps":["trace[1726205909] 'process raft request' (duration: 248.453009ms)","trace[1726205909] 'compare' (duration: 134.968504ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:25.200695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.124774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-08-06T07:54:25.200843Z","caller":"traceutil/trace.go:171","msg":"trace[1930154973] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:25065; }","duration":"494.259467ms","start":"2026-08-06T07:54:24.70656Z","end":"2026-08-06T07:54:25.200819Z","steps":["trace[1930154973] 'agreement among raft nodes before linearized reading' (duration: 494.046663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:25.200876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.70653Z","time spent":"494.333539ms","remote":"127.0.0.1:34774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1959,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-08-06T07:54:25.200872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:24.816869Z","time spent":"383.871473ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T07:54:26.184528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.764481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:54:26.184731Z","caller":"traceutil/trace.go:171","msg":"trace[269408269] linearizableReadLoop","detail":"{readStateIndex:25884; appliedIndex:25881; }","duration":"167.046059ms","start":"2026-08-06T07:54:26.017671Z","end":"2026-08-06T07:54:26.184717Z","steps":["trace[269408269] 'read index received' (duration: 52.212577ms)","trace[269408269] 'applied index is now lower than readState.Index' (duration: 114.832622ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:26.184737Z","caller":"traceutil/trace.go:171","msg":"trace[869945049] transaction","detail":"{read_only:false; response_revision:25067; number_of_response:1; }","duration":"290.360538ms","start":"2026-08-06T07:54:25.894344Z","end":"2026-08-06T07:54:26.184704Z","steps":["trace[869945049] 'process raft request' (duration: 175.328181ms)","trace[869945049] 'compare' (duration: 114.634178ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:26.184804Z","caller":"traceutil/trace.go:171","msg":"trace[422274698] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"237.045717ms","start":"2026-08-06T07:54:25.94775Z","end":"2026-08-06T07:54:26.184795Z","steps":["trace[422274698] 'process raft request' (duration: 236.873823ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:26.185075Z","caller":"traceutil/trace.go:171","msg":"trace[282270427] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"174.74076ms","start":"2026-08-06T07:54:26.010327Z","end":"2026-08-06T07:54:26.185068Z","steps":["trace[282270427] 'process raft request' (duration: 174.363171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:26.18527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.601472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-08-06T07:54:26.185294Z","caller":"traceutil/trace.go:171","msg":"trace[332764417] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25069; }","duration":"167.647623ms","start":"2026-08-06T07:54:26.017638Z","end":"2026-08-06T07:54:26.185285Z","steps":["trace[332764417] 'agreement among raft nodes before linearized reading' (duration: 167.553651ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:26.185385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.619126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:54:26.185432Z","caller":"traceutil/trace.go:171","msg":"trace[971221594] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25069; }","duration":"103.671037ms","start":"2026-08-06T07:54:26.081748Z","end":"2026-08-06T07:54:26.185419Z","steps":["trace[971221594] 'agreement among raft nodes before linearized reading' (duration: 103.585805ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:26.438742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.440136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-06T07:54:26.438822Z","caller":"traceutil/trace.go:171","msg":"trace[1674480710] linearizableReadLoop","detail":"{readStateIndex:25885; appliedIndex:25884; }","duration":"244.93171ms","start":"2026-08-06T07:54:26.193879Z","end":"2026-08-06T07:54:26.438811Z","steps":["trace[1674480710] 'read index received' (duration: 119.27775ms)","trace[1674480710] 'applied index is now lower than readState.Index' (duration: 125.6531ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:26.438885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.003122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:54:26.4389Z","caller":"traceutil/trace.go:171","msg":"trace[1021265602] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25070; }","duration":"245.042352ms","start":"2026-08-06T07:54:26.193852Z","end":"2026-08-06T07:54:26.438894Z","steps":["trace[1021265602] 'agreement among raft nodes before linearized reading' (duration: 244.985711ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:26.438871Z","caller":"traceutil/trace.go:171","msg":"trace[1696659193] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"246.540486ms","start":"2026-08-06T07:54:26.19229Z","end":"2026-08-06T07:54:26.438831Z","steps":["trace[1696659193] 'process raft request' (duration: 120.942336ms)","trace[1696659193] 'compare' (duration: 125.352694ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:27.272988Z","caller":"traceutil/trace.go:171","msg":"trace[1628852860] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"261.983326ms","start":"2026-08-06T07:54:27.010829Z","end":"2026-08-06T07:54:27.272812Z","steps":["trace[1628852860] 'process raft request' (duration: 261.814422ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:27.273558Z","caller":"traceutil/trace.go:171","msg":"trace[1931504276] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"262.704761ms","start":"2026-08-06T07:54:27.010841Z","end":"2026-08-06T07:54:27.273546Z","steps":["trace[1931504276] 'process raft request' (duration: 261.933634ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:27.273734Z","caller":"traceutil/trace.go:171","msg":"trace[1110117380] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"261.936784ms","start":"2026-08-06T07:54:27.011759Z","end":"2026-08-06T07:54:27.273696Z","steps":["trace[1110117380] 'process raft request' (duration: 261.336841ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:27.274676Z","caller":"traceutil/trace.go:171","msg":"trace[805538108] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"261.334ms","start":"2026-08-06T07:54:27.013307Z","end":"2026-08-06T07:54:27.274641Z","steps":["trace[805538108] 'process raft request' (duration: 260.027742ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:27.322475Z","caller":"traceutil/trace.go:171","msg":"trace[134022195] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"117.368699ms","start":"2026-08-06T07:54:27.205089Z","end":"2026-08-06T07:54:27.322457Z","steps":["trace[134022195] 'process raft request' (duration: 117.187794ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:27.322549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.258433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:54:27.322611Z","caller":"traceutil/trace.go:171","msg":"trace[2030308589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25080; }","duration":"105.384676ms","start":"2026-08-06T07:54:27.217208Z","end":"2026-08-06T07:54:27.322593Z","steps":["trace[2030308589] 'agreement among raft nodes before linearized reading' (duration: 105.225753ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:37.4499Z","caller":"traceutil/trace.go:171","msg":"trace[92513327] transaction","detail":"{read_only:false; response_revision:25163; number_of_response:1; }","duration":"119.24045ms","start":"2026-08-06T07:54:37.330638Z","end":"2026-08-06T07:54:37.449878Z","steps":["trace[92513327] 'process raft request' (duration: 119.155778ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:37.450181Z","caller":"traceutil/trace.go:171","msg":"trace[95146818] transaction","detail":"{read_only:false; response_revision:25162; number_of_response:1; }","duration":"128.38176ms","start":"2026-08-06T07:54:37.321788Z","end":"2026-08-06T07:54:37.45017Z","steps":["trace[95146818] 'process raft request' (duration: 126.56063ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:37.450311Z","caller":"traceutil/trace.go:171","msg":"trace[1621693345] linearizableReadLoop","detail":"{readStateIndex:25979; appliedIndex:25978; }","duration":"121.359735ms","start":"2026-08-06T07:54:37.328941Z","end":"2026-08-06T07:54:37.450301Z","steps":["trace[1621693345] 'read index received' (duration: 119.500314ms)","trace[1621693345] 'applied index is now lower than readState.Index' (duration: 1.858611ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:37.450505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.543329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-08-06T07:54:37.450565Z","caller":"traceutil/trace.go:171","msg":"trace[107089853] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25164; }","duration":"121.640682ms","start":"2026-08-06T07:54:37.328909Z","end":"2026-08-06T07:54:37.450549Z","steps":["trace[107089853] 'agreement among raft nodes before linearized reading' (duration: 121.455748ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:37.663929Z","caller":"traceutil/trace.go:171","msg":"trace[1896072322] transaction","detail":"{read_only:false; response_revision:25165; number_of_response:1; }","duration":"208.670814ms","start":"2026-08-06T07:54:37.455238Z","end":"2026-08-06T07:54:37.663909Z","steps":["trace[1896072322] 'process raft request' (duration: 163.501442ms)","trace[1896072322] 'compare' (duration: 44.998508ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:37.66417Z","caller":"traceutil/trace.go:171","msg":"trace[520340003] transaction","detail":"{read_only:false; response_revision:25166; number_of_response:1; }","duration":"133.478602ms","start":"2026-08-06T07:54:37.530664Z","end":"2026-08-06T07:54:37.664143Z","steps":["trace[520340003] 'process raft request' (duration: 133.202036ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:38.50747Z","caller":"traceutil/trace.go:171","msg":"trace[928405175] transaction","detail":"{read_only:false; response_revision:25168; number_of_response:1; }","duration":"273.340504ms","start":"2026-08-06T07:54:38.2341Z","end":"2026-08-06T07:54:38.50744Z","steps":["trace[928405175] 'process raft request' (duration: 197.397136ms)","trace[928405175] 'compare' (duration: 75.55195ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:42.94964Z","caller":"traceutil/trace.go:171","msg":"trace[1602680642] transaction","detail":"{read_only:false; response_revision:25204; number_of_response:1; }","duration":"147.206964ms","start":"2026-08-06T07:54:42.802401Z","end":"2026-08-06T07:54:42.949608Z","steps":["trace[1602680642] 'process raft request' (duration: 70.576191ms)","trace[1602680642] 'compare' (duration: 76.49782ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:48.790019Z","caller":"traceutil/trace.go:171","msg":"trace[1484814605] transaction","detail":"{read_only:false; response_revision:25243; number_of_response:1; }","duration":"230.515864ms","start":"2026-08-06T07:54:48.559485Z","end":"2026-08-06T07:54:48.790001Z","steps":["trace[1484814605] 'process raft request' (duration: 230.394982ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:48.879753Z","caller":"traceutil/trace.go:171","msg":"trace[939239657] transaction","detail":"{read_only:false; response_revision:25244; number_of_response:1; }","duration":"316.015482ms","start":"2026-08-06T07:54:48.563712Z","end":"2026-08-06T07:54:48.879728Z","steps":["trace[939239657] 'process raft request' (duration: 305.051801ms)","trace[939239657] 'compare' (duration: 10.610524ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:48.879898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T07:54:48.563688Z","time spent":"316.137326ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-06T07:54:49.166571Z","caller":"traceutil/trace.go:171","msg":"trace[279559139] linearizableReadLoop","detail":"{readStateIndex:26067; appliedIndex:26066; }","duration":"187.038599ms","start":"2026-08-06T07:54:48.979514Z","end":"2026-08-06T07:54:49.166553Z","steps":["trace[279559139] 'read index received' (duration: 186.866035ms)","trace[279559139] 'applied index is now lower than readState.Index' (duration: 171.854µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T07:54:49.166669Z","caller":"traceutil/trace.go:171","msg":"trace[2093503976] transaction","detail":"{read_only:false; response_revision:25248; number_of_response:1; }","duration":"191.019606ms","start":"2026-08-06T07:54:48.975608Z","end":"2026-08-06T07:54:49.166628Z","steps":["trace[2093503976] 'process raft request' (duration: 190.833742ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T07:54:49.166717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.180332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T07:54:49.166747Z","caller":"traceutil/trace.go:171","msg":"trace[401255429] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:25248; }","duration":"187.249474ms","start":"2026-08-06T07:54:48.97949Z","end":"2026-08-06T07:54:49.166739Z","steps":["trace[401255429] 'agreement among raft nodes before linearized reading' (duration: 187.132372ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:49.358609Z","caller":"traceutil/trace.go:171","msg":"trace[917900697] linearizableReadLoop","detail":"{readStateIndex:26068; appliedIndex:26067; }","duration":"138.397971ms","start":"2026-08-06T07:54:49.220178Z","end":"2026-08-06T07:54:49.358576Z","steps":["trace[917900697] 'read index received' (duration: 69.560278ms)","trace[917900697] 'applied index is now lower than readState.Index' (duration: 68.836463ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:49.358848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.671316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T07:54:49.35891Z","caller":"traceutil/trace.go:171","msg":"trace[1776400829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25249; }","duration":"138.790079ms","start":"2026-08-06T07:54:49.220108Z","end":"2026-08-06T07:54:49.358898Z","steps":["trace[1776400829] 'agreement among raft nodes before linearized reading' (duration: 138.673046ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:54:49.358901Z","caller":"traceutil/trace.go:171","msg":"trace[1215806775] transaction","detail":"{read_only:false; response_revision:25249; number_of_response:1; }","duration":"157.364197ms","start":"2026-08-06T07:54:49.201493Z","end":"2026-08-06T07:54:49.358858Z","steps":["trace[1215806775] 'process raft request' (duration: 88.256189ms)","trace[1215806775] 'compare' (duration: 68.629918ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T07:54:49.359002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.730103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T07:54:49.359096Z","caller":"traceutil/trace.go:171","msg":"trace[363967050] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:25249; }","duration":"126.873727ms","start":"2026-08-06T07:54:49.2322Z","end":"2026-08-06T07:54:49.359074Z","steps":["trace[363967050] 'agreement among raft nodes before linearized reading' (duration: 126.691933ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T07:55:01.428549Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000663e.wal"} {"level":"info","ts":"2026-08-06T07:56:02.756781Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23080} {"level":"info","ts":"2026-08-06T07:56:02.890134Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23080,"took":"130.19527ms","hash":1946064468,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":36376576,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-08-06T07:56:02.890206Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1946064468,"revision":23080,"compact-revision":20048} {"level":"info","ts":"2026-08-06T08:01:02.763851Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26047} {"level":"info","ts":"2026-08-06T08:01:02.912959Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26047,"took":"144.617745ms","hash":3093306958,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":34750464,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-08-06T08:01:02.913035Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3093306958,"revision":26047,"compact-revision":23080} {"level":"info","ts":"2026-08-06T08:01:47.688856Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e9047e95cdba2056","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-06T08:01:47.69485Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-06T08:01:47.694937Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-08-06T08:06:02.773744Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28753} {"level":"info","ts":"2026-08-06T08:06:02.916762Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28753,"took":"135.611836ms","hash":4140149585,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":30662656,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-06T08:06:02.916861Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4140149585,"revision":28753,"compact-revision":26047} {"level":"info","ts":"2026-08-06T08:11:02.782417Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31006} {"level":"info","ts":"2026-08-06T08:11:02.934991Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31006,"took":"149.050082ms","hash":105337913,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":30564352,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-06T08:11:02.935058Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":105337913,"revision":31006,"compact-revision":28753} {"level":"info","ts":"2026-08-06T08:16:02.789025Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33272} {"level":"info","ts":"2026-08-06T08:16:02.947939Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33272,"took":"154.678957ms","hash":1193043591,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":32063488,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-06T08:16:02.948021Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1193043591,"revision":33272,"compact-revision":31006} {"level":"info","ts":"2026-08-06T08:21:02.794618Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35566} {"level":"info","ts":"2026-08-06T08:21:02.938167Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35566,"took":"140.001523ms","hash":4084853972,"current-db-size-bytes":58716160,"current-db-size":"59 MB","current-db-size-in-use-bytes":31383552,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-06T08:21:02.938237Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4084853972,"revision":35566,"compact-revision":33272} {"level":"info","ts":"2026-08-06T08:23:15.142683Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e9047e95cdba2056","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-06T08:23:15.147342Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-08-06T08:23:15.147509Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-08-06T08:26:02.804092Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37793} {"level":"info","ts":"2026-08-06T08:26:02.92737Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37793,"took":"117.177665ms","hash":851499687,"current-db-size-bytes":59138048,"current-db-size":"59 MB","current-db-size-in-use-bytes":32317440,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-06T08:26:02.92745Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":851499687,"revision":37793,"compact-revision":35566}