{"level":"warn","ts":"2026-05-30T05:17:33.507322Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T05:17:33.50741Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-05-30T05:17:33.507469Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T05:17:33.507477Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-05-30T05:17:33.507492Z","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-05-30T05:17:33.508103Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-05-30T05:17:33.508291Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-05-30T05:17:33.514158Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.923425ms"} {"level":"info","ts":"2026-05-30T05:17:33.520679Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-05-30T05:17:33.520812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T05:17:33.520889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-05-30T05:17:33.520932Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T05:17:33.520963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-05-30T05:17:33.521025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-05-30T05:17:33.52957Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T05:17:33.531141Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T05:17:33.53232Z","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-05-30T05:17:33.534541Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T05:17:33.53477Z","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-05-30T05:17:33.534909Z","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-05-30T05:17:33.534809Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T05:17:33.534956Z","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-05-30T05:17:33.536649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-05-30T05:17:33.536844Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-05-30T05:17:33.540053Z","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-05-30T05:17:33.540182Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-05-30T05:17:33.540235Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-05-30T05:17:33.540344Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T05:17:33.540377Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T05:17:34.221908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T05:17:34.221983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T05:17:34.222022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-05-30T05:17:34.222041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-05-30T05:17:34.222052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-05-30T05:17:34.222068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-05-30T05:17:34.222081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-05-30T05:17:34.22313Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T05:17:34.223185Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T05:17:34.223214Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T05:17:34.223434Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:17:34.223563Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T05:17:34.223753Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T05:17:34.224615Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:17:34.224772Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:17:34.224824Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T05:17:34.225622Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T05:17:34.226585Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"warn","ts":"2026-05-30T05:17:37.32258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.452734ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:17:37.32279Z","caller":"traceutil/trace.go:171","msg":"trace[1248586364] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"250.721661ms","start":"2026-05-30T05:17:37.072043Z","end":"2026-05-30T05:17:37.322764Z","steps":["trace[1248586364] 'process raft request' (duration: 68.407573ms)","trace[1248586364] 'compare' (duration: 181.242079ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:17:46.616119Z","caller":"traceutil/trace.go:171","msg":"trace[534748748] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"193.027463ms","start":"2026-05-30T05:17:46.423065Z","end":"2026-05-30T05:17:46.616093Z","steps":["trace[534748748] 'process raft request' (duration: 192.865089ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:17:46.918648Z","caller":"traceutil/trace.go:171","msg":"trace[2112459639] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:368; }","duration":"227.652646ms","start":"2026-05-30T05:17:46.690969Z","end":"2026-05-30T05:17:46.918622Z","steps":["trace[2112459639] 'read index received' (duration: 227.486961ms)","trace[2112459639] 'applied index is now lower than readState.Index' (duration: 164.735µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:17:46.918826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.79546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-05-30T05:17:46.918866Z","caller":"traceutil/trace.go:171","msg":"trace[1952902290] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:358; }","duration":"227.919053ms","start":"2026-05-30T05:17:46.690937Z","end":"2026-05-30T05:17:46.918856Z","steps":["trace[1952902290] 'agreement among raft nodes before linearized reading' (duration: 227.78844ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:17:46.918846Z","caller":"traceutil/trace.go:171","msg":"trace[477272901] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"295.891104ms","start":"2026-05-30T05:17:46.622801Z","end":"2026-05-30T05:17:46.918692Z","steps":["trace[477272901] 'process raft request' (duration: 295.665408ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:12.540698Z","caller":"traceutil/trace.go:171","msg":"trace[574719228] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"126.708957ms","start":"2026-05-30T05:18:12.413959Z","end":"2026-05-30T05:18:12.540668Z","steps":["trace[574719228] 'process raft request' (duration: 121.538245ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:12.541188Z","caller":"traceutil/trace.go:171","msg":"trace[296705063] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"127.109458ms","start":"2026-05-30T05:18:12.414035Z","end":"2026-05-30T05:18:12.541144Z","steps":["trace[296705063] 'process raft request' (duration: 126.724828ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:12.541503Z","caller":"traceutil/trace.go:171","msg":"trace[1456731163] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"118.667515ms","start":"2026-05-30T05:18:12.422808Z","end":"2026-05-30T05:18:12.541476Z","steps":["trace[1456731163] 'process raft request' (duration: 118.262214ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:12.785281Z","caller":"traceutil/trace.go:171","msg":"trace[1246971453] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"107.044835ms","start":"2026-05-30T05:18:12.678201Z","end":"2026-05-30T05:18:12.785246Z","steps":["trace[1246971453] 'process raft request' (duration: 106.400897ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:18:13.656942Z","caller":"traceutil/trace.go:171","msg":"trace[1071763653] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"331.267657ms","start":"2026-05-30T05:18:13.325637Z","end":"2026-05-30T05:18:13.656905Z","steps":["trace[1071763653] 'process raft request' (duration: 239.958604ms)","trace[1071763653] 'compare' (duration: 90.687856ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:13.657168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:13.32561Z","time spent":"331.477423ms","remote":"127.0.0.1:42436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T05:18:19.65559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.383568ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:18:19.655729Z","caller":"traceutil/trace.go:171","msg":"trace[1602819668] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"139.377276ms","start":"2026-05-30T05:18:19.516333Z","end":"2026-05-30T05:18:19.65571Z","steps":["trace[1602819668] 'read index received' (duration: 548.855µs)","trace[1602819668] 'applied index is now lower than readState.Index' (duration: 138.827231ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:18:19.655825Z","caller":"traceutil/trace.go:171","msg":"trace[1698878819] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"526.219622ms","start":"2026-05-30T05:18:19.129549Z","end":"2026-05-30T05:18:19.655769Z","steps":["trace[1698878819] 'process raft request' (duration: 311.562157ms)","trace[1698878819] 'compare' (duration: 214.206313ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:18:19.65595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.611513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vnjjb\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-30T05:18:19.65599Z","caller":"traceutil/trace.go:171","msg":"trace[1953775501] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vnjjb; range_end:; response_count:1; response_revision:599; }","duration":"140.2689ms","start":"2026-05-30T05:18:19.515711Z","end":"2026-05-30T05:18:19.65598Z","steps":["trace[1953775501] 'agreement among raft nodes before linearized reading' (duration: 140.049344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:19.655988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:18:19.129525Z","time spent":"526.386206ms","remote":"127.0.0.1:42982","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-05-30T05:18:20.794862Z","caller":"traceutil/trace.go:171","msg":"trace[141504053] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"127.983159ms","start":"2026-05-30T05:18:20.666847Z","end":"2026-05-30T05:18:20.79483Z","steps":["trace[141504053] 'process raft request' (duration: 127.65566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:18:35.51137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.251334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:18:35.511526Z","caller":"traceutil/trace.go:171","msg":"trace[235135383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:764; }","duration":"293.48891ms","start":"2026-05-30T05:18:35.218006Z","end":"2026-05-30T05:18:35.511495Z","steps":["trace[235135383] 'range keys from in-memory index tree' (duration: 293.14337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:51.54177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.829475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-20d6d6fc-b8c9-4039-978f-b4c9ffa2aacf\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-05-30T05:19:51.541773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.367175ms","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":"warn","ts":"2026-05-30T05:19:51.54182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.705449ms","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-05-30T05:19:51.541904Z","caller":"traceutil/trace.go:171","msg":"trace[412990768] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-20d6d6fc-b8c9-4039-978f-b4c9ffa2aacf; range_end:; response_count:1; response_revision:1841; }","duration":"246.035361ms","start":"2026-05-30T05:19:51.29584Z","end":"2026-05-30T05:19:51.541875Z","steps":["trace[412990768] 'range keys from in-memory index tree' (duration: 245.486756ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:51.541913Z","caller":"traceutil/trace.go:171","msg":"trace[1331725668] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1841; }","duration":"213.5709ms","start":"2026-05-30T05:19:51.328318Z","end":"2026-05-30T05:19:51.541889Z","steps":["trace[1331725668] 'range keys from in-memory index tree' (duration: 213.19287ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:19:51.541927Z","caller":"traceutil/trace.go:171","msg":"trace[61541340] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1841; }","duration":"413.887394ms","start":"2026-05-30T05:19:51.128013Z","end":"2026-05-30T05:19:51.5419Z","steps":["trace[61541340] 'range keys from in-memory index tree' (duration: 413.442982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:19:51.541977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:19:51.127988Z","time spent":"413.978147ms","remote":"127.0.0.1:49520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-30T05:20:00.628871Z","caller":"traceutil/trace.go:171","msg":"trace[755354512] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"109.131808ms","start":"2026-05-30T05:20:00.519712Z","end":"2026-05-30T05:20:00.628844Z","steps":["trace[755354512] 'process raft request' (duration: 108.927393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:00.659552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.052638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-30T05:20:00.65966Z","caller":"traceutil/trace.go:171","msg":"trace[395597237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1922; }","duration":"105.204622ms","start":"2026-05-30T05:20:00.554434Z","end":"2026-05-30T05:20:00.659639Z","steps":["trace[395597237] 'agreement among raft nodes before linearized reading' (duration: 104.923175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:00.65974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.082939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T05:20:00.659845Z","caller":"traceutil/trace.go:171","msg":"trace[320590677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1922; }","duration":"105.201872ms","start":"2026-05-30T05:20:00.554621Z","end":"2026-05-30T05:20:00.659823Z","steps":["trace[320590677] 'agreement among raft nodes before linearized reading' (duration: 104.958546ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:06.410075Z","caller":"traceutil/trace.go:171","msg":"trace[346379755] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"355.003534ms","start":"2026-05-30T05:20:06.055047Z","end":"2026-05-30T05:20:06.41005Z","steps":["trace[346379755] 'process raft request' (duration: 354.785138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:06.410464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:06.05502Z","time spent":"355.152598ms","remote":"127.0.0.1:42676","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-05-30T05:20:06.419255Z","caller":"traceutil/trace.go:171","msg":"trace[963661991] linearizableReadLoop","detail":"{readStateIndex:2036; appliedIndex:2034; }","duration":"202.077841ms","start":"2026-05-30T05:20:06.21715Z","end":"2026-05-30T05:20:06.419228Z","steps":["trace[963661991] 'read index received' (duration: 192.638698ms)","trace[963661991] 'applied index is now lower than readState.Index' (duration: 9.437603ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:06.41937Z","caller":"traceutil/trace.go:171","msg":"trace[1037046213] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"302.560887ms","start":"2026-05-30T05:20:06.116798Z","end":"2026-05-30T05:20:06.419358Z","steps":["trace[1037046213] 'process raft request' (duration: 302.288749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:06.419487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.151477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:06.419545Z","caller":"traceutil/trace.go:171","msg":"trace[328324807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1964; }","duration":"201.213748ms","start":"2026-05-30T05:20:06.218318Z","end":"2026-05-30T05:20:06.419532Z","steps":["trace[328324807] 'agreement among raft nodes before linearized reading' (duration: 201.074434ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:06.419523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.341079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:20:06.41961Z","caller":"traceutil/trace.go:171","msg":"trace[1213201164] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1964; }","duration":"202.490873ms","start":"2026-05-30T05:20:06.217099Z","end":"2026-05-30T05:20:06.41959Z","steps":["trace[1213201164] 'agreement among raft nodes before linearized reading' (duration: 202.329858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:06.419568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:20:06.116772Z","time spent":"302.627809ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:20:42.885168Z","caller":"traceutil/trace.go:171","msg":"trace[660919659] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2248; }","duration":"119.906179ms","start":"2026-05-30T05:20:42.765225Z","end":"2026-05-30T05:20:42.885131Z","steps":["trace[660919659] 'read index received' (duration: 91.744191ms)","trace[660919659] 'applied index is now lower than readState.Index' (duration: 28.155358ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:20:42.886756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.512143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-30T05:20:42.886875Z","caller":"traceutil/trace.go:171","msg":"trace[592319488] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2170; }","duration":"121.687727ms","start":"2026-05-30T05:20:42.765167Z","end":"2026-05-30T05:20:42.886854Z","steps":["trace[592319488] 'agreement among raft nodes before linearized reading' (duration: 120.139496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:20:43.225183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.373298ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:20:43.225425Z","caller":"traceutil/trace.go:171","msg":"trace[487954313] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"260.105534ms","start":"2026-05-30T05:20:42.965286Z","end":"2026-05-30T05:20:43.225391Z","steps":["trace[487954313] 'process raft request' (duration: 11.403697ms)","trace[487954313] 'compare' (duration: 248.112591ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:20:48.700285Z","caller":"traceutil/trace.go:171","msg":"trace[165912530] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"123.786624ms","start":"2026-05-30T05:20:48.576459Z","end":"2026-05-30T05:20:48.700246Z","steps":["trace[165912530] 'process raft request' (duration: 123.476796ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:20:48.737488Z","caller":"traceutil/trace.go:171","msg":"trace[1206215903] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"152.723963ms","start":"2026-05-30T05:20:48.584707Z","end":"2026-05-30T05:20:48.737431Z","steps":["trace[1206215903] 'process raft request' (duration: 152.535498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:22:08.583273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.779824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T05:22:08.583409Z","caller":"traceutil/trace.go:171","msg":"trace[1829454593] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2827; }","duration":"268.965469ms","start":"2026-05-30T05:22:08.314413Z","end":"2026-05-30T05:22:08.583378Z","steps":["trace[1829454593] 'count revisions from in-memory index tree' (duration: 268.60027ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:00.062973Z","caller":"traceutil/trace.go:171","msg":"trace[29767084] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"113.983386ms","start":"2026-05-30T05:25:59.948917Z","end":"2026-05-30T05:26:00.0629Z","steps":["trace[29767084] 'process raft request' (duration: 113.623646ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:00.067548Z","caller":"traceutil/trace.go:171","msg":"trace[1183158033] linearizableReadLoop","detail":"{readStateIndex:4914; appliedIndex:4911; }","duration":"112.65079ms","start":"2026-05-30T05:25:59.954863Z","end":"2026-05-30T05:26:00.067514Z","steps":["trace[1183158033] 'read index received' (duration: 107.931225ms)","trace[1183158033] 'applied index is now lower than readState.Index' (duration: 4.718275ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:00.067834Z","caller":"traceutil/trace.go:171","msg":"trace[544847382] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"118.058373ms","start":"2026-05-30T05:25:59.94975Z","end":"2026-05-30T05:26:00.067809Z","steps":["trace[544847382] 'process raft request' (duration: 117.451517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:00.067876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.851175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:26:00.068047Z","caller":"traceutil/trace.go:171","msg":"trace[453696277] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:0; response_revision:4736; }","duration":"113.206505ms","start":"2026-05-30T05:25:59.954819Z","end":"2026-05-30T05:26:00.068025Z","steps":["trace[453696277] 'agreement among raft nodes before linearized reading' (duration: 112.842405ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:00.068284Z","caller":"traceutil/trace.go:171","msg":"trace[318659486] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"113.914814ms","start":"2026-05-30T05:25:59.954271Z","end":"2026-05-30T05:26:00.068186Z","steps":["trace[318659486] 'process raft request' (duration: 113.118033ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:05.303955Z","caller":"traceutil/trace.go:171","msg":"trace[871215064] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"115.949918ms","start":"2026-05-30T05:26:05.187973Z","end":"2026-05-30T05:26:05.303923Z","steps":["trace[871215064] 'process raft request' (duration: 115.636259ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:05.442322Z","caller":"traceutil/trace.go:171","msg":"trace[1191733648] linearizableReadLoop","detail":"{readStateIndex:5081; appliedIndex:5080; }","duration":"132.198129ms","start":"2026-05-30T05:26:05.310098Z","end":"2026-05-30T05:26:05.442296Z","steps":["trace[1191733648] 'read index received' (duration: 132.009834ms)","trace[1191733648] 'applied index is now lower than readState.Index' (duration: 186.965µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:05.442356Z","caller":"traceutil/trace.go:171","msg":"trace[1294539242] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"133.35588ms","start":"2026-05-30T05:26:05.308966Z","end":"2026-05-30T05:26:05.442322Z","steps":["trace[1294539242] 'process raft request' (duration: 133.169895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:05.442599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.478737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62975"} {"level":"info","ts":"2026-05-30T05:26:05.442661Z","caller":"traceutil/trace.go:171","msg":"trace[1046348914] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4897; }","duration":"132.59298ms","start":"2026-05-30T05:26:05.310055Z","end":"2026-05-30T05:26:05.442648Z","steps":["trace[1046348914] 'agreement among raft nodes before linearized reading' (duration: 132.293162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:05.442649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.941259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11454"} {"level":"info","ts":"2026-05-30T05:26:05.442713Z","caller":"traceutil/trace.go:171","msg":"trace[732897789] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4897; }","duration":"130.050912ms","start":"2026-05-30T05:26:05.312646Z","end":"2026-05-30T05:26:05.442697Z","steps":["trace[732897789] 'agreement among raft nodes before linearized reading' (duration: 129.847887ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:05.573533Z","caller":"traceutil/trace.go:171","msg":"trace[1923005950] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"124.394782ms","start":"2026-05-30T05:26:05.449114Z","end":"2026-05-30T05:26:05.573509Z","steps":["trace[1923005950] 'process raft request' (duration: 124.219467ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:05.593242Z","caller":"traceutil/trace.go:171","msg":"trace[1948878426] linearizableReadLoop","detail":"{readStateIndex:5083; appliedIndex:5081; }","duration":"116.302727ms","start":"2026-05-30T05:26:05.476921Z","end":"2026-05-30T05:26:05.593223Z","steps":["trace[1948878426] 'read index received' (duration: 96.460791ms)","trace[1948878426] 'applied index is now lower than readState.Index' (duration: 19.841056ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:05.593323Z","caller":"traceutil/trace.go:171","msg":"trace[2021313454] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"140.065078ms","start":"2026-05-30T05:26:05.453252Z","end":"2026-05-30T05:26:05.593317Z","steps":["trace[2021313454] 'process raft request' (duration: 139.839522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:05.593475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.515883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-30T05:26:05.593546Z","caller":"traceutil/trace.go:171","msg":"trace[542938428] 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:4899; }","duration":"116.633295ms","start":"2026-05-30T05:26:05.476897Z","end":"2026-05-30T05:26:05.59353Z","steps":["trace[542938428] 'agreement among raft nodes before linearized reading' (duration: 116.4248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:09.389869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.491928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:26:09.390046Z","caller":"traceutil/trace.go:171","msg":"trace[910281328] linearizableReadLoop","detail":"{readStateIndex:5230; appliedIndex:5229; }","duration":"238.443249ms","start":"2026-05-30T05:26:09.151577Z","end":"2026-05-30T05:26:09.390021Z","steps":["trace[910281328] 'read index received' (duration: 88.680554ms)","trace[910281328] 'applied index is now lower than readState.Index' (duration: 149.760835ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:09.390058Z","caller":"traceutil/trace.go:171","msg":"trace[559468068] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"315.137974ms","start":"2026-05-30T05:26:09.074887Z","end":"2026-05-30T05:26:09.390025Z","steps":["trace[559468068] 'process raft request' (duration: 165.378429ms)","trace[559468068] 'compare' (duration: 149.121258ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:26:09.390202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:09.074864Z","time spent":"315.268118ms","remote":"127.0.0.1:42784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1001,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T05:26:09.390322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.344444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:26:09.390371Z","caller":"traceutil/trace.go:171","msg":"trace[1799019188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5042; }","duration":"172.425077ms","start":"2026-05-30T05:26:09.217934Z","end":"2026-05-30T05:26:09.390359Z","steps":["trace[1799019188] 'agreement among raft nodes before linearized reading' (duration: 172.231822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:09.390451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.84477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-30T05:26:09.390575Z","caller":"traceutil/trace.go:171","msg":"trace[1811588833] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5042; }","duration":"239.021305ms","start":"2026-05-30T05:26:09.151527Z","end":"2026-05-30T05:26:09.390549Z","steps":["trace[1811588833] 'agreement among raft nodes before linearized reading' (duration: 238.583953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:09.390578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.960631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a89bfe75-33f0-40cb-9cdd-0160a010b388\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-05-30T05:26:09.390714Z","caller":"traceutil/trace.go:171","msg":"trace[448809744] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a89bfe75-33f0-40cb-9cdd-0160a010b388; range_end:; response_count:1; response_revision:5042; }","duration":"170.168626ms","start":"2026-05-30T05:26:09.220517Z","end":"2026-05-30T05:26:09.390685Z","steps":["trace[448809744] 'agreement among raft nodes before linearized reading' (duration: 169.739375ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:09.721634Z","caller":"traceutil/trace.go:171","msg":"trace[1477228914] linearizableReadLoop","detail":"{readStateIndex:5243; appliedIndex:5242; }","duration":"112.65099ms","start":"2026-05-30T05:26:09.608961Z","end":"2026-05-30T05:26:09.721612Z","steps":["trace[1477228914] 'read index received' (duration: 112.28648ms)","trace[1477228914] 'applied index is now lower than readState.Index' (duration: 363.35µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:09.721772Z","caller":"traceutil/trace.go:171","msg":"trace[984983580] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"114.941031ms","start":"2026-05-30T05:26:09.606819Z","end":"2026-05-30T05:26:09.72176Z","steps":["trace[984983580] 'process raft request' (duration: 114.660054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:09.722463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.478622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787077"} {"level":"info","ts":"2026-05-30T05:26:09.722502Z","caller":"traceutil/trace.go:171","msg":"trace[947177810] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5055; }","duration":"113.556614ms","start":"2026-05-30T05:26:09.608934Z","end":"2026-05-30T05:26:09.722491Z","steps":["trace[947177810] 'agreement among raft nodes before linearized reading' (duration: 113.02656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:09.722605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.003856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/monitoring/vector\" ","response":"range_response_count:1 size:5083"} {"level":"info","ts":"2026-05-30T05:26:09.72272Z","caller":"traceutil/trace.go:171","msg":"trace[685955184] range","detail":"{range_begin:/registry/daemonsets/monitoring/vector; range_end:; response_count:1; response_revision:5055; }","duration":"111.153751ms","start":"2026-05-30T05:26:09.611534Z","end":"2026-05-30T05:26:09.722687Z","steps":["trace[685955184] 'agreement among raft nodes before linearized reading' (duration: 110.849963ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:22.677822Z","caller":"traceutil/trace.go:171","msg":"trace[861127955] linearizableReadLoop","detail":"{readStateIndex:5528; appliedIndex:5527; }","duration":"100.051626ms","start":"2026-05-30T05:26:22.577747Z","end":"2026-05-30T05:26:22.677799Z","steps":["trace[861127955] 'read index received' (duration: 91.657763ms)","trace[861127955] 'applied index is now lower than readState.Index' (duration: 8.392503ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:22.677865Z","caller":"traceutil/trace.go:171","msg":"trace[1767959186] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"105.50458ms","start":"2026-05-30T05:26:22.572326Z","end":"2026-05-30T05:26:22.677831Z","steps":["trace[1767959186] 'process raft request' (duration: 97.064366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:22.678267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.499057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-05-30T05:26:22.678328Z","caller":"traceutil/trace.go:171","msg":"trace[928407995] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5329; }","duration":"100.616781ms","start":"2026-05-30T05:26:22.577696Z","end":"2026-05-30T05:26:22.678313Z","steps":["trace[928407995] 'agreement among raft nodes before linearized reading' (duration: 100.18637ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:22.744535Z","caller":"traceutil/trace.go:171","msg":"trace[1782008968] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"165.058471ms","start":"2026-05-30T05:26:22.579451Z","end":"2026-05-30T05:26:22.74451Z","steps":["trace[1782008968] 'process raft request' (duration: 164.471966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:22.954712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.570319ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-30T05:26:22.955221Z","caller":"traceutil/trace.go:171","msg":"trace[339610509] linearizableReadLoop","detail":"{readStateIndex:5531; appliedIndex:5528; }","duration":"272.184505ms","start":"2026-05-30T05:26:22.68288Z","end":"2026-05-30T05:26:22.955065Z","steps":["trace[339610509] 'read index received' (duration: 61.059301ms)","trace[339610509] 'applied index is now lower than readState.Index' (duration: 211.123914ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:22.955409Z","caller":"traceutil/trace.go:171","msg":"trace[1842841594] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"275.387299ms","start":"2026-05-30T05:26:22.679989Z","end":"2026-05-30T05:26:22.955377Z","steps":["trace[1842841594] 'process raft request' (duration: 274.832994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:22.955798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.349829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-30T05:26:22.955791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.412751ms","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-05-30T05:26:22.95586Z","caller":"traceutil/trace.go:171","msg":"trace[2005797522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5331; }","duration":"214.448992ms","start":"2026-05-30T05:26:22.741396Z","end":"2026-05-30T05:26:22.955845Z","steps":["trace[2005797522] 'agreement among raft nodes before linearized reading' (duration: 214.206976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:22.955836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.063815ms","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-05-30T05:26:22.955903Z","caller":"traceutil/trace.go:171","msg":"trace[375240846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5331; }","duration":"214.598866ms","start":"2026-05-30T05:26:22.741279Z","end":"2026-05-30T05:26:22.955878Z","steps":["trace[375240846] 'agreement among raft nodes before linearized reading' (duration: 214.244107ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:22.955941Z","caller":"traceutil/trace.go:171","msg":"trace[655214208] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5331; }","duration":"216.29144ms","start":"2026-05-30T05:26:22.739628Z","end":"2026-05-30T05:26:22.95592Z","steps":["trace[655214208] 'agreement among raft nodes before linearized reading' (duration: 215.962852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:22.956462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.550691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224956"} {"level":"info","ts":"2026-05-30T05:26:22.956557Z","caller":"traceutil/trace.go:171","msg":"trace[1478454083] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5331; }","duration":"273.703295ms","start":"2026-05-30T05:26:22.682834Z","end":"2026-05-30T05:26:22.956537Z","steps":["trace[1478454083] 'agreement among raft nodes before linearized reading' (duration: 272.547164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:22.957009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.904451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-05-30T05:26:22.95709Z","caller":"traceutil/trace.go:171","msg":"trace[1749629043] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5331; }","duration":"274.022963ms","start":"2026-05-30T05:26:22.683049Z","end":"2026-05-30T05:26:22.957071Z","steps":["trace[1749629043] 'agreement among raft nodes before linearized reading' (duration: 272.428071ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.721009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.130838ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:26:23.721165Z","caller":"traceutil/trace.go:171","msg":"trace[1693239549] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5332; }","duration":"395.316223ms","start":"2026-05-30T05:26:23.325823Z","end":"2026-05-30T05:26:23.721139Z","steps":["trace[1693239549] 'range keys from in-memory index tree' (duration: 395.109708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.722275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.838998ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:26:23.72255Z","caller":"traceutil/trace.go:171","msg":"trace[1659807791] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"762.093107ms","start":"2026-05-30T05:26:22.960438Z","end":"2026-05-30T05:26:23.722531Z","steps":["trace[1659807791] 'process raft request' (duration: 762.011895ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:23.72258Z","caller":"traceutil/trace.go:171","msg":"trace[1539241000] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"762.158258ms","start":"2026-05-30T05:26:22.96038Z","end":"2026-05-30T05:26:23.722538Z","steps":["trace[1539241000] 'process raft request' (duration: 761.992374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.722642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:22.96043Z","time spent":"762.164369ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:26:23.722631Z","caller":"traceutil/trace.go:171","msg":"trace[1286049615] transaction","detail":"{read_only:false; response_revision:5333; number_of_response:1; }","duration":"762.318952ms","start":"2026-05-30T05:26:22.960261Z","end":"2026-05-30T05:26:23.72258Z","steps":["trace[1286049615] 'process raft request' (duration: 164.107234ms)","trace[1286049615] 'compare' (duration: 596.987836ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:26:23.722776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:22.960372Z","time spent":"762.299373ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:26:23.722836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:22.96024Z","time spent":"762.497058ms","remote":"127.0.0.1:42682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1005,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T05:26:23.722996Z","caller":"traceutil/trace.go:171","msg":"trace[764663155] transaction","detail":"{read_only:false; response_revision:5336; number_of_response:1; }","duration":"762.522128ms","start":"2026-05-30T05:26:22.960437Z","end":"2026-05-30T05:26:23.722959Z","steps":["trace[764663155] 'process raft request' (duration: 762.049706ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:23.72311Z","caller":"traceutil/trace.go:171","msg":"trace[1388552683] linearizableReadLoop","detail":"{readStateIndex:5537; appliedIndex:5531; }","duration":"759.052196ms","start":"2026-05-30T05:26:22.964044Z","end":"2026-05-30T05:26:23.723096Z","steps":["trace[1388552683] 'read index received' (duration: 5.180798ms)","trace[1388552683] 'applied index is now lower than readState.Index' (duration: 753.870558ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:23.723298Z","caller":"traceutil/trace.go:171","msg":"trace[372482742] transaction","detail":"{read_only:false; response_revision:5338; number_of_response:1; }","duration":"597.390446ms","start":"2026-05-30T05:26:23.125894Z","end":"2026-05-30T05:26:23.723284Z","steps":["trace[372482742] 'process raft request' (duration: 597.16736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.723323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:22.960413Z","time spent":"762.737524ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:26:23.723376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:23.125872Z","time spent":"597.464878ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:26:23.7235Z","caller":"traceutil/trace.go:171","msg":"trace[937249331] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"762.2305ms","start":"2026-05-30T05:26:22.961256Z","end":"2026-05-30T05:26:23.723487Z","steps":["trace[937249331] 'process raft request' (duration: 761.513131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.723737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:22.961245Z","time spent":"762.285042ms","remote":"127.0.0.1:42552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T05:26:23.72389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.839477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:110846"} {"level":"info","ts":"2026-05-30T05:26:23.723956Z","caller":"traceutil/trace.go:171","msg":"trace[2147392669] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:5338; }","duration":"759.911568ms","start":"2026-05-30T05:26:22.964029Z","end":"2026-05-30T05:26:23.72394Z","steps":["trace[2147392669] 'agreement among raft nodes before linearized reading' (duration: 759.286752ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.724001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:22.964017Z","time spent":"759.975171ms","remote":"127.0.0.1:42582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":16,"response size":110869,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"warn","ts":"2026-05-30T05:26:23.724045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.912738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bz4bl\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-05-30T05:26:23.724079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.102083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:26:23.724085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.015474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T05:26:23.724106Z","caller":"traceutil/trace.go:171","msg":"trace[1275574386] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bz4bl; range_end:; response_count:1; response_revision:5338; }","duration":"182.00837ms","start":"2026-05-30T05:26:23.54208Z","end":"2026-05-30T05:26:23.724089Z","steps":["trace[1275574386] 'agreement among raft nodes before linearized reading' (duration: 181.874327ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:23.724132Z","caller":"traceutil/trace.go:171","msg":"trace[1074556210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5338; }","duration":"506.188825ms","start":"2026-05-30T05:26:23.217931Z","end":"2026-05-30T05:26:23.72412Z","steps":["trace[1074556210] 'agreement among raft nodes before linearized reading' (duration: 506.098433ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:23.724139Z","caller":"traceutil/trace.go:171","msg":"trace[748819804] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5338; }","duration":"560.126187ms","start":"2026-05-30T05:26:23.164Z","end":"2026-05-30T05:26:23.724126Z","steps":["trace[748819804] 'agreement among raft nodes before linearized reading' (duration: 560.031035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.724179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:23.163975Z","time spent":"560.195769ms","remote":"127.0.0.1:42940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":10,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-05-30T05:26:23.723897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.753865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"warn","ts":"2026-05-30T05:26:23.724179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:23.217915Z","time spent":"506.255257ms","remote":"127.0.0.1:42370","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-05-30T05:26:23.724316Z","caller":"traceutil/trace.go:171","msg":"trace[1053495851] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:5338; }","duration":"760.201097ms","start":"2026-05-30T05:26:22.9641Z","end":"2026-05-30T05:26:23.724301Z","steps":["trace[1053495851] 'agreement among raft nodes before linearized reading' (duration: 759.620822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.724348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.681069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-984jw\" ","response":"range_response_count:1 size:7817"} {"level":"warn","ts":"2026-05-30T05:26:23.724366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:22.964094Z","time spent":"760.258618ms","remote":"127.0.0.1:42810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1147,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"info","ts":"2026-05-30T05:26:23.724396Z","caller":"traceutil/trace.go:171","msg":"trace[316929373] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-984jw; range_end:; response_count:1; response_revision:5338; }","duration":"497.765222ms","start":"2026-05-30T05:26:23.226618Z","end":"2026-05-30T05:26:23.724383Z","steps":["trace[316929373] 'agreement among raft nodes before linearized reading' (duration: 497.586277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.724426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:23.226597Z","time spent":"497.822823ms","remote":"127.0.0.1:42582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":7840,"request content":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-984jw\" "} {"level":"warn","ts":"2026-05-30T05:26:23.724441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.682765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"info","ts":"2026-05-30T05:26:23.724539Z","caller":"traceutil/trace.go:171","msg":"trace[778046174] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5338; }","duration":"735.783378ms","start":"2026-05-30T05:26:22.98872Z","end":"2026-05-30T05:26:23.724503Z","steps":["trace[778046174] 'agreement among raft nodes before linearized reading' (duration: 735.507621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:23.724609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:26:22.988706Z","time spent":"735.888171ms","remote":"127.0.0.1:42476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1848,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-05-30T05:26:31.950114Z","caller":"traceutil/trace.go:171","msg":"trace[663416028] transaction","detail":"{read_only:false; response_revision:5522; number_of_response:1; }","duration":"175.730015ms","start":"2026-05-30T05:26:31.77435Z","end":"2026-05-30T05:26:31.95008Z","steps":["trace[663416028] 'process raft request' (duration: 169.303714ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:26:31.95036Z","caller":"traceutil/trace.go:171","msg":"trace[855578546] linearizableReadLoop","detail":"{readStateIndex:5724; appliedIndex:5722; }","duration":"167.111645ms","start":"2026-05-30T05:26:31.783203Z","end":"2026-05-30T05:26:31.950315Z","steps":["trace[855578546] 'read index received' (duration: 160.375986ms)","trace[855578546] 'applied index is now lower than readState.Index' (duration: 6.733239ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:26:31.950396Z","caller":"traceutil/trace.go:171","msg":"trace[1160282606] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"174.286426ms","start":"2026-05-30T05:26:31.776077Z","end":"2026-05-30T05:26:31.950363Z","steps":["trace[1160282606] 'process raft request' (duration: 173.950077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:26:31.950808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.579478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80607"} {"level":"info","ts":"2026-05-30T05:26:31.950885Z","caller":"traceutil/trace.go:171","msg":"trace[1294723270] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5523; }","duration":"167.67098ms","start":"2026-05-30T05:26:31.783184Z","end":"2026-05-30T05:26:31.950855Z","steps":["trace[1294723270] 'agreement among raft nodes before linearized reading' (duration: 167.29749ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:27:34.247653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2970} {"level":"info","ts":"2026-05-30T05:27:34.322705Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2970,"took":"73.300699ms","hash":2430112579,"current-db-size-bytes":57561088,"current-db-size":"58 MB","current-db-size-in-use-bytes":34017280,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-30T05:27:34.322807Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2430112579,"revision":2970,"compact-revision":-1} {"level":"info","ts":"2026-05-30T05:32:34.2531Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6056} {"level":"info","ts":"2026-05-30T05:32:34.352909Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6056,"took":"97.678781ms","hash":2983779146,"current-db-size-bytes":57561088,"current-db-size":"58 MB","current-db-size-in-use-bytes":21807104,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-05-30T05:32:34.352978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2983779146,"revision":6056,"compact-revision":2970} {"level":"info","ts":"2026-05-30T05:32:47.752123Z","caller":"traceutil/trace.go:171","msg":"trace[1721602158] transaction","detail":"{read_only:false; response_revision:8350; number_of_response:1; }","duration":"261.247589ms","start":"2026-05-30T05:32:47.490844Z","end":"2026-05-30T05:32:47.752091Z","steps":["trace[1721602158] 'process raft request' (duration: 261.000732ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:32:47.978567Z","caller":"traceutil/trace.go:171","msg":"trace[2060995027] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"433.304435ms","start":"2026-05-30T05:32:47.545237Z","end":"2026-05-30T05:32:47.978542Z","steps":["trace[2060995027] 'process raft request' (duration: 426.844182ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:32:47.978763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:32:47.545197Z","time spent":"433.455239ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:32:47.97884Z","caller":"traceutil/trace.go:171","msg":"trace[1178372108] linearizableReadLoop","detail":"{readStateIndex:8646; appliedIndex:8642; }","duration":"406.957479ms","start":"2026-05-30T05:32:47.571858Z","end":"2026-05-30T05:32:47.978815Z","steps":["trace[1178372108] 'read index received' (duration: 180.00197ms)","trace[1178372108] 'applied index is now lower than readState.Index' (duration: 226.954679ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:32:47.978939Z","caller":"traceutil/trace.go:171","msg":"trace[1286971868] transaction","detail":"{read_only:false; response_revision:8352; number_of_response:1; }","duration":"433.155192ms","start":"2026-05-30T05:32:47.545777Z","end":"2026-05-30T05:32:47.978932Z","steps":["trace[1286971868] 'process raft request' (duration: 432.71953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:32:47.97902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:32:47.545745Z","time spent":"433.210412ms","remote":"127.0.0.1:42676","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-05-30T05:32:47.979117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.268487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-30T05:32:47.979121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.841521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T05:32:47.979159Z","caller":"traceutil/trace.go:171","msg":"trace[1527166697] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:8353; }","duration":"407.343408ms","start":"2026-05-30T05:32:47.571801Z","end":"2026-05-30T05:32:47.979144Z","steps":["trace[1527166697] 'agreement among raft nodes before linearized reading' (duration: 407.210995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:32:47.979183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.335367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-30T05:32:47.979197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:32:47.571782Z","time spent":"407.407611ms","remote":"127.0.0.1:42408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"info","ts":"2026-05-30T05:32:47.97921Z","caller":"traceutil/trace.go:171","msg":"trace[658501319] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8353; }","duration":"114.412649ms","start":"2026-05-30T05:32:47.864788Z","end":"2026-05-30T05:32:47.979201Z","steps":["trace[658501319] 'agreement among raft nodes before linearized reading' (duration: 114.318636ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:32:47.979207Z","caller":"traceutil/trace.go:171","msg":"trace[1258114929] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:8353; }","duration":"212.984195ms","start":"2026-05-30T05:32:47.7662Z","end":"2026-05-30T05:32:47.979184Z","steps":["trace[1258114929] 'agreement among raft nodes before linearized reading' (duration: 212.835881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:32:47.979212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.18041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-30T05:32:47.979259Z","caller":"traceutil/trace.go:171","msg":"trace[719631434] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8353; }","duration":"115.244662ms","start":"2026-05-30T05:32:47.864001Z","end":"2026-05-30T05:32:47.979246Z","steps":["trace[719631434] 'agreement among raft nodes before linearized reading' (duration: 115.105008ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:32:47.97928Z","caller":"traceutil/trace.go:171","msg":"trace[940095477] transaction","detail":"{read_only:false; response_revision:8353; number_of_response:1; }","duration":"433.164391ms","start":"2026-05-30T05:32:47.546003Z","end":"2026-05-30T05:32:47.979168Z","steps":["trace[940095477] 'process raft request' (duration: 432.707459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:32:47.979431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.797358ms","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-05-30T05:32:47.979428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.83997ms","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-05-30T05:32:47.979491Z","caller":"traceutil/trace.go:171","msg":"trace[2128396541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8353; }","duration":"124.949892ms","start":"2026-05-30T05:32:47.854523Z","end":"2026-05-30T05:32:47.979473Z","steps":["trace[2128396541] 'agreement among raft nodes before linearized reading' (duration: 124.645854ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:32:47.979514Z","caller":"traceutil/trace.go:171","msg":"trace[1836188543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8353; }","duration":"191.026225ms","start":"2026-05-30T05:32:47.788464Z","end":"2026-05-30T05:32:47.97949Z","steps":["trace[1836188543] 'agreement among raft nodes before linearized reading' (duration: 190.738117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:32:47.981238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:32:47.545991Z","time spent":"435.167196ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:32:59.623818Z","caller":"traceutil/trace.go:171","msg":"trace[1411367910] transaction","detail":"{read_only:false; response_revision:8413; number_of_response:1; }","duration":"232.95607ms","start":"2026-05-30T05:32:59.39084Z","end":"2026-05-30T05:32:59.623796Z","steps":["trace[1411367910] 'process raft request' (duration: 232.793076ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:00.164893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.485715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-30T05:33:00.165092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.742921ms","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":"warn","ts":"2026-05-30T05:33:00.165134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.831097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-30T05:33:00.165178Z","caller":"traceutil/trace.go:171","msg":"trace[1892039089] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8417; }","duration":"107.849594ms","start":"2026-05-30T05:33:00.057308Z","end":"2026-05-30T05:33:00.165158Z","steps":["trace[1892039089] 'agreement among raft nodes before linearized reading' (duration: 45.997804ms)","trace[1892039089] 'range keys from in-memory index tree' (duration: 61.584713ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:33:00.165019Z","caller":"traceutil/trace.go:171","msg":"trace[1515368329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8417; }","duration":"110.627428ms","start":"2026-05-30T05:33:00.054367Z","end":"2026-05-30T05:33:00.164995Z","steps":["trace[1515368329] 'agreement among raft nodes before linearized reading' (duration: 48.933123ms)","trace[1515368329] 'range keys from in-memory index tree' (duration: 61.454739ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:33:00.165235Z","caller":"traceutil/trace.go:171","msg":"trace[9574753] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8417; }","duration":"110.038822ms","start":"2026-05-30T05:33:00.055174Z","end":"2026-05-30T05:33:00.165213Z","steps":["trace[9574753] 'agreement among raft nodes before linearized reading' (duration: 48.141061ms)","trace[9574753] 'range keys from in-memory index tree' (duration: 61.554761ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:33:00.165275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.609242ms","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":"warn","ts":"2026-05-30T05:33:00.165309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.890124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T05:33:00.165368Z","caller":"traceutil/trace.go:171","msg":"trace[1395379314] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:8417; }","duration":"118.734456ms","start":"2026-05-30T05:33:00.046611Z","end":"2026-05-30T05:33:00.165345Z","steps":["trace[1395379314] 'agreement among raft nodes before linearized reading' (duration: 56.675381ms)","trace[1395379314] 'count revisions from in-memory index tree' (duration: 61.916381ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:33:00.165479Z","caller":"traceutil/trace.go:171","msg":"trace[73369913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8417; }","duration":"108.057599ms","start":"2026-05-30T05:33:00.057344Z","end":"2026-05-30T05:33:00.165402Z","steps":["trace[73369913] 'agreement among raft nodes before linearized reading' (duration: 45.977304ms)","trace[73369913] 'range keys from in-memory index tree' (duration: 61.772257ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:33:01.409025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.842893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:33:01.409127Z","caller":"traceutil/trace.go:171","msg":"trace[871651834] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:8422; }","duration":"107.990007ms","start":"2026-05-30T05:33:01.301115Z","end":"2026-05-30T05:33:01.409105Z","steps":["trace[871651834] 'count revisions from in-memory index tree' (duration: 107.739831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:01.409162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.832011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:33:01.409273Z","caller":"traceutil/trace.go:171","msg":"trace[634766335] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8422; }","duration":"191.073247ms","start":"2026-05-30T05:33:01.218166Z","end":"2026-05-30T05:33:01.409239Z","steps":["trace[634766335] 'range keys from in-memory index tree' (duration: 190.678286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:28.494163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.492305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T05:33:28.494239Z","caller":"traceutil/trace.go:171","msg":"trace[1699017406] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8619; }","duration":"314.612888ms","start":"2026-05-30T05:33:28.17961Z","end":"2026-05-30T05:33:28.494223Z","steps":["trace[1699017406] 'count revisions from in-memory index tree' (duration: 314.433294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:28.494269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:33:28.179596Z","time spent":"314.665909ms","remote":"127.0.0.1:49476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-05-30T05:33:28.49457Z","caller":"traceutil/trace.go:171","msg":"trace[267757184] transaction","detail":"{read_only:false; response_revision:8620; number_of_response:1; }","duration":"300.987761ms","start":"2026-05-30T05:33:28.193551Z","end":"2026-05-30T05:33:28.494539Z","steps":["trace[267757184] 'process raft request' (duration: 289.197993ms)","trace[267757184] 'compare' (duration: 11.598653ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:33:28.494743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:33:28.193538Z","time spent":"301.125144ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:33:28.495448Z","caller":"traceutil/trace.go:171","msg":"trace[2044833927] linearizableReadLoop","detail":"{readStateIndex:8925; appliedIndex:8923; }","duration":"277.844797ms","start":"2026-05-30T05:33:28.217585Z","end":"2026-05-30T05:33:28.49543Z","steps":["trace[2044833927] 'read index received' (duration: 265.137564ms)","trace[2044833927] 'applied index is now lower than readState.Index' (duration: 12.706293ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:33:28.495627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.030853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:33:28.495685Z","caller":"traceutil/trace.go:171","msg":"trace[1033603000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8621; }","duration":"278.158806ms","start":"2026-05-30T05:33:28.217512Z","end":"2026-05-30T05:33:28.495671Z","steps":["trace[1033603000] 'agreement among raft nodes before linearized reading' (duration: 278.046802ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:28.495697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.302748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-30T05:33:28.495724Z","caller":"traceutil/trace.go:171","msg":"trace[148883172] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8621; }","duration":"118.36015ms","start":"2026-05-30T05:33:28.377356Z","end":"2026-05-30T05:33:28.495717Z","steps":["trace[148883172] 'agreement among raft nodes before linearized reading' (duration: 118.259837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:28.495744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.74681ms","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-05-30T05:33:28.4958Z","caller":"traceutil/trace.go:171","msg":"trace[1366487908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8621; }","duration":"154.839863ms","start":"2026-05-30T05:33:28.340947Z","end":"2026-05-30T05:33:28.495787Z","steps":["trace[1366487908] 'agreement among raft nodes before linearized reading' (duration: 154.663718ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:28.495859Z","caller":"traceutil/trace.go:171","msg":"trace[763045470] transaction","detail":"{read_only:false; response_revision:8621; number_of_response:1; }","duration":"300.20869ms","start":"2026-05-30T05:33:28.19564Z","end":"2026-05-30T05:33:28.495849Z","steps":["trace[763045470] 'process raft request' (duration: 299.727697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:28.495938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:33:28.195632Z","time spent":"300.249461ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:33:28.496036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.224036ms","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-05-30T05:33:28.496075Z","caller":"traceutil/trace.go:171","msg":"trace[1182403914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8621; }","duration":"121.305249ms","start":"2026-05-30T05:33:28.374761Z","end":"2026-05-30T05:33:28.496066Z","steps":["trace[1182403914] 'agreement among raft nodes before linearized reading' (duration: 121.203746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:28.4961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.432452ms","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-05-30T05:33:28.496131Z","caller":"traceutil/trace.go:171","msg":"trace[1635621234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8621; }","duration":"121.495154ms","start":"2026-05-30T05:33:28.374629Z","end":"2026-05-30T05:33:28.496124Z","steps":["trace[1635621234] 'agreement among raft nodes before linearized reading' (duration: 121.419422ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:28.73924Z","caller":"traceutil/trace.go:171","msg":"trace[186861833] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"237.900161ms","start":"2026-05-30T05:33:28.50132Z","end":"2026-05-30T05:33:28.73922Z","steps":["trace[186861833] 'process raft request' (duration: 237.764087ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:28.740023Z","caller":"traceutil/trace.go:171","msg":"trace[1988969912] linearizableReadLoop","detail":"{readStateIndex:8929; appliedIndex:8925; }","duration":"232.505086ms","start":"2026-05-30T05:33:28.507495Z","end":"2026-05-30T05:33:28.74Z","steps":["trace[1988969912] 'read index received' (duration: 231.656993ms)","trace[1988969912] 'applied index is now lower than readState.Index' (duration: 847.053µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:33:28.740057Z","caller":"traceutil/trace.go:171","msg":"trace[1440467917] transaction","detail":"{read_only:false; response_revision:8623; number_of_response:1; }","duration":"238.556319ms","start":"2026-05-30T05:33:28.501468Z","end":"2026-05-30T05:33:28.740024Z","steps":["trace[1440467917] 'process raft request' (duration: 238.386234ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:28.740116Z","caller":"traceutil/trace.go:171","msg":"trace[1238031919] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"238.671362ms","start":"2026-05-30T05:33:28.501436Z","end":"2026-05-30T05:33:28.740108Z","steps":["trace[1238031919] 'process raft request' (duration: 238.516328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:28.740287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.776173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-bz4bl\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-05-30T05:33:28.740328Z","caller":"traceutil/trace.go:171","msg":"trace[23223808] range","detail":"{range_begin:/registry/pods/openstack/keepalived-bz4bl; range_end:; response_count:1; response_revision:8625; }","duration":"232.849195ms","start":"2026-05-30T05:33:28.507469Z","end":"2026-05-30T05:33:28.740318Z","steps":["trace[23223808] 'agreement among raft nodes before linearized reading' (duration: 232.722841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:33:28.740354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.435107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-30T05:33:28.740386Z","caller":"traceutil/trace.go:171","msg":"trace[2126110326] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8625; }","duration":"218.500108ms","start":"2026-05-30T05:33:28.521878Z","end":"2026-05-30T05:33:28.740378Z","steps":["trace[2126110326] 'agreement among raft nodes before linearized reading' (duration: 218.386825ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:28.740452Z","caller":"traceutil/trace.go:171","msg":"trace[952470398] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"238.892058ms","start":"2026-05-30T05:33:28.501549Z","end":"2026-05-30T05:33:28.740441Z","steps":["trace[952470398] 'process raft request' (duration: 238.427485ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:42.666232Z","caller":"traceutil/trace.go:171","msg":"trace[1970203139] transaction","detail":"{read_only:false; response_revision:8739; number_of_response:1; }","duration":"127.077754ms","start":"2026-05-30T05:33:42.539126Z","end":"2026-05-30T05:33:42.666203Z","steps":["trace[1970203139] 'process raft request' (duration: 126.9089ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:42.697079Z","caller":"traceutil/trace.go:171","msg":"trace[1860858123] transaction","detail":"{read_only:false; response_revision:8740; number_of_response:1; }","duration":"145.631475ms","start":"2026-05-30T05:33:42.551422Z","end":"2026-05-30T05:33:42.697053Z","steps":["trace[1860858123] 'process raft request' (duration: 145.429739ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:42.697389Z","caller":"traceutil/trace.go:171","msg":"trace[1332913592] transaction","detail":"{read_only:false; response_revision:8741; number_of_response:1; }","duration":"142.997403ms","start":"2026-05-30T05:33:42.554381Z","end":"2026-05-30T05:33:42.697378Z","steps":["trace[1332913592] 'process raft request' (duration: 142.631774ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:42.697808Z","caller":"traceutil/trace.go:171","msg":"trace[1924282068] transaction","detail":"{read_only:false; response_revision:8742; number_of_response:1; }","duration":"133.335984ms","start":"2026-05-30T05:33:42.564458Z","end":"2026-05-30T05:33:42.697793Z","steps":["trace[1924282068] 'process raft request' (duration: 132.83614ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:33:56.938115Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023e5.wal"} {"level":"info","ts":"2026-05-30T05:35:21.383027Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fed19d9291630e09","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-30T05:35:21.388079Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-30T05:35:21.388189Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-30T05:37:34.259725Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8146} {"level":"info","ts":"2026-05-30T05:37:34.326979Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8146,"took":"64.766361ms","hash":2616818482,"current-db-size-bytes":57561088,"current-db-size":"58 MB","current-db-size-in-use-bytes":28315648,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-30T05:37:34.327054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2616818482,"revision":8146,"compact-revision":6056} {"level":"warn","ts":"2026-05-30T05:40:33.344931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.465037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:40:33.345028Z","caller":"traceutil/trace.go:171","msg":"trace[1824308581] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11897; }","duration":"126.644841ms","start":"2026-05-30T05:40:33.218363Z","end":"2026-05-30T05:40:33.345008Z","steps":["trace[1824308581] 'range keys from in-memory index tree' (duration: 126.347314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:40:33.345582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.687319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-volume-589d48df75-zm2gx.18b4415891b1d5ba\" ","response":"range_response_count:1 size:804"} {"level":"info","ts":"2026-05-30T05:40:33.345654Z","caller":"traceutil/trace.go:171","msg":"trace[534717315] range","detail":"{range_begin:/registry/events/openstack/cinder-volume-589d48df75-zm2gx.18b4415891b1d5ba; range_end:; response_count:1; response_revision:11897; }","duration":"244.810094ms","start":"2026-05-30T05:40:33.10083Z","end":"2026-05-30T05:40:33.34564Z","steps":["trace[534717315] 'range keys from in-memory index tree' (duration: 244.435723ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:40:33.508052Z","caller":"traceutil/trace.go:171","msg":"trace[523476739] linearizableReadLoop","detail":"{readStateIndex:12307; appliedIndex:12306; }","duration":"154.837975ms","start":"2026-05-30T05:40:33.353181Z","end":"2026-05-30T05:40:33.508019Z","steps":["trace[523476739] 'read index received' (duration: 154.691541ms)","trace[523476739] 'applied index is now lower than readState.Index' (duration: 144.744µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:40:33.50814Z","caller":"traceutil/trace.go:171","msg":"trace[1254092969] transaction","detail":"{read_only:false; response_revision:11898; number_of_response:1; }","duration":"160.327374ms","start":"2026-05-30T05:40:33.347753Z","end":"2026-05-30T05:40:33.50808Z","steps":["trace[1254092969] 'process raft request' (duration: 160.083087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:40:33.508389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.255108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-30T05:40:33.508452Z","caller":"traceutil/trace.go:171","msg":"trace[252762163] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:11898; }","duration":"103.372281ms","start":"2026-05-30T05:40:33.405058Z","end":"2026-05-30T05:40:33.50843Z","steps":["trace[252762163] 'agreement among raft nodes before linearized reading' (duration: 103.155175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:40:33.508859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.649497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-30T05:40:33.508953Z","caller":"traceutil/trace.go:171","msg":"trace[1315816142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11898; }","duration":"155.778321ms","start":"2026-05-30T05:40:33.353155Z","end":"2026-05-30T05:40:33.508933Z","steps":["trace[1315816142] 'agreement among raft nodes before linearized reading' (duration: 154.993609ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:40:33.858762Z","caller":"traceutil/trace.go:171","msg":"trace[1800914537] transaction","detail":"{read_only:false; response_revision:11903; number_of_response:1; }","duration":"115.020147ms","start":"2026-05-30T05:40:33.743713Z","end":"2026-05-30T05:40:33.858733Z","steps":["trace[1800914537] 'process raft request' (duration: 114.180214ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:42:34.267575Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10507} {"level":"info","ts":"2026-05-30T05:42:34.348185Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10507,"took":"77.939955ms","hash":2656744407,"current-db-size-bytes":57561088,"current-db-size":"58 MB","current-db-size-in-use-bytes":25960448,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-30T05:42:34.348257Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2656744407,"revision":10507,"compact-revision":8146} {"level":"info","ts":"2026-05-30T05:46:34.845333Z","caller":"traceutil/trace.go:171","msg":"trace[1939618429] linearizableReadLoop","detail":"{readStateIndex:14840; appliedIndex:14839; }","duration":"102.030113ms","start":"2026-05-30T05:46:34.743279Z","end":"2026-05-30T05:46:34.845309Z","steps":["trace[1939618429] 'read index received' (duration: 101.876099ms)","trace[1939618429] 'applied index is now lower than readState.Index' (duration: 152.834µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:46:34.84567Z","caller":"traceutil/trace.go:171","msg":"trace[1468231872] transaction","detail":"{read_only:false; response_revision:14346; number_of_response:1; }","duration":"107.387306ms","start":"2026-05-30T05:46:34.738269Z","end":"2026-05-30T05:46:34.845656Z","steps":["trace[1468231872] 'process raft request' (duration: 106.882792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:46:34.845919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.631379ms","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-05-30T05:46:34.845965Z","caller":"traceutil/trace.go:171","msg":"trace[1670525915] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14346; }","duration":"102.727361ms","start":"2026-05-30T05:46:34.743224Z","end":"2026-05-30T05:46:34.845951Z","steps":["trace[1670525915] 'agreement among raft nodes before linearized reading' (duration: 102.641319ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:47:09.340999Z","caller":"traceutil/trace.go:171","msg":"trace[431112378] linearizableReadLoop","detail":"{readStateIndex:15047; appliedIndex:15046; }","duration":"121.354269ms","start":"2026-05-30T05:47:09.219605Z","end":"2026-05-30T05:47:09.340959Z","steps":["trace[431112378] 'read index received' (duration: 121.055601ms)","trace[431112378] 'applied index is now lower than readState.Index' (duration: 234.507µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:47:09.34106Z","caller":"traceutil/trace.go:171","msg":"trace[1221072048] transaction","detail":"{read_only:false; response_revision:14544; number_of_response:1; }","duration":"138.596359ms","start":"2026-05-30T05:47:09.202406Z","end":"2026-05-30T05:47:09.341002Z","steps":["trace[1221072048] 'process raft request' (duration: 138.220509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:47:09.341319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.676317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:47:09.342015Z","caller":"traceutil/trace.go:171","msg":"trace[2016481397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14544; }","duration":"122.393286ms","start":"2026-05-30T05:47:09.219589Z","end":"2026-05-30T05:47:09.341982Z","steps":["trace[2016481397] 'agreement among raft nodes before linearized reading' (duration: 121.610666ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:47:09.347511Z","caller":"traceutil/trace.go:171","msg":"trace[1859220915] transaction","detail":"{read_only:false; response_revision:14545; number_of_response:1; }","duration":"126.65669ms","start":"2026-05-30T05:47:09.220751Z","end":"2026-05-30T05:47:09.347408Z","steps":["trace[1859220915] 'process raft request' (duration: 126.355682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:47:10.475379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.348529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-h2hrl\" ","response":"range_response_count:1 size:12360"} {"level":"info","ts":"2026-05-30T05:47:10.475507Z","caller":"traceutil/trace.go:171","msg":"trace[2033899432] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-h2hrl; range_end:; response_count:1; response_revision:14550; }","duration":"456.549606ms","start":"2026-05-30T05:47:10.018929Z","end":"2026-05-30T05:47:10.475479Z","steps":["trace[2033899432] 'range keys from in-memory index tree' (duration: 456.086933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:47:10.47561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:47:10.018906Z","time spent":"456.686609ms","remote":"127.0.0.1:42582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":12383,"request content":"key:\"/registry/pods/openstack/openvswitch-h2hrl\" "} {"level":"warn","ts":"2026-05-30T05:47:10.47573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.237512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:47:10.475841Z","caller":"traceutil/trace.go:171","msg":"trace[802390688] linearizableReadLoop","detail":"{readStateIndex:15054; appliedIndex:15053; }","duration":"161.306026ms","start":"2026-05-30T05:47:10.314515Z","end":"2026-05-30T05:47:10.475821Z","steps":["trace[802390688] 'read index received' (duration: 45.982µs)","trace[802390688] 'applied index is now lower than readState.Index' (duration: 161.258374ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:47:10.475922Z","caller":"traceutil/trace.go:171","msg":"trace[1048726907] transaction","detail":"{read_only:false; response_revision:14551; number_of_response:1; }","duration":"360.015819ms","start":"2026-05-30T05:47:10.115861Z","end":"2026-05-30T05:47:10.475877Z","steps":["trace[1048726907] 'process raft request' (duration: 119.533241ms)","trace[1048726907] 'compare' (duration: 239.950274ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:47:10.475996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.47798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18953"} {"level":"info","ts":"2026-05-30T05:47:10.476034Z","caller":"traceutil/trace.go:171","msg":"trace[557132060] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:14551; }","duration":"161.552512ms","start":"2026-05-30T05:47:10.314471Z","end":"2026-05-30T05:47:10.476024Z","steps":["trace[557132060] 'agreement among raft nodes before linearized reading' (duration: 161.46099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:47:10.476089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:47:10.115842Z","time spent":"360.156652ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T05:47:10.476214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.314824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:47:10.476317Z","caller":"traceutil/trace.go:171","msg":"trace[95600890] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:14551; }","duration":"128.443807ms","start":"2026-05-30T05:47:10.347852Z","end":"2026-05-30T05:47:10.476296Z","steps":["trace[95600890] 'agreement among raft nodes before linearized reading' (duration: 128.286373ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:47:15.837095Z","caller":"traceutil/trace.go:171","msg":"trace[443900130] transaction","detail":"{read_only:false; response_revision:14596; number_of_response:1; }","duration":"106.44195ms","start":"2026-05-30T05:47:15.730626Z","end":"2026-05-30T05:47:15.837067Z","steps":["trace[443900130] 'process raft request' (duration: 106.250545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:47:16.115886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.50418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T05:47:16.11601Z","caller":"traceutil/trace.go:171","msg":"trace[972655591] linearizableReadLoop","detail":"{readStateIndex:15101; appliedIndex:15100; }","duration":"267.443288ms","start":"2026-05-30T05:47:15.848548Z","end":"2026-05-30T05:47:16.115991Z","steps":["trace[972655591] 'read index received' (duration: 111.700431ms)","trace[972655591] 'applied index is now lower than readState.Index' (duration: 155.741597ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:47:16.116058Z","caller":"traceutil/trace.go:171","msg":"trace[2135481833] transaction","detail":"{read_only:false; response_revision:14597; number_of_response:1; }","duration":"362.201426ms","start":"2026-05-30T05:47:15.7538Z","end":"2026-05-30T05:47:16.116001Z","steps":["trace[2135481833] 'process raft request' (duration: 206.48208ms)","trace[2135481833] 'compare' (duration: 155.351196ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T05:47:16.116122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.54261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:47:16.116147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.954938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:47:16.116182Z","caller":"traceutil/trace.go:171","msg":"trace[533407472] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:14597; }","duration":"260.017239ms","start":"2026-05-30T05:47:15.856154Z","end":"2026-05-30T05:47:16.116171Z","steps":["trace[533407472] 'agreement among raft nodes before linearized reading' (duration: 259.948348ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:47:16.116192Z","caller":"traceutil/trace.go:171","msg":"trace[1467584696] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:14597; }","duration":"267.660713ms","start":"2026-05-30T05:47:15.848508Z","end":"2026-05-30T05:47:16.116169Z","steps":["trace[1467584696] 'agreement among raft nodes before linearized reading' (duration: 267.53176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:47:16.116246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T05:47:15.753775Z","time spent":"362.383771ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T05:47:16.287701Z","caller":"traceutil/trace.go:171","msg":"trace[794595703] transaction","detail":"{read_only:false; response_revision:14598; number_of_response:1; }","duration":"125.376777ms","start":"2026-05-30T05:47:16.162279Z","end":"2026-05-30T05:47:16.287656Z","steps":["trace[794595703] 'process raft request' (duration: 88.647886ms)","trace[794595703] 'compare' (duration: 36.526335ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:47:34.273549Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12730} {"level":"info","ts":"2026-05-30T05:47:34.352214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12730,"took":"76.042ms","hash":1284372083,"current-db-size-bytes":57561088,"current-db-size":"58 MB","current-db-size-in-use-bytes":28102656,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-30T05:47:34.352314Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1284372083,"revision":12730,"compact-revision":10507} {"level":"info","ts":"2026-05-30T05:48:25.778968Z","caller":"traceutil/trace.go:171","msg":"trace[1911542230] transaction","detail":"{read_only:false; response_revision:15497; number_of_response:1; }","duration":"127.866533ms","start":"2026-05-30T05:48:25.651071Z","end":"2026-05-30T05:48:25.778937Z","steps":["trace[1911542230] 'process raft request' (duration: 127.628377ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:48:25.77948Z","caller":"traceutil/trace.go:171","msg":"trace[949246903] linearizableReadLoop","detail":"{readStateIndex:16033; appliedIndex:16031; }","duration":"112.425231ms","start":"2026-05-30T05:48:25.667027Z","end":"2026-05-30T05:48:25.779452Z","steps":["trace[949246903] 'read index received' (duration: 111.753203ms)","trace[949246903] 'applied index is now lower than readState.Index' (duration: 671.058µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T05:48:25.779632Z","caller":"traceutil/trace.go:171","msg":"trace[1365326533] transaction","detail":"{read_only:false; response_revision:15498; number_of_response:1; }","duration":"116.824508ms","start":"2026-05-30T05:48:25.662787Z","end":"2026-05-30T05:48:25.779611Z","steps":["trace[1365326533] 'process raft request' (duration: 116.557051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:48:25.779787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.339418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T05:48:25.779884Z","caller":"traceutil/trace.go:171","msg":"trace[1193192387] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15498; }","duration":"112.472062ms","start":"2026-05-30T05:48:25.667389Z","end":"2026-05-30T05:48:25.779861Z","steps":["trace[1193192387] 'agreement among raft nodes before linearized reading' (duration: 112.336238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:48:25.779806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.435421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:48:25.779968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.950804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T05:48:25.779865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.233795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-05-30T05:48:25.780022Z","caller":"traceutil/trace.go:171","msg":"trace[32390687] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15498; }","duration":"112.681258ms","start":"2026-05-30T05:48:25.667284Z","end":"2026-05-30T05:48:25.779965Z","steps":["trace[32390687] 'agreement among raft nodes before linearized reading' (duration: 112.350209ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:48:25.780091Z","caller":"traceutil/trace.go:171","msg":"trace[1758116619] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15498; }","duration":"106.485832ms","start":"2026-05-30T05:48:25.673595Z","end":"2026-05-30T05:48:25.780081Z","steps":["trace[1758116619] 'agreement among raft nodes before linearized reading' (duration: 106.0679ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:48:25.780052Z","caller":"traceutil/trace.go:171","msg":"trace[1819884867] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15498; }","duration":"113.063747ms","start":"2026-05-30T05:48:25.666968Z","end":"2026-05-30T05:48:25.780031Z","steps":["trace[1819884867] 'agreement among raft nodes before linearized reading' (duration: 112.649166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T05:48:58.077969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.624869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-30T05:48:58.078054Z","caller":"traceutil/trace.go:171","msg":"trace[1695139844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15666; }","duration":"108.739182ms","start":"2026-05-30T05:48:57.969298Z","end":"2026-05-30T05:48:58.078037Z","steps":["trace[1695139844] 'range keys from in-memory index tree' (duration: 108.548877ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:48:58.361656Z","caller":"traceutil/trace.go:171","msg":"trace[483182291] transaction","detail":"{read_only:false; response_revision:15668; number_of_response:1; }","duration":"162.785035ms","start":"2026-05-30T05:48:58.198835Z","end":"2026-05-30T05:48:58.36162Z","steps":["trace[483182291] 'process raft request' (duration: 162.540139ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:49:04.574645Z","caller":"traceutil/trace.go:171","msg":"trace[1920969406] transaction","detail":"{read_only:false; response_revision:15700; number_of_response:1; }","duration":"193.658909ms","start":"2026-05-30T05:49:04.380955Z","end":"2026-05-30T05:49:04.574614Z","steps":["trace[1920969406] 'process raft request' (duration: 193.467314ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:49:04.629366Z","caller":"traceutil/trace.go:171","msg":"trace[1639744639] transaction","detail":"{read_only:false; response_revision:15701; number_of_response:1; }","duration":"134.551681ms","start":"2026-05-30T05:49:04.494782Z","end":"2026-05-30T05:49:04.629333Z","steps":["trace[1639744639] 'process raft request' (duration: 134.015097ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T05:52:34.280314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14872} {"level":"info","ts":"2026-05-30T05:52:34.381867Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14872,"took":"96.557268ms","hash":4027820834,"current-db-size-bytes":57561088,"current-db-size":"58 MB","current-db-size-in-use-bytes":30400512,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-30T05:52:34.381955Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4027820834,"revision":14872,"compact-revision":12730} {"level":"info","ts":"2026-05-30T05:57:34.287366Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17344} {"level":"info","ts":"2026-05-30T05:57:34.39398Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17344,"took":"101.941678ms","hash":3191431105,"current-db-size-bytes":57561088,"current-db-size":"58 MB","current-db-size-in-use-bytes":29196288,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-30T05:57:34.394036Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3191431105,"revision":17344,"compact-revision":14872} {"level":"info","ts":"2026-05-30T05:58:14.626368Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fed19d9291630e09","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-30T05:58:14.631688Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-30T05:58:14.631906Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-30T06:02:34.296204Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19113} {"level":"info","ts":"2026-05-30T06:02:34.389124Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19113,"took":"88.935388ms","hash":1644273745,"current-db-size-bytes":57561088,"current-db-size":"58 MB","current-db-size-in-use-bytes":24834048,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-05-30T06:02:34.389206Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1644273745,"revision":19113,"compact-revision":17344}