{"level":"warn","ts":"2026-09-25T14:57:31.156076Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-25T14:57:31.15619Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.26:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.26:2380","--initial-cluster=instance=https://199.204.45.26:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.26:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.26: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-09-25T14:57:31.156383Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-25T14:57:31.156401Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.26:2380"]} {"level":"info","ts":"2026-09-25T14:57:31.156517Z","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-09-25T14:57:31.157358Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.26:2379"]} {"level":"info","ts":"2026-09-25T14:57:31.157501Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.26:2380"],"listen-peer-urls":["https://199.204.45.26:2380"],"advertise-client-urls":["https://199.204.45.26:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.26:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.26: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-09-25T14:57:31.162976Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.129666ms"} {"level":"info","ts":"2026-09-25T14:57:31.170205Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a7108982bc3c968b","cluster-id":"40b662d11e99c298"} {"level":"info","ts":"2026-09-25T14:57:31.170304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b switched to configuration voters=()"} {"level":"info","ts":"2026-09-25T14:57:31.170333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b became follower at term 0"} {"level":"info","ts":"2026-09-25T14:57:31.170351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a7108982bc3c968b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-25T14:57:31.170407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b became follower at term 1"} {"level":"info","ts":"2026-09-25T14:57:31.170483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b switched to configuration voters=(12038272998558176907)"} {"level":"warn","ts":"2026-09-25T14:57:31.182417Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-25T14:57:31.184057Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-25T14:57:31.185553Z","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-09-25T14:57:31.18793Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a7108982bc3c968b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-25T14:57:31.188158Z","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-09-25T14:57:31.18831Z","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-09-25T14:57:31.188355Z","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-09-25T14:57:31.18881Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a7108982bc3c968b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-25T14:57:31.192838Z","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-09-25T14:57:31.192986Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.26:2380"} {"level":"info","ts":"2026-09-25T14:57:31.193083Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.26:2380"} {"level":"info","ts":"2026-09-25T14:57:31.194079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b switched to configuration voters=(12038272998558176907)"} {"level":"info","ts":"2026-09-25T14:57:31.194089Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-25T14:57:31.194149Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a7108982bc3c968b","initial-advertise-peer-urls":["https://199.204.45.26:2380"],"listen-peer-urls":["https://199.204.45.26:2380"],"advertise-client-urls":["https://199.204.45.26:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.26:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-25T14:57:31.194293Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"40b662d11e99c298","local-member-id":"a7108982bc3c968b","added-peer-id":"a7108982bc3c968b","added-peer-peer-urls":["https://199.204.45.26:2380"]} {"level":"info","ts":"2026-09-25T14:57:32.17116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b is starting a new election at term 1"} {"level":"info","ts":"2026-09-25T14:57:32.171223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-25T14:57:32.17126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b received MsgPreVoteResp from a7108982bc3c968b at term 1"} {"level":"info","ts":"2026-09-25T14:57:32.17128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b became candidate at term 2"} {"level":"info","ts":"2026-09-25T14:57:32.17129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b received MsgVoteResp from a7108982bc3c968b at term 2"} {"level":"info","ts":"2026-09-25T14:57:32.171306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a7108982bc3c968b became leader at term 2"} {"level":"info","ts":"2026-09-25T14:57:32.171318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a7108982bc3c968b elected leader a7108982bc3c968b at term 2"} {"level":"info","ts":"2026-09-25T14:57:32.172662Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T14:57:32.173431Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a7108982bc3c968b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.26:2379]}","request-path":"/0/members/a7108982bc3c968b/attributes","cluster-id":"40b662d11e99c298","publish-timeout":"7s"} {"level":"info","ts":"2026-09-25T14:57:32.173493Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-25T14:57:32.17349Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-25T14:57:32.173698Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-25T14:57:32.173846Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-25T14:57:32.173881Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"40b662d11e99c298","local-member-id":"a7108982bc3c968b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T14:57:32.174051Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T14:57:32.17411Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-25T14:57:32.177608Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-25T14:57:32.177671Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.26:2379"} {"level":"info","ts":"2026-09-25T14:58:00.570441Z","caller":"traceutil/trace.go:171","msg":"trace[1636600640] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"225.137048ms","start":"2026-09-25T14:58:00.345263Z","end":"2026-09-25T14:58:00.5704Z","steps":["trace[1636600640] 'process raft request' (duration: 224.883764ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T14:58:20.942168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.702148ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T14:58:20.942438Z","caller":"traceutil/trace.go:171","msg":"trace[1480066868] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"207.149846ms","start":"2026-09-25T14:58:20.735257Z","end":"2026-09-25T14:58:20.942407Z","steps":["trace[1480066868] 'process raft request' (duration: 95.490174ms)","trace[1480066868] 'compare' (duration: 110.528135ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T14:58:20.972782Z","caller":"traceutil/trace.go:171","msg":"trace[1869171871] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:673; }","duration":"190.269145ms","start":"2026-09-25T14:58:20.782484Z","end":"2026-09-25T14:58:20.972753Z","steps":["trace[1869171871] 'read index received' (duration: 48.231774ms)","trace[1869171871] 'applied index is now lower than readState.Index' (duration: 142.036091ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T14:58:20.972991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.517038ms","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-09-25T14:58:20.973029Z","caller":"traceutil/trace.go:171","msg":"trace[1318943229] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"190.59897ms","start":"2026-09-25T14:58:20.782421Z","end":"2026-09-25T14:58:20.97302Z","steps":["trace[1318943229] 'agreement among raft nodes before linearized reading' (duration: 190.412948ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T14:58:21.16814Z","caller":"traceutil/trace.go:171","msg":"trace[1005252735] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"218.26381ms","start":"2026-09-25T14:58:20.949845Z","end":"2026-09-25T14:58:21.168108Z","steps":["trace[1005252735] 'process raft request' (duration: 217.745551ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T14:58:21.176375Z","caller":"traceutil/trace.go:171","msg":"trace[1383178477] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"198.611034ms","start":"2026-09-25T14:58:20.977734Z","end":"2026-09-25T14:58:21.176345Z","steps":["trace[1383178477] 'process raft request' (duration: 198.416431ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T14:58:21.829751Z","caller":"traceutil/trace.go:171","msg":"trace[400837890] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"587.009483ms","start":"2026-09-25T14:58:21.242719Z","end":"2026-09-25T14:58:21.829729Z","steps":["trace[400837890] 'process raft request' (duration: 577.97333ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T14:58:21.829898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.683457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T14:58:21.829942Z","caller":"traceutil/trace.go:171","msg":"trace[1867378686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"331.796609ms","start":"2026-09-25T14:58:21.498135Z","end":"2026-09-25T14:58:21.829932Z","steps":["trace[1867378686] 'agreement among raft nodes before linearized reading' (duration: 331.668777ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T14:58:21.829997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T14:58:21.498105Z","time spent":"331.88439ms","remote":"127.0.0.1:57426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-25T14:58:21.830076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T14:58:21.242689Z","time spent":"587.192147ms","remote":"127.0.0.1:58002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-25T14:58:21.829747Z","caller":"traceutil/trace.go:171","msg":"trace[687896086] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"331.504973ms","start":"2026-09-25T14:58:21.4982Z","end":"2026-09-25T14:58:21.829705Z","steps":["trace[687896086] 'read index received' (duration: 322.426029ms)","trace[687896086] 'applied index is now lower than readState.Index' (duration: 9.077774ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T14:58:38.818864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.323702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6v4g5\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-25T14:58:38.819518Z","caller":"traceutil/trace.go:171","msg":"trace[2077661830] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6v4g5; range_end:; response_count:1; response_revision:818; }","duration":"183.027883ms","start":"2026-09-25T14:58:38.636442Z","end":"2026-09-25T14:58:38.81947Z","steps":["trace[2077661830] 'range keys from in-memory index tree' (duration: 182.068409ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T14:59:27.632424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.071034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T14:59:27.632564Z","caller":"traceutil/trace.go:171","msg":"trace[1773243194] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1364; }","duration":"129.285187ms","start":"2026-09-25T14:59:27.50325Z","end":"2026-09-25T14:59:27.632535Z","steps":["trace[1773243194] 'range keys from in-memory index tree' (duration: 128.984394ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T14:59:35.415177Z","caller":"traceutil/trace.go:171","msg":"trace[1061096974] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"158.528662ms","start":"2026-09-25T14:59:35.256609Z","end":"2026-09-25T14:59:35.415138Z","steps":["trace[1061096974] 'process raft request' (duration: 158.32807ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:03.492394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.925377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-327b2c1d-bd6e-4280-bf47-12edbf32079f\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-25T15:00:03.492496Z","caller":"traceutil/trace.go:171","msg":"trace[2122009580] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-327b2c1d-bd6e-4280-bf47-12edbf32079f; range_end:; response_count:1; response_revision:1917; }","duration":"138.116049ms","start":"2026-09-25T15:00:03.354357Z","end":"2026-09-25T15:00:03.492473Z","steps":["trace[2122009580] 'range keys from in-memory index tree' (duration: 137.625083ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:03.492791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.939522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-25T15:00:03.49289Z","caller":"traceutil/trace.go:171","msg":"trace[1769819521] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1917; }","duration":"142.112155ms","start":"2026-09-25T15:00:03.350748Z","end":"2026-09-25T15:00:03.49286Z","steps":["trace[1769819521] 'range keys from in-memory index tree' (duration: 141.604808ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:00:03.761628Z","caller":"traceutil/trace.go:171","msg":"trace[1787147740] linearizableReadLoop","detail":"{readStateIndex:1996; appliedIndex:1995; }","duration":"188.760441ms","start":"2026-09-25T15:00:03.572841Z","end":"2026-09-25T15:00:03.761602Z","steps":["trace[1787147740] 'read index received' (duration: 188.567539ms)","trace[1787147740] 'applied index is now lower than readState.Index' (duration: 191.482µs)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:00:03.761704Z","caller":"traceutil/trace.go:171","msg":"trace[815290795] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"259.11656ms","start":"2026-09-25T15:00:03.502544Z","end":"2026-09-25T15:00:03.761661Z","steps":["trace[815290795] 'process raft request' (duration: 258.890517ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:03.761889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.032934ms","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-09-25T15:00:03.761926Z","caller":"traceutil/trace.go:171","msg":"trace[1134386321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1918; }","duration":"189.138366ms","start":"2026-09-25T15:00:03.572778Z","end":"2026-09-25T15:00:03.761916Z","steps":["trace[1134386321] 'agreement among raft nodes before linearized reading' (duration: 188.960184ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:03.76206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-25T15:00:03.762132Z","caller":"traceutil/trace.go:171","msg":"trace[1812004180] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1918; }","duration":"144.459522ms","start":"2026-09-25T15:00:03.617648Z","end":"2026-09-25T15:00:03.762107Z","steps":["trace[1812004180] 'agreement among raft nodes before linearized reading' (duration: 144.26992ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:04.247484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.628221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-09-25T15:00:04.247556Z","caller":"traceutil/trace.go:171","msg":"trace[762898859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1922; }","duration":"164.777542ms","start":"2026-09-25T15:00:04.082761Z","end":"2026-09-25T15:00:04.247538Z","steps":["trace[762898859] 'range keys from in-memory index tree' (duration: 164.461819ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:04.247581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.989266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T15:00:04.247702Z","caller":"traceutil/trace.go:171","msg":"trace[99622287] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1922; }","duration":"146.175498ms","start":"2026-09-25T15:00:04.101501Z","end":"2026-09-25T15:00:04.247677Z","steps":["trace[99622287] 'count revisions from in-memory index tree' (duration: 145.919685ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:04.247876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.857536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-327b2c1d-bd6e-4280-bf47-12edbf32079f\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-25T15:00:04.248447Z","caller":"traceutil/trace.go:171","msg":"trace[228825947] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-327b2c1d-bd6e-4280-bf47-12edbf32079f; range_end:; response_count:1; response_revision:1922; }","duration":"167.466573ms","start":"2026-09-25T15:00:04.080966Z","end":"2026-09-25T15:00:04.248433Z","steps":["trace[228825947] 'range keys from in-memory index tree' (duration: 166.680994ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:38.408077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.707393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-25T15:00:38.408164Z","caller":"traceutil/trace.go:171","msg":"trace[1487632103] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2157; }","duration":"102.833964ms","start":"2026-09-25T15:00:38.30531Z","end":"2026-09-25T15:00:38.408143Z","steps":["trace[1487632103] 'range keys from in-memory index tree' (duration: 102.588111ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:39.027305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.657955ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T15:00:39.027586Z","caller":"traceutil/trace.go:171","msg":"trace[1680003315] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"183.462023ms","start":"2026-09-25T15:00:38.844092Z","end":"2026-09-25T15:00:39.027554Z","steps":["trace[1680003315] 'read index received' (duration: 57.360853ms)","trace[1680003315] 'applied index is now lower than readState.Index' (duration: 126.09964ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:00:39.027779Z","caller":"traceutil/trace.go:171","msg":"trace[753553977] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"260.023937ms","start":"2026-09-25T15:00:38.767735Z","end":"2026-09-25T15:00:39.027759Z","steps":["trace[753553977] 'process raft request' (duration: 133.780585ms)","trace[753553977] 'compare' (duration: 125.477383ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:00:39.028068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.926538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-25T15:00:39.028191Z","caller":"traceutil/trace.go:171","msg":"trace[1832686138] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:2162; }","duration":"184.111931ms","start":"2026-09-25T15:00:38.844052Z","end":"2026-09-25T15:00:39.028164Z","steps":["trace[1832686138] 'agreement among raft nodes before linearized reading' (duration: 183.792577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:39.028188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.753344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-09-25T15:00:39.028294Z","caller":"traceutil/trace.go:171","msg":"trace[1897225645] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2162; }","duration":"112.922195ms","start":"2026-09-25T15:00:38.915347Z","end":"2026-09-25T15:00:39.028269Z","steps":["trace[1897225645] 'agreement among raft nodes before linearized reading' (duration: 112.574471ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:39.397746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.339003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-09-25T15:00:39.397856Z","caller":"traceutil/trace.go:171","msg":"trace[2135172309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2162; }","duration":"225.525976ms","start":"2026-09-25T15:00:39.172306Z","end":"2026-09-25T15:00:39.397832Z","steps":["trace[2135172309] 'range keys from in-memory index tree' (duration: 225.048249ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:00:39.398062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.163412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T15:00:39.398201Z","caller":"traceutil/trace.go:171","msg":"trace[547994212] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:2162; }","duration":"149.393725ms","start":"2026-09-25T15:00:39.248776Z","end":"2026-09-25T15:00:39.398169Z","steps":["trace[547994212] 'count revisions from in-memory index tree' (duration: 148.929061ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:02:42.981845Z","caller":"traceutil/trace.go:171","msg":"trace[496495319] transaction","detail":"{read_only:false; response_revision:2914; number_of_response:1; }","duration":"100.880635ms","start":"2026-09-25T15:02:42.880936Z","end":"2026-09-25T15:02:42.981816Z","steps":["trace[496495319] 'process raft request' (duration: 88.718035ms)","trace[496495319] 'compare' (duration: 12.048687ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:02:43.594228Z","caller":"traceutil/trace.go:171","msg":"trace[262543259] transaction","detail":"{read_only:false; response_revision:2916; number_of_response:1; }","duration":"300.651085ms","start":"2026-09-25T15:02:43.29355Z","end":"2026-09-25T15:02:43.594201Z","steps":["trace[262543259] 'process raft request' (duration: 300.498361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:02:43.594382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:02:43.293528Z","time spent":"300.774937ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-25T15:03:17.009027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.107165ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T15:03:17.009475Z","caller":"traceutil/trace.go:171","msg":"trace[372387177] linearizableReadLoop","detail":"{readStateIndex:3220; appliedIndex:3218; }","duration":"177.966484ms","start":"2026-09-25T15:03:16.831491Z","end":"2026-09-25T15:03:17.009458Z","steps":["trace[372387177] 'read index received' (duration: 114.618902ms)","trace[372387177] 'applied index is now lower than readState.Index' (duration: 63.346622ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:03:17.00967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.16851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-25T15:03:17.009707Z","caller":"traceutil/trace.go:171","msg":"trace[308968264] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3100; }","duration":"178.271902ms","start":"2026-09-25T15:03:16.831422Z","end":"2026-09-25T15:03:17.009694Z","steps":["trace[308968264] 'agreement among raft nodes before linearized reading' (duration: 178.094768ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:03:17.009744Z","caller":"traceutil/trace.go:171","msg":"trace[132881441] transaction","detail":"{read_only:false; response_revision:3100; number_of_response:1; }","duration":"207.61368ms","start":"2026-09-25T15:03:16.802029Z","end":"2026-09-25T15:03:17.009643Z","steps":["trace[132881441] 'process raft request' (duration: 207.369284ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:03:17.009857Z","caller":"traceutil/trace.go:171","msg":"trace[776736449] transaction","detail":"{read_only:false; response_revision:3099; number_of_response:1; }","duration":"207.745342ms","start":"2026-09-25T15:03:16.801793Z","end":"2026-09-25T15:03:17.009538Z","steps":["trace[776736449] 'process raft request' (duration: 27.047974ms)","trace[776736449] 'compare' (duration: 179.706505ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:03:17.310542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.252023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-25T15:03:17.310756Z","caller":"traceutil/trace.go:171","msg":"trace[1758299032] linearizableReadLoop","detail":"{readStateIndex:3221; appliedIndex:3220; }","duration":"273.486542ms","start":"2026-09-25T15:03:17.037191Z","end":"2026-09-25T15:03:17.310677Z","steps":["trace[1758299032] 'read index received' (duration: 99.85557ms)","trace[1758299032] 'applied index is now lower than readState.Index' (duration: 173.629242ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:03:17.310722Z","caller":"traceutil/trace.go:171","msg":"trace[76457650] transaction","detail":"{read_only:false; response_revision:3101; number_of_response:1; }","duration":"292.701611ms","start":"2026-09-25T15:03:17.017997Z","end":"2026-09-25T15:03:17.310699Z","steps":["trace[76457650] 'process raft request' (duration: 119.034928ms)","trace[76457650] 'compare' (duration: 173.013918ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:03:17.311316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.114367ms","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-09-25T15:03:17.311746Z","caller":"traceutil/trace.go:171","msg":"trace[1023708028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3101; }","duration":"274.423174ms","start":"2026-09-25T15:03:17.037148Z","end":"2026-09-25T15:03:17.311571Z","steps":["trace[1023708028] 'agreement among raft nodes before linearized reading' (duration: 274.033495ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:03:17.332172Z","caller":"traceutil/trace.go:171","msg":"trace[276743283] transaction","detail":"{read_only:false; response_revision:3102; number_of_response:1; }","duration":"224.710904ms","start":"2026-09-25T15:03:17.107439Z","end":"2026-09-25T15:03:17.33215Z","steps":["trace[276743283] 'process raft request' (duration: 224.492049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:03:17.332322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.278851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-09-25T15:03:17.332404Z","caller":"traceutil/trace.go:171","msg":"trace[1189514754] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:3102; }","duration":"238.408524ms","start":"2026-09-25T15:03:17.093973Z","end":"2026-09-25T15:03:17.332381Z","steps":["trace[1189514754] 'agreement among raft nodes before linearized reading' (duration: 238.166828ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:03:17.427162Z","caller":"traceutil/trace.go:171","msg":"trace[938805123] transaction","detail":"{read_only:false; response_revision:3103; number_of_response:1; }","duration":"111.334218ms","start":"2026-09-25T15:03:17.315804Z","end":"2026-09-25T15:03:17.427139Z","steps":["trace[938805123] 'process raft request' (duration: 111.189444ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:07:32.201823Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2822} {"level":"info","ts":"2026-09-25T15:07:32.276486Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2822,"took":"73.875592ms","hash":3692414803,"current-db-size-bytes":41553920,"current-db-size":"42 MB","current-db-size-in-use-bytes":16519168,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-09-25T15:07:32.276557Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3692414803,"revision":2822,"compact-revision":-1} {"level":"info","ts":"2026-09-25T15:07:58.754023Z","caller":"traceutil/trace.go:171","msg":"trace[1719379572] linearizableReadLoop","detail":"{readStateIndex:5437; appliedIndex:5436; }","duration":"103.499266ms","start":"2026-09-25T15:07:58.650505Z","end":"2026-09-25T15:07:58.754004Z","steps":["trace[1719379572] 'read index received' (duration: 103.418535ms)","trace[1719379572] 'applied index is now lower than readState.Index' (duration: 79.841µs)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:07:58.754433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.910493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-09-25T15:07:58.754531Z","caller":"traceutil/trace.go:171","msg":"trace[370132307] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5234; }","duration":"104.036954ms","start":"2026-09-25T15:07:58.650468Z","end":"2026-09-25T15:07:58.754505Z","steps":["trace[370132307] 'agreement among raft nodes before linearized reading' (duration: 103.620418ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:07:58.754044Z","caller":"traceutil/trace.go:171","msg":"trace[1664271354] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"106.873058ms","start":"2026-09-25T15:07:58.647151Z","end":"2026-09-25T15:07:58.754024Z","steps":["trace[1664271354] 'process raft request' (duration: 106.723475ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:07:58.755031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.475051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-39f7a7fd-5267-48e5-9d9c-c64866f6eb86\" ","response":"range_response_count:1 size:4067"} {"level":"info","ts":"2026-09-25T15:07:58.755069Z","caller":"traceutil/trace.go:171","msg":"trace[1537497131] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-39f7a7fd-5267-48e5-9d9c-c64866f6eb86; range_end:; response_count:1; response_revision:5235; }","duration":"104.579713ms","start":"2026-09-25T15:07:58.650479Z","end":"2026-09-25T15:07:58.755059Z","steps":["trace[1537497131] 'agreement among raft nodes before linearized reading' (duration: 104.483131ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:07:59.862851Z","caller":"traceutil/trace.go:171","msg":"trace[686527202] linearizableReadLoop","detail":"{readStateIndex:5471; appliedIndex:5470; }","duration":"133.429011ms","start":"2026-09-25T15:07:59.729397Z","end":"2026-09-25T15:07:59.862826Z","steps":["trace[686527202] 'read index received' (duration: 130.426645ms)","trace[686527202] 'applied index is now lower than readState.Index' (duration: 3.001366ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:07:59.862956Z","caller":"traceutil/trace.go:171","msg":"trace[1712104658] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"201.03189ms","start":"2026-09-25T15:07:59.661885Z","end":"2026-09-25T15:07:59.862917Z","steps":["trace[1712104658] 'process raft request' (duration: 197.976833ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:07:59.863097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.669004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-25T15:07:59.863117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.855666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-25T15:07:59.86317Z","caller":"traceutil/trace.go:171","msg":"trace[340105211] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5266; }","duration":"125.954427ms","start":"2026-09-25T15:07:59.737201Z","end":"2026-09-25T15:07:59.863155Z","steps":["trace[340105211] 'agreement among raft nodes before linearized reading' (duration: 125.758114ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:07:59.86317Z","caller":"traceutil/trace.go:171","msg":"trace[1423310697] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5266; }","duration":"133.798247ms","start":"2026-09-25T15:07:59.729353Z","end":"2026-09-25T15:07:59.863151Z","steps":["trace[1423310697] 'agreement among raft nodes before linearized reading' (duration: 133.585113ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:05.462284Z","caller":"traceutil/trace.go:171","msg":"trace[1595758896] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"257.967114ms","start":"2026-09-25T15:08:05.204286Z","end":"2026-09-25T15:08:05.462253Z","steps":["trace[1595758896] 'process raft request' (duration: 218.597037ms)","trace[1595758896] 'compare' (duration: 39.008772ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:08:05.705655Z","caller":"traceutil/trace.go:171","msg":"trace[1504614673] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"495.48656ms","start":"2026-09-25T15:08:05.210135Z","end":"2026-09-25T15:08:05.705622Z","steps":["trace[1504614673] 'process raft request' (duration: 493.968307ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:05.705617Z","caller":"traceutil/trace.go:171","msg":"trace[909277811] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"434.336221ms","start":"2026-09-25T15:08:05.271254Z","end":"2026-09-25T15:08:05.705591Z","steps":["trace[909277811] 'process raft request' (duration: 434.26979ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:05.705769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:05.210121Z","time spent":"495.590311ms","remote":"127.0.0.1:57524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-25T15:08:05.705781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:05.27123Z","time spent":"434.484313ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:08:05.706328Z","caller":"traceutil/trace.go:171","msg":"trace[1820653904] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"242.258037ms","start":"2026-09-25T15:08:05.464054Z","end":"2026-09-25T15:08:05.706312Z","steps":["trace[1820653904] 'process raft request' (duration: 242.066444ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:05.706337Z","caller":"traceutil/trace.go:171","msg":"trace[1536893995] linearizableReadLoop","detail":"{readStateIndex:5539; appliedIndex:5535; }","duration":"205.714412ms","start":"2026-09-25T15:08:05.500599Z","end":"2026-09-25T15:08:05.706314Z","steps":["trace[1536893995] 'read index received' (duration: 203.516639ms)","trace[1536893995] 'applied index is now lower than readState.Index' (duration: 2.196393ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:08:05.706514Z","caller":"traceutil/trace.go:171","msg":"trace[229765520] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"229.888929ms","start":"2026-09-25T15:08:05.476601Z","end":"2026-09-25T15:08:05.70649Z","steps":["trace[229765520] 'process raft request' (duration: 229.640165ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:05.706647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.058307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T15:08:05.706712Z","caller":"traceutil/trace.go:171","msg":"trace[9858882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5332; }","duration":"206.168289ms","start":"2026-09-25T15:08:05.500531Z","end":"2026-09-25T15:08:05.7067Z","steps":["trace[9858882] 'agreement among raft nodes before linearized reading' (duration: 206.070528ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:06.05568Z","caller":"traceutil/trace.go:171","msg":"trace[1541180118] transaction","detail":"{read_only:false; response_revision:5351; number_of_response:1; }","duration":"127.029128ms","start":"2026-09-25T15:08:05.9286Z","end":"2026-09-25T15:08:06.055629Z","steps":["trace[1541180118] 'process raft request' (duration: 126.824664ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:06.071615Z","caller":"traceutil/trace.go:171","msg":"trace[21181991] linearizableReadLoop","detail":"{readStateIndex:5561; appliedIndex:5558; }","duration":"141.627368ms","start":"2026-09-25T15:08:05.929963Z","end":"2026-09-25T15:08:06.07159Z","steps":["trace[21181991] 'read index received' (duration: 125.543925ms)","trace[21181991] 'applied index is now lower than readState.Index' (duration: 16.082683ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:08:06.071658Z","caller":"traceutil/trace.go:171","msg":"trace[550574988] transaction","detail":"{read_only:false; response_revision:5352; number_of_response:1; }","duration":"142.236058ms","start":"2026-09-25T15:08:05.929352Z","end":"2026-09-25T15:08:06.071588Z","steps":["trace[550574988] 'process raft request' (duration: 138.153577ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:06.071706Z","caller":"traceutil/trace.go:171","msg":"trace[294323894] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"142.115466ms","start":"2026-09-25T15:08:05.929576Z","end":"2026-09-25T15:08:06.071692Z","steps":["trace[294323894] 'process raft request' (duration: 141.925733ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:06.071817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.842031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-25T15:08:06.071857Z","caller":"traceutil/trace.go:171","msg":"trace[445195336] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5353; }","duration":"141.922643ms","start":"2026-09-25T15:08:05.929922Z","end":"2026-09-25T15:08:06.071845Z","steps":["trace[445195336] 'agreement among raft nodes before linearized reading' (duration: 141.764591ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:09.10407Z","caller":"traceutil/trace.go:171","msg":"trace[1098413245] transaction","detail":"{read_only:false; response_revision:5422; number_of_response:1; }","duration":"324.183202ms","start":"2026-09-25T15:08:08.77984Z","end":"2026-09-25T15:08:09.104023Z","steps":["trace[1098413245] 'process raft request' (duration: 323.914478ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:09.104185Z","caller":"traceutil/trace.go:171","msg":"trace[1270903108] linearizableReadLoop","detail":"{readStateIndex:5630; appliedIndex:5630; }","duration":"157.962912ms","start":"2026-09-25T15:08:08.946062Z","end":"2026-09-25T15:08:09.104025Z","steps":["trace[1270903108] 'read index received' (duration: 157.951012ms)","trace[1270903108] 'applied index is now lower than readState.Index' (duration: 9.68µs)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:08:09.104319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:08.779817Z","time spent":"324.364454ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-25T15:08:09.10452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.411309ms","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-09-25T15:08:09.104642Z","caller":"traceutil/trace.go:171","msg":"trace[12642715] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5422; }","duration":"158.568732ms","start":"2026-09-25T15:08:08.946017Z","end":"2026-09-25T15:08:09.104586Z","steps":["trace[12642715] 'agreement among raft nodes before linearized reading' (duration: 158.013943ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:10.301818Z","caller":"traceutil/trace.go:171","msg":"trace[1075380454] linearizableReadLoop","detail":"{readStateIndex:5641; appliedIndex:5640; }","duration":"183.911414ms","start":"2026-09-25T15:08:10.117876Z","end":"2026-09-25T15:08:10.301787Z","steps":["trace[1075380454] 'read index received' (duration: 164.916717ms)","trace[1075380454] 'applied index is now lower than readState.Index' (duration: 18.993507ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:08:10.302041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.121647ms","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-09-25T15:08:10.302119Z","caller":"traceutil/trace.go:171","msg":"trace[2050762576] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5433; }","duration":"184.248389ms","start":"2026-09-25T15:08:10.117859Z","end":"2026-09-25T15:08:10.302108Z","steps":["trace[2050762576] 'agreement among raft nodes before linearized reading' (duration: 184.049756ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:10.302687Z","caller":"traceutil/trace.go:171","msg":"trace[459632290] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"195.046963ms","start":"2026-09-25T15:08:10.10762Z","end":"2026-09-25T15:08:10.302667Z","steps":["trace[459632290] 'process raft request' (duration: 175.294424ms)","trace[459632290] 'compare' (duration: 18.728633ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:08:21.007657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.294448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-25T15:08:21.007968Z","caller":"traceutil/trace.go:171","msg":"trace[779578360] linearizableReadLoop","detail":"{readStateIndex:5775; appliedIndex:5774; }","duration":"507.685771ms","start":"2026-09-25T15:08:20.500245Z","end":"2026-09-25T15:08:21.007931Z","steps":["trace[779578360] 'read index received' (duration: 93.984747ms)","trace[779578360] 'applied index is now lower than readState.Index' (duration: 413.696974ms)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:08:21.00782Z","caller":"traceutil/trace.go:171","msg":"trace[1768334843] transaction","detail":"{read_only:false; response_revision:5563; number_of_response:1; }","duration":"609.682887ms","start":"2026-09-25T15:08:20.398097Z","end":"2026-09-25T15:08:21.00778Z","steps":["trace[1768334843] 'process raft request' (duration: 196.170146ms)","trace[1768334843] 'compare' (duration: 412.409295ms)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:08:21.008144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:20.398073Z","time spent":"610.017842ms","remote":"127.0.0.1:57524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":794,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-25T15:08:21.008148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.885264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-25T15:08:21.008212Z","caller":"traceutil/trace.go:171","msg":"trace[1224208742] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5564; }","duration":"507.991416ms","start":"2026-09-25T15:08:20.500206Z","end":"2026-09-25T15:08:21.008198Z","steps":["trace[1224208742] 'agreement among raft nodes before linearized reading' (duration: 507.855024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:21.008253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:20.500171Z","time spent":"508.074277ms","remote":"127.0.0.1:57426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-25T15:08:21.008448Z","caller":"traceutil/trace.go:171","msg":"trace[1700763689] transaction","detail":"{read_only:false; response_revision:5564; number_of_response:1; }","duration":"418.262463ms","start":"2026-09-25T15:08:20.590154Z","end":"2026-09-25T15:08:21.008416Z","steps":["trace[1700763689] 'process raft request' (duration: 417.648634ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:21.008581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:20.590132Z","time spent":"418.356774ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-25T15:08:21.009228Z","caller":"traceutil/trace.go:171","msg":"trace[2018373759] transaction","detail":"{read_only:false; response_revision:5565; number_of_response:1; }","duration":"398.213601ms","start":"2026-09-25T15:08:20.610995Z","end":"2026-09-25T15:08:21.009209Z","steps":["trace[2018373759] 'process raft request' (duration: 397.055243ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:21.009442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:20.610986Z","time spent":"398.298213ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-25T15:08:21.06451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.866547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-25T15:08:21.06467Z","caller":"traceutil/trace.go:171","msg":"trace[57800395] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5565; }","duration":"426.11141ms","start":"2026-09-25T15:08:20.638538Z","end":"2026-09-25T15:08:21.064649Z","steps":["trace[57800395] 'agreement among raft nodes before linearized reading' (duration: 425.677904ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:21.064854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:20.638523Z","time spent":"426.268844ms","remote":"127.0.0.1:57722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-25T15:08:21.06637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.296003ms","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-09-25T15:08:21.066499Z","caller":"traceutil/trace.go:171","msg":"trace[2055959292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5565; }","duration":"426.542727ms","start":"2026-09-25T15:08:20.639926Z","end":"2026-09-25T15:08:21.066469Z","steps":["trace[2055959292] 'agreement among raft nodes before linearized reading' (duration: 424.488006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:21.066671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-25T15:08:20.639908Z","time spent":"426.745119ms","remote":"127.0.0.1:57722","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":"info","ts":"2026-09-25T15:08:21.179203Z","caller":"traceutil/trace.go:171","msg":"trace[1659988787] transaction","detail":"{read_only:false; response_revision:5567; number_of_response:1; }","duration":"102.726657ms","start":"2026-09-25T15:08:21.076428Z","end":"2026-09-25T15:08:21.179155Z","steps":["trace[1659988787] 'process raft request' (duration: 102.466723ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:21.179646Z","caller":"traceutil/trace.go:171","msg":"trace[919403043] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"103.085322ms","start":"2026-09-25T15:08:21.076473Z","end":"2026-09-25T15:08:21.179558Z","steps":["trace[919403043] 'process raft request' (duration: 102.625215ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:21.364656Z","caller":"traceutil/trace.go:171","msg":"trace[1261294609] linearizableReadLoop","detail":"{readStateIndex:5783; appliedIndex:5782; }","duration":"165.482053ms","start":"2026-09-25T15:08:21.199149Z","end":"2026-09-25T15:08:21.364631Z","steps":["trace[1261294609] 'read index received' (duration: 165.2873ms)","trace[1261294609] 'applied index is now lower than readState.Index' (duration: 193.613µs)"],"step_count":2} {"level":"warn","ts":"2026-09-25T15:08:21.364898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.297105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-25T15:08:21.365039Z","caller":"traceutil/trace.go:171","msg":"trace[1883020238] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5570; }","duration":"170.448878ms","start":"2026-09-25T15:08:21.194529Z","end":"2026-09-25T15:08:21.364978Z","steps":["trace[1883020238] 'agreement among raft nodes before linearized reading' (duration: 170.143644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:21.365074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.671621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-25T15:08:21.365175Z","caller":"traceutil/trace.go:171","msg":"trace[1993506503] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5570; }","duration":"176.815382ms","start":"2026-09-25T15:08:21.188332Z","end":"2026-09-25T15:08:21.365147Z","steps":["trace[1993506503] 'agreement among raft nodes before linearized reading' (duration: 176.482318ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:21.365586Z","caller":"traceutil/trace.go:171","msg":"trace[764889966] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"167.196279ms","start":"2026-09-25T15:08:21.198372Z","end":"2026-09-25T15:08:21.365569Z","steps":["trace[764889966] 'process raft request' (duration: 166.081412ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:21.371773Z","caller":"traceutil/trace.go:171","msg":"trace[1979742101] transaction","detail":"{read_only:false; response_revision:5571; number_of_response:1; }","duration":"167.258979ms","start":"2026-09-25T15:08:21.204479Z","end":"2026-09-25T15:08:21.371738Z","steps":["trace[1979742101] 'process raft request' (duration: 166.937764ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:21.371943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.834003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-404df595-d9eb-406f-bd0c-fc6139b893ba\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-09-25T15:08:21.372073Z","caller":"traceutil/trace.go:171","msg":"trace[1331884549] range","detail":"{range_begin:/registry/persistentvolumes/pvc-404df595-d9eb-406f-bd0c-fc6139b893ba; range_end:; response_count:1; response_revision:5571; }","duration":"169.010596ms","start":"2026-09-25T15:08:21.203028Z","end":"2026-09-25T15:08:21.372039Z","steps":["trace[1331884549] 'agreement among raft nodes before linearized reading' (duration: 168.648021ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:22.323886Z","caller":"traceutil/trace.go:171","msg":"trace[1982287188] linearizableReadLoop","detail":"{readStateIndex:5792; appliedIndex:5791; }","duration":"174.908034ms","start":"2026-09-25T15:08:22.148941Z","end":"2026-09-25T15:08:22.323849Z","steps":["trace[1982287188] 'read index received' (duration: 174.67179ms)","trace[1982287188] 'applied index is now lower than readState.Index' (duration: 234.904µs)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:08:22.324048Z","caller":"traceutil/trace.go:171","msg":"trace[2136760006] transaction","detail":"{read_only:false; response_revision:5579; number_of_response:1; }","duration":"205.271351ms","start":"2026-09-25T15:08:22.118758Z","end":"2026-09-25T15:08:22.324029Z","steps":["trace[2136760006] 'process raft request' (duration: 204.859484ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:08:22.324678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.707383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-09-25T15:08:22.324892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.772046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-25T15:08:22.324847Z","caller":"traceutil/trace.go:171","msg":"trace[1942172887] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5579; }","duration":"137.863486ms","start":"2026-09-25T15:08:22.186903Z","end":"2026-09-25T15:08:22.324766Z","steps":["trace[1942172887] 'agreement among raft nodes before linearized reading' (duration: 137.43008ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:08:22.325189Z","caller":"traceutil/trace.go:171","msg":"trace[929961738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5579; }","duration":"176.203953ms","start":"2026-09-25T15:08:22.148872Z","end":"2026-09-25T15:08:22.325076Z","steps":["trace[929961738] 'agreement among raft nodes before linearized reading' (duration: 175.529283ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:09:07.809591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.05378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-25T15:09:07.809708Z","caller":"traceutil/trace.go:171","msg":"trace[685311895] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5948; }","duration":"106.252103ms","start":"2026-09-25T15:09:07.703434Z","end":"2026-09-25T15:09:07.809687Z","steps":["trace[685311895] 'range keys from in-memory index tree' (duration: 105.783966ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:09:08.129914Z","caller":"traceutil/trace.go:171","msg":"trace[2053341158] linearizableReadLoop","detail":"{readStateIndex:6176; appliedIndex:6175; }","duration":"131.992894ms","start":"2026-09-25T15:09:07.997891Z","end":"2026-09-25T15:09:08.129884Z","steps":["trace[2053341158] 'read index received' (duration: 131.944183ms)","trace[2053341158] 'applied index is now lower than readState.Index' (duration: 47.071µs)"],"step_count":2} {"level":"info","ts":"2026-09-25T15:09:08.130139Z","caller":"traceutil/trace.go:171","msg":"trace[1603752862] transaction","detail":"{read_only:false; response_revision:5951; number_of_response:1; }","duration":"133.265392ms","start":"2026-09-25T15:09:07.996705Z","end":"2026-09-25T15:09:08.129971Z","steps":["trace[1603752862] 'process raft request' (duration: 132.967698ms)"],"step_count":1} {"level":"warn","ts":"2026-09-25T15:09:08.130319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.361409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-25T15:09:08.13044Z","caller":"traceutil/trace.go:171","msg":"trace[1637826665] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5951; }","duration":"132.584853ms","start":"2026-09-25T15:09:07.997835Z","end":"2026-09-25T15:09:08.13042Z","steps":["trace[1637826665] 'agreement among raft nodes before linearized reading' (duration: 132.164697ms)"],"step_count":1} {"level":"info","ts":"2026-09-25T15:12:32.209222Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4596} {"level":"info","ts":"2026-09-25T15:12:32.269437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4596,"took":"59.217261ms","hash":758892714,"current-db-size-bytes":41553920,"current-db-size":"42 MB","current-db-size-in-use-bytes":33288192,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-25T15:12:32.269511Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":758892714,"revision":4596,"compact-revision":2822} {"level":"info","ts":"2026-09-25T15:12:36.297564Z","caller":"traceutil/trace.go:171","msg":"trace[1481390179] transaction","detail":"{read_only:false; response_revision:7400; number_of_response:1; }","duration":"107.127097ms","start":"2026-09-25T15:12:36.190409Z","end":"2026-09-25T15:12:36.297536Z","steps":["trace[1481390179] 'process raft request' (duration: 107.000443ms)"],"step_count":1}