{"level":"warn","ts":"2026-10-15T06:21:51.953453Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:21:51.953567Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.106: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.106:2380","--initial-cluster=instance=https://199.204.45.106:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.106:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.106: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-10-15T06:21:51.953669Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T06:21:51.953686Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.106:2380"]} {"level":"info","ts":"2026-10-15T06:21:51.953714Z","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-10-15T06:21:51.954419Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.106:2379"]} {"level":"info","ts":"2026-10-15T06:21:51.954518Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.106:2380"],"listen-peer-urls":["https://199.204.45.106:2380"],"advertise-client-urls":["https://199.204.45.106:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.106:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.106: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-10-15T06:21:51.96054Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.776722ms"} {"level":"info","ts":"2026-10-15T06:21:51.971628Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ed705fd75e8fffa1","cluster-id":"cc6a87afb0c7e34c"} {"level":"info","ts":"2026-10-15T06:21:51.97175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T06:21:51.971782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 became follower at term 0"} {"level":"info","ts":"2026-10-15T06:21:51.971799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ed705fd75e8fffa1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T06:21:51.971808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 became follower at term 1"} {"level":"info","ts":"2026-10-15T06:21:51.971863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 switched to configuration voters=(17109280362989617057)"} {"level":"warn","ts":"2026-10-15T06:21:51.980409Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T06:21:51.98209Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T06:21:51.984192Z","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-10-15T06:21:51.98898Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ed705fd75e8fffa1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T06:21:51.989162Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ed705fd75e8fffa1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T06:21:51.989487Z","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-10-15T06:21:51.989823Z","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-10-15T06:21:51.989838Z","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-10-15T06:21:51.99096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 switched to configuration voters=(17109280362989617057)"} {"level":"info","ts":"2026-10-15T06:21:51.991074Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cc6a87afb0c7e34c","local-member-id":"ed705fd75e8fffa1","added-peer-id":"ed705fd75e8fffa1","added-peer-peer-urls":["https://199.204.45.106:2380"]} {"level":"info","ts":"2026-10-15T06:21:51.991271Z","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-10-15T06:21:51.991443Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ed705fd75e8fffa1","initial-advertise-peer-urls":["https://199.204.45.106:2380"],"listen-peer-urls":["https://199.204.45.106:2380"],"advertise-client-urls":["https://199.204.45.106:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.106:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T06:21:51.991465Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T06:21:51.991567Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.106:2380"} {"level":"info","ts":"2026-10-15T06:21:51.991584Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.106:2380"} {"level":"info","ts":"2026-10-15T06:21:52.672736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T06:21:52.672797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T06:21:52.672839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 received MsgPreVoteResp from ed705fd75e8fffa1 at term 1"} {"level":"info","ts":"2026-10-15T06:21:52.672855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 became candidate at term 2"} {"level":"info","ts":"2026-10-15T06:21:52.672862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 received MsgVoteResp from ed705fd75e8fffa1 at term 2"} {"level":"info","ts":"2026-10-15T06:21:52.672873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ed705fd75e8fffa1 became leader at term 2"} {"level":"info","ts":"2026-10-15T06:21:52.672882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ed705fd75e8fffa1 elected leader ed705fd75e8fffa1 at term 2"} {"level":"info","ts":"2026-10-15T06:21:52.674063Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:21:52.674723Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ed705fd75e8fffa1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.106:2379]}","request-path":"/0/members/ed705fd75e8fffa1/attributes","cluster-id":"cc6a87afb0c7e34c","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T06:21:52.674767Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:21:52.674801Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:21:52.67522Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cc6a87afb0c7e34c","local-member-id":"ed705fd75e8fffa1","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:21:52.675356Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:21:52.6754Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:21:52.675063Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T06:21:52.675436Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T06:21:52.679903Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T06:21:52.680426Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.106:2379"} {"level":"info","ts":"2026-10-15T06:22:18.588529Z","caller":"traceutil/trace.go:171","msg":"trace[1667851530] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"171.051093ms","start":"2026-10-15T06:22:18.417438Z","end":"2026-10-15T06:22:18.588489Z","steps":["trace[1667851530] 'process raft request' (duration: 170.900399ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:37.014512Z","caller":"traceutil/trace.go:171","msg":"trace[826549938] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"148.275636ms","start":"2026-10-15T06:22:36.866159Z","end":"2026-10-15T06:22:37.014435Z","steps":["trace[826549938] 'process raft request' (duration: 138.368793ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:37.015782Z","caller":"traceutil/trace.go:171","msg":"trace[2086214314] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"146.32484ms","start":"2026-10-15T06:22:36.86942Z","end":"2026-10-15T06:22:37.015745Z","steps":["trace[2086214314] 'process raft request' (duration: 145.765327ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:37.01605Z","caller":"traceutil/trace.go:171","msg":"trace[989116101] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"142.613494ms","start":"2026-10-15T06:22:36.873412Z","end":"2026-10-15T06:22:37.016026Z","steps":["trace[989116101] 'process raft request' (duration: 142.135533ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:22:37.289684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.950145ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:22:37.289803Z","caller":"traceutil/trace.go:171","msg":"trace[1502244395] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"187.53366ms","start":"2026-10-15T06:22:37.102252Z","end":"2026-10-15T06:22:37.289786Z","steps":["trace[1502244395] 'process raft request' (duration: 26.808638ms)","trace[1502244395] 'compare' (duration: 159.758359ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:22:37.291961Z","caller":"traceutil/trace.go:171","msg":"trace[601752607] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"184.156592ms","start":"2026-10-15T06:22:37.107775Z","end":"2026-10-15T06:22:37.291931Z","steps":["trace[601752607] 'process raft request' (duration: 183.818083ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:37.292294Z","caller":"traceutil/trace.go:171","msg":"trace[944158710] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"181.17028ms","start":"2026-10-15T06:22:37.111096Z","end":"2026-10-15T06:22:37.292267Z","steps":["trace[944158710] 'process raft request' (duration: 180.851683ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:37.292308Z","caller":"traceutil/trace.go:171","msg":"trace[1921431784] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"178.687983ms","start":"2026-10-15T06:22:37.113583Z","end":"2026-10-15T06:22:37.292271Z","steps":["trace[1921431784] 'process raft request' (duration: 178.55162ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:43.030129Z","caller":"traceutil/trace.go:171","msg":"trace[1099853122] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"121.579461ms","start":"2026-10-15T06:22:42.908522Z","end":"2026-10-15T06:22:43.030102Z","steps":["trace[1099853122] 'process raft request' (duration: 120.792122ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:43.033312Z","caller":"traceutil/trace.go:171","msg":"trace[1417466050] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"118.527269ms","start":"2026-10-15T06:22:42.914762Z","end":"2026-10-15T06:22:43.033289Z","steps":["trace[1417466050] 'process raft request' (duration: 118.402086ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:43.731258Z","caller":"traceutil/trace.go:171","msg":"trace[268641708] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"134.673969ms","start":"2026-10-15T06:22:43.596554Z","end":"2026-10-15T06:22:43.731228Z","steps":["trace[268641708] 'read index received' (duration: 133.692326ms)","trace[268641708] 'applied index is now lower than readState.Index' (duration: 980.453µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:22:43.731305Z","caller":"traceutil/trace.go:171","msg":"trace[506529769] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"166.973598ms","start":"2026-10-15T06:22:43.564308Z","end":"2026-10-15T06:22:43.731281Z","steps":["trace[506529769] 'process raft request' (duration: 166.194999ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:22:43.731432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.850823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:22:43.731525Z","caller":"traceutil/trace.go:171","msg":"trace[1520433163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"134.980147ms","start":"2026-10-15T06:22:43.59652Z","end":"2026-10-15T06:22:43.7315Z","steps":["trace[1520433163] 'agreement among raft nodes before linearized reading' (duration: 134.809323ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:44.142344Z","caller":"traceutil/trace.go:171","msg":"trace[252526303] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"349.955012ms","start":"2026-10-15T06:22:43.792369Z","end":"2026-10-15T06:22:44.142324Z","steps":["trace[252526303] 'process raft request' (duration: 349.83805ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:22:44.142522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:22:43.792344Z","time spent":"350.058294ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:22:44.413159Z","caller":"traceutil/trace.go:171","msg":"trace[10529859] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:669; }","duration":"481.363786ms","start":"2026-10-15T06:22:43.931761Z","end":"2026-10-15T06:22:44.413125Z","steps":["trace[10529859] 'read index received' (duration: 210.45279ms)","trace[10529859] 'applied index is now lower than readState.Index' (duration: 270.909716ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:22:44.413331Z","caller":"traceutil/trace.go:171","msg":"trace[180821968] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"605.512743ms","start":"2026-10-15T06:22:43.807803Z","end":"2026-10-15T06:22:44.413316Z","steps":["trace[180821968] 'process raft request' (duration: 548.547445ms)","trace[180821968] 'compare' (duration: 56.575839ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:22:44.413452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:22:43.807785Z","time spent":"605.580834ms","remote":"127.0.0.1:43954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T06:22:44.41363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.234724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-15T06:22:44.413636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.15271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-15T06:22:44.413742Z","caller":"traceutil/trace.go:171","msg":"trace[2015207957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"226.290453ms","start":"2026-10-15T06:22:44.187437Z","end":"2026-10-15T06:22:44.413727Z","steps":["trace[2015207957] 'agreement among raft nodes before linearized reading' (duration: 226.032997ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:22:44.41367Z","caller":"traceutil/trace.go:171","msg":"trace[1218603450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"364.341206ms","start":"2026-10-15T06:22:44.049318Z","end":"2026-10-15T06:22:44.413659Z","steps":["trace[1218603450] 'agreement among raft nodes before linearized reading' (duration: 364.021649ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:22:44.413796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:22:44.049296Z","time spent":"364.48972ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T06:22:44.413776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.020981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fzcnn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-15T06:22:44.414008Z","caller":"traceutil/trace.go:171","msg":"trace[1224560557] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fzcnn; range_end:; response_count:1; response_revision:648; }","duration":"482.285367ms","start":"2026-10-15T06:22:43.931715Z","end":"2026-10-15T06:22:44.414001Z","steps":["trace[1224560557] 'agreement among raft nodes before linearized reading' (duration: 481.692894ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:22:44.414036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:22:43.931698Z","time spent":"482.331629ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-fzcnn\" "} {"level":"warn","ts":"2026-10-15T06:22:46.249032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.154195ms","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-10-15T06:22:46.24911Z","caller":"traceutil/trace.go:171","msg":"trace[416637263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:687; }","duration":"102.274138ms","start":"2026-10-15T06:22:46.146816Z","end":"2026-10-15T06:22:46.24909Z","steps":["trace[416637263] 'range keys from in-memory index tree' (duration: 101.96882ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:23:00.216857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.45077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-15T06:23:00.217108Z","caller":"traceutil/trace.go:171","msg":"trace[1956778491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:813; }","duration":"360.756415ms","start":"2026-10-15T06:22:59.856316Z","end":"2026-10-15T06:23:00.217072Z","steps":["trace[1956778491] 'range keys from in-memory index tree' (duration: 360.235204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:23:00.216926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.78308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bbxqk\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-10-15T06:23:00.217237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:22:59.856298Z","time spent":"360.887279ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-15T06:23:00.218385Z","caller":"traceutil/trace.go:171","msg":"trace[663207626] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bbxqk; range_end:; response_count:1; response_revision:813; }","duration":"179.469696ms","start":"2026-10-15T06:23:00.038072Z","end":"2026-10-15T06:23:00.217542Z","steps":["trace[663207626] 'range keys from in-memory index tree' (duration: 178.535264ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:23:31.703748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.036943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:23:31.70393Z","caller":"traceutil/trace.go:171","msg":"trace[956435252] linearizableReadLoop","detail":"{readStateIndex:1252; appliedIndex:1251; }","duration":"312.050008ms","start":"2026-10-15T06:23:31.391858Z","end":"2026-10-15T06:23:31.703908Z","steps":["trace[956435252] 'read index received' (duration: 50.281µs)","trace[956435252] 'applied index is now lower than readState.Index' (duration: 311.998217ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:23:31.704014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.17198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:23:31.704055Z","caller":"traceutil/trace.go:171","msg":"trace[560172346] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1217; }","duration":"312.269673ms","start":"2026-10-15T06:23:31.391772Z","end":"2026-10-15T06:23:31.704042Z","steps":["trace[560172346] 'agreement among raft nodes before linearized reading' (duration: 312.196541ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:23:31.704027Z","caller":"traceutil/trace.go:171","msg":"trace[24857827] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"340.179704ms","start":"2026-10-15T06:23:31.363758Z","end":"2026-10-15T06:23:31.703938Z","steps":["trace[24857827] 'process raft request' (duration: 13.842484ms)","trace[24857827] 'compare' (duration: 325.871079ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:23:31.704099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:23:31.391749Z","time spent":"312.337964ms","remote":"127.0.0.1:43908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-10-15T06:23:31.704338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:23:31.363727Z","time spent":"340.429308ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:23:47.541981Z","caller":"traceutil/trace.go:171","msg":"trace[373347541] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"115.247112ms","start":"2026-10-15T06:23:47.426693Z","end":"2026-10-15T06:23:47.54194Z","steps":["trace[373347541] 'process raft request' (duration: 115.033098ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:24:05.850518Z","caller":"traceutil/trace.go:171","msg":"trace[2042740011] transaction","detail":"{read_only:false; response_revision:1705; number_of_response:1; }","duration":"112.949938ms","start":"2026-10-15T06:24:05.737543Z","end":"2026-10-15T06:24:05.850493Z","steps":["trace[2042740011] 'process raft request' (duration: 112.59726ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:24:18.777569Z","caller":"traceutil/trace.go:171","msg":"trace[1015468506] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"166.315069ms","start":"2026-10-15T06:24:18.611213Z","end":"2026-10-15T06:24:18.777528Z","steps":["trace[1015468506] 'read index received' (duration: 166.116235ms)","trace[1015468506] 'applied index is now lower than readState.Index' (duration: 197.904µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:24:18.777634Z","caller":"traceutil/trace.go:171","msg":"trace[996617157] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"312.213856ms","start":"2026-10-15T06:24:18.465389Z","end":"2026-10-15T06:24:18.777603Z","steps":["trace[996617157] 'process raft request' (duration: 311.920459ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:24:18.777837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:24:18.465361Z","time spent":"312.347999ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:24:18.778044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.592965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-15T06:24:18.778099Z","caller":"traceutil/trace.go:171","msg":"trace[585830953] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1881; }","duration":"166.911373ms","start":"2026-10-15T06:24:18.611169Z","end":"2026-10-15T06:24:18.77808Z","steps":["trace[585830953] 'agreement among raft nodes before linearized reading' (duration: 166.510544ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:24:19.23878Z","caller":"traceutil/trace.go:171","msg":"trace[1450608879] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"223.770712ms","start":"2026-10-15T06:24:19.014953Z","end":"2026-10-15T06:24:19.238723Z","steps":["trace[1450608879] 'process raft request' (duration: 186.09848ms)","trace[1450608879] 'compare' (duration: 37.557759ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:24:47.276879Z","caller":"traceutil/trace.go:171","msg":"trace[78352461] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"122.988503ms","start":"2026-10-15T06:24:47.153859Z","end":"2026-10-15T06:24:47.276847Z","steps":["trace[78352461] 'process raft request' (duration: 83.400029ms)","trace[78352461] 'compare' (duration: 39.212787ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:24:52.428593Z","caller":"traceutil/trace.go:171","msg":"trace[765318801] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"196.069079ms","start":"2026-10-15T06:24:52.232496Z","end":"2026-10-15T06:24:52.428565Z","steps":["trace[765318801] 'process raft request' (duration: 108.130288ms)","trace[765318801] 'compare' (duration: 87.568124ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:24:52.428707Z","caller":"traceutil/trace.go:171","msg":"trace[1983139890] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"196.019018ms","start":"2026-10-15T06:24:52.232642Z","end":"2026-10-15T06:24:52.428661Z","steps":["trace[1983139890] 'process raft request' (duration: 195.656781ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:24:53.406944Z","caller":"traceutil/trace.go:171","msg":"trace[1508200525] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"101.004977ms","start":"2026-10-15T06:24:53.3059Z","end":"2026-10-15T06:24:53.406905Z","steps":["trace[1508200525] 'process raft request' (duration: 100.730931ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:24:53.704675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.284874ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:24:53.704766Z","caller":"traceutil/trace.go:171","msg":"trace[346239162] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2204; }","duration":"287.612416ms","start":"2026-10-15T06:24:53.417142Z","end":"2026-10-15T06:24:53.704755Z","steps":["trace[346239162] 'read index received' (duration: 175.142538ms)","trace[346239162] 'applied index is now lower than readState.Index' (duration: 112.468738ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:24:53.704908Z","caller":"traceutil/trace.go:171","msg":"trace[576158476] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"293.114221ms","start":"2026-10-15T06:24:53.411785Z","end":"2026-10-15T06:24:53.7049Z","steps":["trace[576158476] 'process raft request' (duration: 180.548491ms)","trace[576158476] 'compare' (duration: 112.045539ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:24:53.705165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.374852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T06:24:53.705232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.097525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-15T06:24:53.705244Z","caller":"traceutil/trace.go:171","msg":"trace[1159672374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2127; }","duration":"108.506333ms","start":"2026-10-15T06:24:53.596721Z","end":"2026-10-15T06:24:53.705227Z","steps":["trace[1159672374] 'agreement among raft nodes before linearized reading' (duration: 108.378961ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:24:53.705436Z","caller":"traceutil/trace.go:171","msg":"trace[1249769428] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2127; }","duration":"288.172497ms","start":"2026-10-15T06:24:53.417092Z","end":"2026-10-15T06:24:53.705265Z","steps":["trace[1249769428] 'agreement among raft nodes before linearized reading' (duration: 288.041175ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:25:58.413709Z","caller":"traceutil/trace.go:171","msg":"trace[582717497] transaction","detail":"{read_only:false; response_revision:2576; number_of_response:1; }","duration":"283.063729ms","start":"2026-10-15T06:25:58.130622Z","end":"2026-10-15T06:25:58.413685Z","steps":["trace[582717497] 'process raft request' (duration: 280.675134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:30.992694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.06725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-15T06:26:30.99287Z","caller":"traceutil/trace.go:171","msg":"trace[1707383545] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2754; }","duration":"259.212964ms","start":"2026-10-15T06:26:30.733554Z","end":"2026-10-15T06:26:30.992767Z","steps":["trace[1707383545] 'range keys from in-memory index tree' (duration: 258.824125ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:26:31.11777Z","caller":"traceutil/trace.go:171","msg":"trace[120108203] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"119.673129ms","start":"2026-10-15T06:26:30.998056Z","end":"2026-10-15T06:26:31.117729Z","steps":["trace[120108203] 'process raft request' (duration: 119.408914ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:29:11.78799Z","caller":"traceutil/trace.go:171","msg":"trace[2137488626] transaction","detail":"{read_only:false; response_revision:3631; number_of_response:1; }","duration":"115.058841ms","start":"2026-10-15T06:29:11.672905Z","end":"2026-10-15T06:29:11.787964Z","steps":["trace[2137488626] 'process raft request' (duration: 103.150436ms)","trace[2137488626] 'compare' (duration: 11.766053ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:07.030182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.750518ms","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-10-15T06:31:07.0303Z","caller":"traceutil/trace.go:171","msg":"trace[1121215011] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4814; }","duration":"155.882011ms","start":"2026-10-15T06:31:06.874402Z","end":"2026-10-15T06:31:07.030284Z","steps":["trace[1121215011] 'range keys from in-memory index tree' (duration: 155.734928ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:07.030752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.21417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2362739"} {"level":"info","ts":"2026-10-15T06:31:07.030785Z","caller":"traceutil/trace.go:171","msg":"trace[198153183] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4814; }","duration":"131.276411ms","start":"2026-10-15T06:31:06.899501Z","end":"2026-10-15T06:31:07.030778Z","steps":["trace[198153183] 'range keys from in-memory index tree' (duration: 130.441134ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:08.614407Z","caller":"traceutil/trace.go:171","msg":"trace[1090060673] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5022; }","duration":"116.61414ms","start":"2026-10-15T06:31:08.497777Z","end":"2026-10-15T06:31:08.614391Z","steps":["trace[1090060673] 'read index received' (duration: 99.929726ms)","trace[1090060673] 'applied index is now lower than readState.Index' (duration: 16.683754ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:08.614496Z","caller":"traceutil/trace.go:171","msg":"trace[1657739077] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"116.941317ms","start":"2026-10-15T06:31:08.497537Z","end":"2026-10-15T06:31:08.614479Z","steps":["trace[1657739077] 'process raft request' (duration: 100.228522ms)","trace[1657739077] 'compare' (duration: 16.50451ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:08.614618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.936504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:08.614691Z","caller":"traceutil/trace.go:171","msg":"trace[1979303196] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4844; }","duration":"115.015116ms","start":"2026-10-15T06:31:08.499658Z","end":"2026-10-15T06:31:08.614673Z","steps":["trace[1979303196] 'agreement among raft nodes before linearized reading' (duration: 114.905573ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:08.614553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.754143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:08.614777Z","caller":"traceutil/trace.go:171","msg":"trace[514327966] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:4844; }","duration":"116.997638ms","start":"2026-10-15T06:31:08.497768Z","end":"2026-10-15T06:31:08.614766Z","steps":["trace[514327966] 'agreement among raft nodes before linearized reading' (duration: 116.723462ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:12.424248Z","caller":"traceutil/trace.go:171","msg":"trace[1695224579] linearizableReadLoop","detail":"{readStateIndex:5103; appliedIndex:5102; }","duration":"167.750112ms","start":"2026-10-15T06:31:12.256483Z","end":"2026-10-15T06:31:12.424233Z","steps":["trace[1695224579] 'read index received' (duration: 141.512047ms)","trace[1695224579] 'applied index is now lower than readState.Index' (duration: 26.237515ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:12.424326Z","caller":"traceutil/trace.go:171","msg":"trace[1253721565] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"173.597896ms","start":"2026-10-15T06:31:12.250722Z","end":"2026-10-15T06:31:12.42432Z","steps":["trace[1253721565] 'process raft request' (duration: 147.240959ms)","trace[1253721565] 'compare' (duration: 26.191233ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:12.42452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.026519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14497"} {"level":"info","ts":"2026-10-15T06:31:12.424541Z","caller":"traceutil/trace.go:171","msg":"trace[2029066066] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4922; }","duration":"168.07872ms","start":"2026-10-15T06:31:12.256457Z","end":"2026-10-15T06:31:12.424535Z","steps":["trace[2029066066] 'agreement among raft nodes before linearized reading' (duration: 167.971987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:12.424639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.566216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-15T06:31:12.424654Z","caller":"traceutil/trace.go:171","msg":"trace[2057055445] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4922; }","duration":"165.618548ms","start":"2026-10-15T06:31:12.259032Z","end":"2026-10-15T06:31:12.424651Z","steps":["trace[2057055445] 'agreement among raft nodes before linearized reading' (duration: 165.576587ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:12.42478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.212711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-10-15T06:31:12.424797Z","caller":"traceutil/trace.go:171","msg":"trace[2009772941] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4922; }","duration":"133.243901ms","start":"2026-10-15T06:31:12.291548Z","end":"2026-10-15T06:31:12.424792Z","steps":["trace[2009772941] 'agreement among raft nodes before linearized reading' (duration: 133.199781ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:12.424885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.566739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-15T06:31:12.4249Z","caller":"traceutil/trace.go:171","msg":"trace[522443070] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4922; }","duration":"134.610431ms","start":"2026-10-15T06:31:12.290285Z","end":"2026-10-15T06:31:12.424896Z","steps":["trace[522443070] 'agreement among raft nodes before linearized reading' (duration: 134.56912ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:15.24322Z","caller":"traceutil/trace.go:171","msg":"trace[1423635883] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"132.895174ms","start":"2026-10-15T06:31:15.110306Z","end":"2026-10-15T06:31:15.243201Z","steps":["trace[1423635883] 'process raft request' (duration: 132.752151ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:15.636432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.752794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:31:15.636527Z","caller":"traceutil/trace.go:171","msg":"trace[1805162064] linearizableReadLoop","detail":"{readStateIndex:5185; appliedIndex:5184; }","duration":"122.839531ms","start":"2026-10-15T06:31:15.513673Z","end":"2026-10-15T06:31:15.636512Z","steps":["trace[1805162064] 'read index received' (duration: 41.441µs)","trace[1805162064] 'applied index is now lower than readState.Index' (duration: 122.79701ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:15.636576Z","caller":"traceutil/trace.go:171","msg":"trace[403377985] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"215.323369ms","start":"2026-10-15T06:31:15.421229Z","end":"2026-10-15T06:31:15.636553Z","steps":["trace[403377985] 'process raft request' (duration: 71.35785ms)","trace[403377985] 'compare' (duration: 143.642501ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:15.636716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.043485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c44df3ab-a5db-4022-9ca3-4e6fb41c1b19\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-15T06:31:15.636751Z","caller":"traceutil/trace.go:171","msg":"trace[1421408825] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c44df3ab-a5db-4022-9ca3-4e6fb41c1b19; range_end:; response_count:1; response_revision:5003; }","duration":"123.078606ms","start":"2026-10-15T06:31:15.513661Z","end":"2026-10-15T06:31:15.63674Z","steps":["trace[1421408825] 'agreement among raft nodes before linearized reading' (duration: 122.890462ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.251366Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18420181239545205358,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-15T06:31:16.431069Z","caller":"traceutil/trace.go:171","msg":"trace[1075322458] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"788.724499ms","start":"2026-10-15T06:31:15.642324Z","end":"2026-10-15T06:31:16.431049Z","steps":["trace[1075322458] 'process raft request' (duration: 775.51121ms)","trace[1075322458] 'compare' (duration: 13.130928ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:16.431181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:15.642305Z","time spent":"788.816542ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:31:16.438036Z","caller":"traceutil/trace.go:171","msg":"trace[943544639] linearizableReadLoop","detail":"{readStateIndex:5188; appliedIndex:5185; }","duration":"687.328243ms","start":"2026-10-15T06:31:15.750689Z","end":"2026-10-15T06:31:16.438017Z","steps":["trace[943544639] 'read index received' (duration: 667.129406ms)","trace[943544639] 'applied index is now lower than readState.Index' (duration: 20.198327ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:16.438113Z","caller":"traceutil/trace.go:171","msg":"trace[1507744389] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"561.325104ms","start":"2026-10-15T06:31:15.876781Z","end":"2026-10-15T06:31:16.438106Z","steps":["trace[1507744389] 'process raft request' (duration: 561.212922ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.438181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:15.876756Z","time spent":"561.369676ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:31:16.438148Z","caller":"traceutil/trace.go:171","msg":"trace[843816369] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"712.832902ms","start":"2026-10-15T06:31:15.725272Z","end":"2026-10-15T06:31:16.438105Z","steps":["trace[843816369] 'process raft request' (duration: 712.629418ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.438289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.540532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:16.438311Z","caller":"traceutil/trace.go:171","msg":"trace[621024411] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:5006; }","duration":"257.595634ms","start":"2026-10-15T06:31:16.180709Z","end":"2026-10-15T06:31:16.438305Z","steps":["trace[621024411] 'agreement among raft nodes before linearized reading' (duration: 257.555323ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.438302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.880934ms","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-10-15T06:31:16.438335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:15.725257Z","time spent":"712.996745ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:31:16.438367Z","caller":"traceutil/trace.go:171","msg":"trace[76734908] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5006; }","duration":"679.973575ms","start":"2026-10-15T06:31:15.758378Z","end":"2026-10-15T06:31:16.438352Z","steps":["trace[76734908] 'agreement among raft nodes before linearized reading' (duration: 679.758861ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.438415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:15.758366Z","time spent":"680.038518ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-15T06:31:16.438516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.834723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-15T06:31:16.438538Z","caller":"traceutil/trace.go:171","msg":"trace[1580960479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5006; }","duration":"687.892304ms","start":"2026-10-15T06:31:15.75064Z","end":"2026-10-15T06:31:16.438532Z","steps":["trace[1580960479] 'agreement among raft nodes before linearized reading' (duration: 687.772372ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.438557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:15.750622Z","time spent":"687.930575ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T06:31:16.438657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.255218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.106\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-10-15T06:31:16.438682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.095469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:16.438702Z","caller":"traceutil/trace.go:171","msg":"trace[117203680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5006; }","duration":"637.14629ms","start":"2026-10-15T06:31:15.80155Z","end":"2026-10-15T06:31:16.438697Z","steps":["trace[117203680] 'agreement among raft nodes before linearized reading' (duration: 637.110159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.438718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:15.801533Z","time spent":"637.180851ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-15T06:31:16.438709Z","caller":"traceutil/trace.go:171","msg":"trace[747257519] range","detail":"{range_begin:/registry/masterleases/199.204.45.106; range_end:; response_count:1; response_revision:5006; }","duration":"250.323999ms","start":"2026-10-15T06:31:16.188367Z","end":"2026-10-15T06:31:16.438691Z","steps":["trace[747257519] 'agreement among raft nodes before linearized reading' (duration: 250.155966ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.438746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.820902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c44df3ab-a5db-4022-9ca3-4e6fb41c1b19\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-10-15T06:31:16.438811Z","caller":"traceutil/trace.go:171","msg":"trace[1498382302] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c44df3ab-a5db-4022-9ca3-4e6fb41c1b19; range_end:; response_count:1; response_revision:5006; }","duration":"618.908174ms","start":"2026-10-15T06:31:15.819884Z","end":"2026-10-15T06:31:16.438793Z","steps":["trace[1498382302] 'agreement among raft nodes before linearized reading' (duration: 618.79123ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.43884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.803738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-10-15T06:31:16.438862Z","caller":"traceutil/trace.go:171","msg":"trace[222537815] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5006; }","duration":"623.850989ms","start":"2026-10-15T06:31:15.815003Z","end":"2026-10-15T06:31:16.438854Z","steps":["trace[222537815] 'agreement among raft nodes before linearized reading' (duration: 623.787787ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:16.438856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:15.819873Z","time spent":"618.971175ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3790,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c44df3ab-a5db-4022-9ca3-4e6fb41c1b19\" "} {"level":"warn","ts":"2026-10-15T06:31:16.438878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:15.81499Z","time spent":"623.883999ms","remote":"127.0.0.1:57614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3268,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-10-15T06:31:18.736485Z","caller":"traceutil/trace.go:171","msg":"trace[782857401] linearizableReadLoop","detail":"{readStateIndex:5220; appliedIndex:5219; }","duration":"139.284939ms","start":"2026-10-15T06:31:18.597171Z","end":"2026-10-15T06:31:18.736456Z","steps":["trace[782857401] 'read index received' (duration: 133.715911ms)","trace[782857401] 'applied index is now lower than readState.Index' (duration: 5.567638ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:18.736575Z","caller":"traceutil/trace.go:171","msg":"trace[926529301] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"154.90868ms","start":"2026-10-15T06:31:18.581643Z","end":"2026-10-15T06:31:18.736552Z","steps":["trace[926529301] 'process raft request' (duration: 149.21186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:18.736683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.089655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T06:31:18.736755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.558125ms","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-10-15T06:31:18.736773Z","caller":"traceutil/trace.go:171","msg":"trace[1799086192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5037; }","duration":"139.224958ms","start":"2026-10-15T06:31:18.597523Z","end":"2026-10-15T06:31:18.736748Z","steps":["trace[1799086192] 'agreement among raft nodes before linearized reading' (duration: 139.088705ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:18.736806Z","caller":"traceutil/trace.go:171","msg":"trace[511296759] 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:5037; }","duration":"139.684298ms","start":"2026-10-15T06:31:18.597105Z","end":"2026-10-15T06:31:18.736789Z","steps":["trace[511296759] 'agreement among raft nodes before linearized reading' (duration: 139.502264ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.151269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.629015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:31:31.151361Z","caller":"traceutil/trace.go:171","msg":"trace[1619870982] linearizableReadLoop","detail":"{readStateIndex:5369; appliedIndex:5368; }","duration":"507.1055ms","start":"2026-10-15T06:31:30.644242Z","end":"2026-10-15T06:31:31.151348Z","steps":["trace[1619870982] 'read index received' (duration: 21.150607ms)","trace[1619870982] 'applied index is now lower than readState.Index' (duration: 485.953712ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:31.151432Z","caller":"traceutil/trace.go:171","msg":"trace[171458286] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"522.018235ms","start":"2026-10-15T06:31:30.629402Z","end":"2026-10-15T06:31:31.151421Z","steps":["trace[171458286] 'process raft request' (duration: 36.028242ms)","trace[171458286] 'compare' (duration: 485.434211ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:31.151471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:30.629381Z","time spent":"522.068266ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:31:31.151587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.571678ms","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-10-15T06:31:31.15164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.204992ms","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-10-15T06:31:31.151657Z","caller":"traceutil/trace.go:171","msg":"trace[1716200660] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5182; }","duration":"489.670031ms","start":"2026-10-15T06:31:30.661968Z","end":"2026-10-15T06:31:31.151638Z","steps":["trace[1716200660] 'agreement among raft nodes before linearized reading' (duration: 489.488897ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.151671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.463037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-10-15T06:31:31.151693Z","caller":"traceutil/trace.go:171","msg":"trace[1122452923] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5182; }","duration":"300.533969ms","start":"2026-10-15T06:31:30.851152Z","end":"2026-10-15T06:31:31.151686Z","steps":["trace[1122452923] 'agreement among raft nodes before linearized reading' (duration: 300.481538ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.1517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:30.661952Z","time spent":"489.736602ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-15T06:31:31.151696Z","caller":"traceutil/trace.go:171","msg":"trace[2134614189] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5182; }","duration":"300.278404ms","start":"2026-10-15T06:31:30.851401Z","end":"2026-10-15T06:31:31.151679Z","steps":["trace[2134614189] 'agreement among raft nodes before linearized reading' (duration: 300.073679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.151715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:30.851134Z","time spent":"300.57709ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-10-15T06:31:31.151741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:30.851395Z","time spent":"300.335355ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-15T06:31:31.151618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.620323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-15T06:31:31.151812Z","caller":"traceutil/trace.go:171","msg":"trace[1661716606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5182; }","duration":"484.818467ms","start":"2026-10-15T06:31:30.666981Z","end":"2026-10-15T06:31:31.1518Z","steps":["trace[1661716606] 'agreement among raft nodes before linearized reading' (duration: 484.569122ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.151875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:30.666976Z","time spent":"484.862988ms","remote":"127.0.0.1:43702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T06:31:31.151913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.692932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-10-15T06:31:31.151956Z","caller":"traceutil/trace.go:171","msg":"trace[621204767] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5182; }","duration":"507.758784ms","start":"2026-10-15T06:31:30.644181Z","end":"2026-10-15T06:31:31.15194Z","steps":["trace[621204767] 'agreement among raft nodes before linearized reading' (duration: 507.648092ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.151995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:30.644152Z","time spent":"507.834225ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10416,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-10-15T06:31:31.152149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.726432ms","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-10-15T06:31:31.152184Z","caller":"traceutil/trace.go:171","msg":"trace[1149277498] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5182; }","duration":"489.776033ms","start":"2026-10-15T06:31:30.662401Z","end":"2026-10-15T06:31:31.152177Z","steps":["trace[1149277498] 'agreement among raft nodes before linearized reading' (duration: 489.356264ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.152202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:30.662394Z","time spent":"489.803303ms","remote":"127.0.0.1:43598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-10-15T06:31:31.353748Z","caller":"traceutil/trace.go:171","msg":"trace[8353727] transaction","detail":"{read_only:false; response_revision:5184; number_of_response:1; }","duration":"196.043708ms","start":"2026-10-15T06:31:31.15768Z","end":"2026-10-15T06:31:31.353723Z","steps":["trace[8353727] 'process raft request' (duration: 139.977612ms)","trace[8353727] 'compare' (duration: 55.561696ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:31.353752Z","caller":"traceutil/trace.go:171","msg":"trace[1255011832] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"195.695721ms","start":"2026-10-15T06:31:31.158025Z","end":"2026-10-15T06:31:31.353721Z","steps":["trace[1255011832] 'process raft request' (duration: 195.493297ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:31.353789Z","caller":"traceutil/trace.go:171","msg":"trace[1670596579] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"194.700069ms","start":"2026-10-15T06:31:31.159073Z","end":"2026-10-15T06:31:31.353773Z","steps":["trace[1670596579] 'process raft request' (duration: 194.519185ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:31.354404Z","caller":"traceutil/trace.go:171","msg":"trace[1525408117] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"188.247213ms","start":"2026-10-15T06:31:31.166094Z","end":"2026-10-15T06:31:31.354341Z","steps":["trace[1525408117] 'process raft request' (duration: 187.535018ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:31.606954Z","caller":"traceutil/trace.go:171","msg":"trace[1416973026] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"172.624092ms","start":"2026-10-15T06:31:31.434305Z","end":"2026-10-15T06:31:31.606929Z","steps":["trace[1416973026] 'process raft request' (duration: 105.133375ms)","trace[1416973026] 'compare' (duration: 67.276863ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:31.607374Z","caller":"traceutil/trace.go:171","msg":"trace[570914229] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"172.806726ms","start":"2026-10-15T06:31:31.434546Z","end":"2026-10-15T06:31:31.607352Z","steps":["trace[570914229] 'process raft request' (duration: 172.300866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.817849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.188594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:31:31.818246Z","caller":"traceutil/trace.go:171","msg":"trace[2065260929] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"375.813181ms","start":"2026-10-15T06:31:31.442285Z","end":"2026-10-15T06:31:31.818098Z","steps":["trace[2065260929] 'process raft request' (duration: 271.28584ms)","trace[2065260929] 'compare' (duration: 103.995159ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:31.818356Z","caller":"traceutil/trace.go:171","msg":"trace[383645190] linearizableReadLoop","detail":"{readStateIndex:5384; appliedIndex:5383; }","duration":"261.993762ms","start":"2026-10-15T06:31:31.556315Z","end":"2026-10-15T06:31:31.818308Z","steps":["trace[383645190] 'read index received' (duration: 157.266897ms)","trace[383645190] 'applied index is now lower than readState.Index' (duration: 104.724565ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:31.818722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:31.442271Z","time spent":"376.061417ms","remote":"127.0.0.1:43930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T06:31:31.95403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.044729ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"warn","ts":"2026-10-15T06:31:31.954049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.717555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-10-15T06:31:31.954207Z","caller":"traceutil/trace.go:171","msg":"trace[246916091] linearizableReadLoop","detail":"{readStateIndex:5385; appliedIndex:5384; }","duration":"135.748593ms","start":"2026-10-15T06:31:31.8184Z","end":"2026-10-15T06:31:31.954149Z","steps":["trace[246916091] 'read index received' (duration: 84.552µs)","trace[246916091] 'applied index is now lower than readState.Index' (duration: 135.661901ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:31.954236Z","caller":"traceutil/trace.go:171","msg":"trace[1249330073] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5197; }","duration":"397.950119ms","start":"2026-10-15T06:31:31.556261Z","end":"2026-10-15T06:31:31.954211Z","steps":["trace[1249330073] 'agreement among raft nodes before linearized reading' (duration: 262.185116ms)","trace[1249330073] 'range keys from in-memory index tree' (duration: 135.387655ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:31.954302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.134748ms","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-10-15T06:31:31.954357Z","caller":"traceutil/trace.go:171","msg":"trace[2097193239] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5197; }","duration":"221.235531ms","start":"2026-10-15T06:31:31.733109Z","end":"2026-10-15T06:31:31.954345Z","steps":["trace[2097193239] 'agreement among raft nodes before linearized reading' (duration: 221.101328ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.954288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.437612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:31:31.954563Z","caller":"traceutil/trace.go:171","msg":"trace[264209582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5197; }","duration":"357.751669ms","start":"2026-10-15T06:31:31.596802Z","end":"2026-10-15T06:31:31.954554Z","steps":["trace[264209582] 'agreement among raft nodes before linearized reading' (duration: 357.443503ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:31.954592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:31.596786Z","time spent":"357.796939ms","remote":"127.0.0.1:43404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-15T06:31:31.954303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:31:31.55624Z","time spent":"398.046171ms","remote":"127.0.0.1:57614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3268,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-10-15T06:31:31.95489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.135807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-15T06:31:31.954928Z","caller":"traceutil/trace.go:171","msg":"trace[588873068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5197; }","duration":"150.215218ms","start":"2026-10-15T06:31:31.804702Z","end":"2026-10-15T06:31:31.954917Z","steps":["trace[588873068] 'agreement among raft nodes before linearized reading' (duration: 150.123336ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.013454Z","caller":"traceutil/trace.go:171","msg":"trace[1827985481] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"179.342915ms","start":"2026-10-15T06:31:31.834089Z","end":"2026-10-15T06:31:32.013431Z","steps":["trace[1827985481] 'process raft request' (duration: 179.178791ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.127865Z","caller":"traceutil/trace.go:171","msg":"trace[1871291649] linearizableReadLoop","detail":"{readStateIndex:5387; appliedIndex:5386; }","duration":"114.349589ms","start":"2026-10-15T06:31:32.013492Z","end":"2026-10-15T06:31:32.127842Z","steps":["trace[1871291649] 'read index received' (duration: 45.041803ms)","trace[1871291649] 'applied index is now lower than readState.Index' (duration: 69.306836ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:32.127882Z","caller":"traceutil/trace.go:171","msg":"trace[249429063] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"169.423025ms","start":"2026-10-15T06:31:31.958432Z","end":"2026-10-15T06:31:32.127855Z","steps":["trace[249429063] 'process raft request' (duration: 100.135378ms)","trace[249429063] 'compare' (duration: 69.168874ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:31:32.128036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.949437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c44df3ab-a5db-4022-9ca3-4e6fb41c1b19\" ","response":"range_response_count:1 size:1322"} {"level":"warn","ts":"2026-10-15T06:31:32.128037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.217977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1162"} {"level":"info","ts":"2026-10-15T06:31:32.12807Z","caller":"traceutil/trace.go:171","msg":"trace[992386610] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c44df3ab-a5db-4022-9ca3-4e6fb41c1b19; range_end:; response_count:1; response_revision:5199; }","duration":"171.027658ms","start":"2026-10-15T06:31:31.957031Z","end":"2026-10-15T06:31:32.128058Z","steps":["trace[992386610] 'agreement among raft nodes before linearized reading' (duration: 170.897935ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.128084Z","caller":"traceutil/trace.go:171","msg":"trace[1292971902] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:5199; }","duration":"167.275188ms","start":"2026-10-15T06:31:31.960796Z","end":"2026-10-15T06:31:32.128071Z","steps":["trace[1292971902] 'agreement among raft nodes before linearized reading' (duration: 167.111015ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:32.849231Z","caller":"traceutil/trace.go:171","msg":"trace[398617059] linearizableReadLoop","detail":"{readStateIndex:5393; appliedIndex:5392; }","duration":"112.221104ms","start":"2026-10-15T06:31:32.736989Z","end":"2026-10-15T06:31:32.849211Z","steps":["trace[398617059] 'read index received' (duration: 112.01678ms)","trace[398617059] 'applied index is now lower than readState.Index' (duration: 203.544µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:31:32.849273Z","caller":"traceutil/trace.go:171","msg":"trace[436925784] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"163.555291ms","start":"2026-10-15T06:31:32.685696Z","end":"2026-10-15T06:31:32.849251Z","steps":["trace[436925784] 'process raft request' (duration: 163.369737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:31:32.849492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.472319ms","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-10-15T06:31:32.849568Z","caller":"traceutil/trace.go:171","msg":"trace[1122574245] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5205; }","duration":"112.587952ms","start":"2026-10-15T06:31:32.73696Z","end":"2026-10-15T06:31:32.849548Z","steps":["trace[1122574245] 'agreement among raft nodes before linearized reading' (duration: 112.358557ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:31:52.699684Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2870} {"level":"info","ts":"2026-10-15T06:31:52.781608Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2870,"took":"80.539902ms","hash":268144441,"current-db-size-bytes":51798016,"current-db-size":"52 MB","current-db-size-in-use-bytes":28250112,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T06:31:52.781675Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":268144441,"revision":2870,"compact-revision":-1} {"level":"info","ts":"2026-10-15T06:36:52.706975Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5346} {"level":"info","ts":"2026-10-15T06:36:52.794591Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5346,"took":"85.939984ms","hash":2228855646,"current-db-size-bytes":51798016,"current-db-size":"52 MB","current-db-size-in-use-bytes":18784256,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-15T06:36:52.794677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2228855646,"revision":5346,"compact-revision":2870}