{"level":"warn","ts":"2026-04-08T06:17:31.792603Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T06:17:31.792694Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-04-08T06:17:31.792766Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T06:17:31.792779Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-08T06:17:31.792797Z","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-04-08T06:17:31.793464Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-04-08T06:17:31.793552Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-04-08T06:17:31.798655Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.247736ms"} {"level":"info","ts":"2026-04-08T06:17:31.805231Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-04-08T06:17:31.805314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T06:17:31.805338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-04-08T06:17:31.805353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T06:17:31.805416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-04-08T06:17:31.805457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-04-08T06:17:31.811016Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T06:17:31.813313Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T06:17:31.815557Z","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-04-08T06:17:31.821087Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T06:17:31.821254Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T06:17:31.821467Z","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-04-08T06:17:31.821578Z","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-04-08T06:17:31.821596Z","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-04-08T06:17:31.823226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-04-08T06:17:31.823913Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-04-08T06:17:31.825876Z","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-04-08T06:17:31.825954Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-08T06:17:31.826025Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-04-08T06:17:31.826198Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T06:17:31.826272Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T06:17:32.506341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T06:17:32.506403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T06:17:32.50642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-04-08T06:17:32.506433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-04-08T06:17:32.506442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-08T06:17:32.506461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-04-08T06:17:32.506475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-04-08T06:17:32.507315Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:17:32.508282Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:17:32.508323Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:17:32.50827Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T06:17:32.50852Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T06:17:32.508551Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T06:17:32.508998Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:17:32.509111Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:17:32.509143Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:17:32.510231Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T06:17:32.511804Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-04-08T06:17:58.180445Z","caller":"traceutil/trace.go:171","msg":"trace[2107426049] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"103.082932ms","start":"2026-04-08T06:17:58.077335Z","end":"2026-04-08T06:17:58.180418Z","steps":["trace[2107426049] 'process raft request' (duration: 102.924528ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:16.101919Z","caller":"traceutil/trace.go:171","msg":"trace[451122377] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"182.084517ms","start":"2026-04-08T06:18:15.919806Z","end":"2026-04-08T06:18:16.101891Z","steps":["trace[451122377] 'read index received' (duration: 181.47693ms)","trace[451122377] 'applied index is now lower than readState.Index' (duration: 606.207µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:18:16.102073Z","caller":"traceutil/trace.go:171","msg":"trace[1967929757] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"197.112658ms","start":"2026-04-08T06:18:15.904887Z","end":"2026-04-08T06:18:16.102Z","steps":["trace[1967929757] 'process raft request' (duration: 196.474401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:16.102444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.605441ms","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-04-08T06:18:16.102705Z","caller":"traceutil/trace.go:171","msg":"trace[1233199085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"182.92985ms","start":"2026-04-08T06:18:15.91974Z","end":"2026-04-08T06:18:16.10267Z","steps":["trace[1233199085] 'agreement among raft nodes before linearized reading' (duration: 182.374635ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:16.419789Z","caller":"traceutil/trace.go:171","msg":"trace[1651134230] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"225.703149ms","start":"2026-04-08T06:18:16.19406Z","end":"2026-04-08T06:18:16.419763Z","steps":["trace[1651134230] 'read index received' (duration: 225.575536ms)","trace[1651134230] 'applied index is now lower than readState.Index' (duration: 126.573µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:18:16.419849Z","caller":"traceutil/trace.go:171","msg":"trace[1627542791] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"256.353066ms","start":"2026-04-08T06:18:16.163458Z","end":"2026-04-08T06:18:16.419811Z","steps":["trace[1627542791] 'process raft request' (duration: 256.136231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:16.420033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.851945ms","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-04-08T06:18:16.420102Z","caller":"traceutil/trace.go:171","msg":"trace[1609772358] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"138.983909ms","start":"2026-04-08T06:18:16.281101Z","end":"2026-04-08T06:18:16.420085Z","steps":["trace[1609772358] 'agreement among raft nodes before linearized reading' (duration: 138.853605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:16.420043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.956026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2d8hq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-08T06:18:16.420275Z","caller":"traceutil/trace.go:171","msg":"trace[1859717678] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2d8hq; range_end:; response_count:1; response_revision:634; }","duration":"226.175482ms","start":"2026-04-08T06:18:16.194008Z","end":"2026-04-08T06:18:16.420184Z","steps":["trace[1859717678] 'agreement among raft nodes before linearized reading' (duration: 225.902044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:16.787117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.260541ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:18:16.787374Z","caller":"traceutil/trace.go:171","msg":"trace[878671694] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:656; }","duration":"356.568156ms","start":"2026-04-08T06:18:16.430788Z","end":"2026-04-08T06:18:16.787356Z","steps":["trace[878671694] 'read index received' (duration: 9.906701ms)","trace[878671694] 'applied index is now lower than readState.Index' (duration: 346.660565ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:18:16.78745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.665138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:18:16.787486Z","caller":"traceutil/trace.go:171","msg":"trace[1701232261] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:637; }","duration":"356.703839ms","start":"2026-04-08T06:18:16.430771Z","end":"2026-04-08T06:18:16.787475Z","steps":["trace[1701232261] 'agreement among raft nodes before linearized reading' (duration: 356.645618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:16.787531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:18:16.430747Z","time spent":"356.774312ms","remote":"127.0.0.1:48928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-04-08T06:18:16.787743Z","caller":"traceutil/trace.go:171","msg":"trace[1188398513] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"357.263696ms","start":"2026-04-08T06:18:16.430432Z","end":"2026-04-08T06:18:16.787696Z","steps":["trace[1188398513] 'process raft request' (duration: 75.767472ms)","trace[1188398513] 'compare' (duration: 280.110386ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:18:16.78778Z","caller":"traceutil/trace.go:171","msg":"trace[2122302843] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"351.182109ms","start":"2026-04-08T06:18:16.436566Z","end":"2026-04-08T06:18:16.787748Z","steps":["trace[2122302843] 'process raft request' (duration: 350.673805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:18:16.787964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:18:16.436552Z","time spent":"351.300732ms","remote":"127.0.0.1:48590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:18:16.787959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:18:16.430421Z","time spent":"357.42262ms","remote":"127.0.0.1:48676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:18:57.70598Z","caller":"traceutil/trace.go:171","msg":"trace[1704409123] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"185.83175ms","start":"2026-04-08T06:18:57.520122Z","end":"2026-04-08T06:18:57.705953Z","steps":["trace[1704409123] 'process raft request' (duration: 185.666115ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:43.847978Z","caller":"traceutil/trace.go:171","msg":"trace[1900942217] linearizableReadLoop","detail":"{readStateIndex:1912; appliedIndex:1911; }","duration":"129.309414ms","start":"2026-04-08T06:19:43.718638Z","end":"2026-04-08T06:19:43.847947Z","steps":["trace[1900942217] 'read index received' (duration: 129.058427ms)","trace[1900942217] 'applied index is now lower than readState.Index' (duration: 249.607µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:43.8481Z","caller":"traceutil/trace.go:171","msg":"trace[704445422] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"169.198761ms","start":"2026-04-08T06:19:43.678852Z","end":"2026-04-08T06:19:43.848051Z","steps":["trace[704445422] 'process raft request' (duration: 168.916354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:43.848309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.607632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5e88fde9-0256-4ae8-8a42-8910acdb8c5d\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-04-08T06:19:43.848399Z","caller":"traceutil/trace.go:171","msg":"trace[232404906] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5e88fde9-0256-4ae8-8a42-8910acdb8c5d; range_end:; response_count:1; response_revision:1845; }","duration":"129.818827ms","start":"2026-04-08T06:19:43.718565Z","end":"2026-04-08T06:19:43.848384Z","steps":["trace[232404906] 'agreement among raft nodes before linearized reading' (duration: 129.54598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:44.23513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.941115ms","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-04-08T06:19:44.235275Z","caller":"traceutil/trace.go:171","msg":"trace[486388422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1846; }","duration":"103.142401ms","start":"2026-04-08T06:19:44.132103Z","end":"2026-04-08T06:19:44.235246Z","steps":["trace[486388422] 'range keys from in-memory index tree' (duration: 102.669748ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:57.03472Z","caller":"traceutil/trace.go:171","msg":"trace[1934310677] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"124.907314ms","start":"2026-04-08T06:19:56.909702Z","end":"2026-04-08T06:19:57.034609Z","steps":["trace[1934310677] 'process raft request' (duration: 124.566265ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:20:28.711626Z","caller":"traceutil/trace.go:171","msg":"trace[69471195] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"239.86607ms","start":"2026-04-08T06:20:28.471695Z","end":"2026-04-08T06:20:28.711561Z","steps":["trace[69471195] 'process raft request' (duration: 163.854013ms)","trace[69471195] 'compare' (duration: 75.865043ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:20:28.721232Z","caller":"traceutil/trace.go:171","msg":"trace[2098252389] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"172.931439ms","start":"2026-04-08T06:20:28.548275Z","end":"2026-04-08T06:20:28.721206Z","steps":["trace[2098252389] 'process raft request' (duration: 172.796045ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:21:23.526873Z","caller":"traceutil/trace.go:171","msg":"trace[1837863915] transaction","detail":"{read_only:false; response_revision:2613; number_of_response:1; }","duration":"160.545376ms","start":"2026-04-08T06:21:23.3663Z","end":"2026-04-08T06:21:23.526845Z","steps":["trace[1837863915] 'process raft request' (duration: 159.908779ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:21:57.210899Z","caller":"traceutil/trace.go:171","msg":"trace[741613463] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"130.297524ms","start":"2026-04-08T06:21:57.080572Z","end":"2026-04-08T06:21:57.21087Z","steps":["trace[741613463] 'process raft request' (duration: 130.114629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:21:57.373258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.933983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T06:21:57.373252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.683498ms","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-04-08T06:21:57.373326Z","caller":"traceutil/trace.go:171","msg":"trace[1016921238] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:2815; }","duration":"105.017626ms","start":"2026-04-08T06:21:57.268294Z","end":"2026-04-08T06:21:57.373312Z","steps":["trace[1016921238] 'count revisions from in-memory index tree' (duration: 104.842341ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:21:57.373362Z","caller":"traceutil/trace.go:171","msg":"trace[498235022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2815; }","duration":"150.843002ms","start":"2026-04-08T06:21:57.222494Z","end":"2026-04-08T06:21:57.373337Z","steps":["trace[498235022] 'range keys from in-memory index tree' (duration: 150.487332ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:58.981377Z","caller":"traceutil/trace.go:171","msg":"trace[1945941780] linearizableReadLoop","detail":"{readStateIndex:5233; appliedIndex:5232; }","duration":"118.84639ms","start":"2026-04-08T06:25:58.862506Z","end":"2026-04-08T06:25:58.981353Z","steps":["trace[1945941780] 'read index received' (duration: 118.784458ms)","trace[1945941780] 'applied index is now lower than readState.Index' (duration: 60.312µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:25:58.981442Z","caller":"traceutil/trace.go:171","msg":"trace[142946132] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"128.081524ms","start":"2026-04-08T06:25:58.853336Z","end":"2026-04-08T06:25:58.981418Z","steps":["trace[142946132] 'process raft request' (duration: 127.852858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:25:58.981592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.067367ms","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-04-08T06:25:58.981624Z","caller":"traceutil/trace.go:171","msg":"trace[1421181074] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5045; }","duration":"119.161819ms","start":"2026-04-08T06:25:58.862451Z","end":"2026-04-08T06:25:58.981613Z","steps":["trace[1421181074] 'agreement among raft nodes before linearized reading' (duration: 119.033716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:25:58.982739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.139312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2bd18f3c-cc28-49dd-9292-c495aa3830c1\" ","response":"range_response_count:1 size:3891"} {"level":"info","ts":"2026-04-08T06:25:58.982808Z","caller":"traceutil/trace.go:171","msg":"trace[639037246] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2bd18f3c-cc28-49dd-9292-c495aa3830c1; range_end:; response_count:1; response_revision:5046; }","duration":"110.223073ms","start":"2026-04-08T06:25:58.872565Z","end":"2026-04-08T06:25:58.982788Z","steps":["trace[639037246] 'agreement among raft nodes before linearized reading' (duration: 110.004497ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:07.753313Z","caller":"traceutil/trace.go:171","msg":"trace[1930909189] transaction","detail":"{read_only:false; response_revision:5207; number_of_response:1; }","duration":"102.939453ms","start":"2026-04-08T06:26:07.650329Z","end":"2026-04-08T06:26:07.753268Z","steps":["trace[1930909189] 'process raft request' (duration: 102.783529ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:07.753362Z","caller":"traceutil/trace.go:171","msg":"trace[1169990315] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"104.466746ms","start":"2026-04-08T06:26:07.648824Z","end":"2026-04-08T06:26:07.753291Z","steps":["trace[1169990315] 'process raft request' (duration: 104.106426ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:07.883123Z","caller":"traceutil/trace.go:171","msg":"trace[1376610207] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"121.535704ms","start":"2026-04-08T06:26:07.761527Z","end":"2026-04-08T06:26:07.883063Z","steps":["trace[1376610207] 'process raft request' (duration: 63.551523ms)","trace[1376610207] 'compare' (duration: 57.076576ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:26:07.883504Z","caller":"traceutil/trace.go:171","msg":"trace[384718494] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"117.215545ms","start":"2026-04-08T06:26:07.766251Z","end":"2026-04-08T06:26:07.883467Z","steps":["trace[384718494] 'process raft request' (duration: 116.548516ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:08.020332Z","caller":"traceutil/trace.go:171","msg":"trace[1173709366] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"129.733259ms","start":"2026-04-08T06:26:07.890555Z","end":"2026-04-08T06:26:08.020288Z","steps":["trace[1173709366] 'process raft request' (duration: 119.355224ms)","trace[1173709366] 'compare' (duration: 10.065806ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:26:08.020358Z","caller":"traceutil/trace.go:171","msg":"trace[921893609] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"129.689627ms","start":"2026-04-08T06:26:07.890632Z","end":"2026-04-08T06:26:08.020321Z","steps":["trace[921893609] 'process raft request' (duration: 129.539763ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:08.020608Z","caller":"traceutil/trace.go:171","msg":"trace[343137565] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"129.79801ms","start":"2026-04-08T06:26:07.890777Z","end":"2026-04-08T06:26:08.020575Z","steps":["trace[343137565] 'process raft request' (duration: 129.476221ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:08.020934Z","caller":"traceutil/trace.go:171","msg":"trace[1586137383] linearizableReadLoop","detail":"{readStateIndex:5409; appliedIndex:5405; }","duration":"129.348158ms","start":"2026-04-08T06:26:07.891553Z","end":"2026-04-08T06:26:08.020901Z","steps":["trace[1586137383] 'read index received' (duration: 35.766131ms)","trace[1586137383] 'applied index is now lower than readState.Index' (duration: 93.580607ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:26:08.021014Z","caller":"traceutil/trace.go:171","msg":"trace[1008086081] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"128.916546ms","start":"2026-04-08T06:26:07.892078Z","end":"2026-04-08T06:26:08.020994Z","steps":["trace[1008086081] 'process raft request' (duration: 128.482084ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:08.020972Z","caller":"traceutil/trace.go:171","msg":"trace[1748004660] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"125.79647ms","start":"2026-04-08T06:26:07.89515Z","end":"2026-04-08T06:26:08.020947Z","steps":["trace[1748004660] 'process raft request' (duration: 125.658986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:26:08.02111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.530143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:26:08.021197Z","caller":"traceutil/trace.go:171","msg":"trace[1435152331] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:5216; }","duration":"129.652636ms","start":"2026-04-08T06:26:07.891523Z","end":"2026-04-08T06:26:08.021176Z","steps":["trace[1435152331] 'agreement among raft nodes before linearized reading' (duration: 129.499472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:26:28.815185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.222863ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:26:28.815787Z","caller":"traceutil/trace.go:171","msg":"trace[804308838] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"237.898046ms","start":"2026-04-08T06:26:28.577841Z","end":"2026-04-08T06:26:28.815739Z","steps":["trace[804308838] 'process raft request' (duration: 44.960093ms)","trace[804308838] 'compare' (duration: 191.972796ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:27:32.54419Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3010} {"level":"info","ts":"2026-04-08T06:27:32.654216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3010,"took":"108.68804ms","hash":3525030417,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":31354880,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-08T06:27:32.65429Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3525030417,"revision":3010,"compact-revision":-1} {"level":"info","ts":"2026-04-08T06:32:24.9298Z","caller":"traceutil/trace.go:171","msg":"trace[1617160002] linearizableReadLoop","detail":"{readStateIndex:8554; appliedIndex:8553; }","duration":"337.828026ms","start":"2026-04-08T06:32:24.591912Z","end":"2026-04-08T06:32:24.92974Z","steps":["trace[1617160002] 'read index received' (duration: 337.548379ms)","trace[1617160002] 'applied index is now lower than readState.Index' (duration: 277.287µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:32:24.929879Z","caller":"traceutil/trace.go:171","msg":"trace[1760159772] transaction","detail":"{read_only:false; response_revision:8267; number_of_response:1; }","duration":"390.626744ms","start":"2026-04-08T06:32:24.539211Z","end":"2026-04-08T06:32:24.929838Z","steps":["trace[1760159772] 'process raft request' (duration: 390.260754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:24.93024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:32:24.539176Z","time spent":"390.905591ms","remote":"127.0.0.1:48676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:32:24.930239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.290109ms","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-04-08T06:32:24.930405Z","caller":"traceutil/trace.go:171","msg":"trace[115273435] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8267; }","duration":"338.516375ms","start":"2026-04-08T06:32:24.591858Z","end":"2026-04-08T06:32:24.930374Z","steps":["trace[115273435] 'agreement among raft nodes before linearized reading' (duration: 338.074813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:24.930487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:32:24.591836Z","time spent":"338.634358ms","remote":"127.0.0.1:48676","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-04-08T06:32:24.966519Z","caller":"traceutil/trace.go:171","msg":"trace[1665676979] transaction","detail":"{read_only:false; response_revision:8268; number_of_response:1; }","duration":"210.87905ms","start":"2026-04-08T06:32:24.755609Z","end":"2026-04-08T06:32:24.966488Z","steps":["trace[1665676979] 'process raft request' (duration: 210.634064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:24.966598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.756667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-08T06:32:24.966643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.081127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:32:24.96668Z","caller":"traceutil/trace.go:171","msg":"trace[168505527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8268; }","duration":"253.857991ms","start":"2026-04-08T06:32:24.7128Z","end":"2026-04-08T06:32:24.966658Z","steps":["trace[168505527] 'agreement among raft nodes before linearized reading' (duration: 253.580603ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:24.966737Z","caller":"traceutil/trace.go:171","msg":"trace[76892164] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8268; }","duration":"211.251791ms","start":"2026-04-08T06:32:24.755461Z","end":"2026-04-08T06:32:24.966713Z","steps":["trace[76892164] 'agreement among raft nodes before linearized reading' (duration: 211.055605ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:32.550021Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6111} {"level":"info","ts":"2026-04-08T06:32:32.647231Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6111,"took":"94.557784ms","hash":2608221834,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":23728128,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-08T06:32:32.647345Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2608221834,"revision":6111,"compact-revision":3010} {"level":"info","ts":"2026-04-08T06:32:37.159403Z","caller":"traceutil/trace.go:171","msg":"trace[44673253] transaction","detail":"{read_only:false; response_revision:8331; number_of_response:1; }","duration":"169.647068ms","start":"2026-04-08T06:32:36.989601Z","end":"2026-04-08T06:32:37.159248Z","steps":["trace[44673253] 'process raft request' (duration: 168.62721ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:37.194422Z","caller":"traceutil/trace.go:171","msg":"trace[276308410] linearizableReadLoop","detail":"{readStateIndex:8624; appliedIndex:8622; }","duration":"149.154921ms","start":"2026-04-08T06:32:37.045168Z","end":"2026-04-08T06:32:37.194323Z","steps":["trace[276308410] 'read index received' (duration: 112.998577ms)","trace[276308410] 'applied index is now lower than readState.Index' (duration: 36.154584ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:32:37.194488Z","caller":"traceutil/trace.go:171","msg":"trace[1688632024] transaction","detail":"{read_only:false; response_revision:8332; number_of_response:1; }","duration":"186.809745ms","start":"2026-04-08T06:32:37.007635Z","end":"2026-04-08T06:32:37.194445Z","steps":["trace[1688632024] 'process raft request' (duration: 186.449055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:37.194723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.523871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T06:32:37.194823Z","caller":"traceutil/trace.go:171","msg":"trace[886317061] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8332; }","duration":"149.675365ms","start":"2026-04-08T06:32:37.045121Z","end":"2026-04-08T06:32:37.194797Z","steps":["trace[886317061] 'agreement among raft nodes before linearized reading' (duration: 149.359746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:37.194853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.072225ms","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-04-08T06:32:37.194893Z","caller":"traceutil/trace.go:171","msg":"trace[1970705279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8332; }","duration":"132.159898ms","start":"2026-04-08T06:32:37.06272Z","end":"2026-04-08T06:32:37.19488Z","steps":["trace[1970705279] 'agreement among raft nodes before linearized reading' (duration: 131.982483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:37.194957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.562603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nxzll\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-08T06:32:37.195043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.577327ms","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-04-08T06:32:37.195044Z","caller":"traceutil/trace.go:171","msg":"trace[1241381536] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nxzll; range_end:; response_count:1; response_revision:8332; }","duration":"116.685167ms","start":"2026-04-08T06:32:37.078336Z","end":"2026-04-08T06:32:37.195021Z","steps":["trace[1241381536] 'agreement among raft nodes before linearized reading' (duration: 116.43232ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:37.195068Z","caller":"traceutil/trace.go:171","msg":"trace[42188938] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8332; }","duration":"129.621589ms","start":"2026-04-08T06:32:37.065441Z","end":"2026-04-08T06:32:37.195062Z","steps":["trace[42188938] 'agreement among raft nodes before linearized reading' (duration: 129.550647ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:37.318983Z","caller":"traceutil/trace.go:171","msg":"trace[1962814266] transaction","detail":"{read_only:false; response_revision:8335; number_of_response:1; }","duration":"117.653673ms","start":"2026-04-08T06:32:37.201306Z","end":"2026-04-08T06:32:37.31896Z","steps":["trace[1962814266] 'process raft request' (duration: 117.55973ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:37.319048Z","caller":"traceutil/trace.go:171","msg":"trace[998833266] transaction","detail":"{read_only:false; response_revision:8334; number_of_response:1; }","duration":"118.829055ms","start":"2026-04-08T06:32:37.200171Z","end":"2026-04-08T06:32:37.319Z","steps":["trace[998833266] 'process raft request' (duration: 118.527636ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:37.319192Z","caller":"traceutil/trace.go:171","msg":"trace[734421721] linearizableReadLoop","detail":"{readStateIndex:8626; appliedIndex:8624; }","duration":"118.038633ms","start":"2026-04-08T06:32:37.201125Z","end":"2026-04-08T06:32:37.319164Z","steps":["trace[734421721] 'read index received' (duration: 45.881909ms)","trace[734421721] 'applied index is now lower than readState.Index' (duration: 72.153994ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:32:37.319215Z","caller":"traceutil/trace.go:171","msg":"trace[2142580936] transaction","detail":"{read_only:false; response_revision:8336; number_of_response:1; }","duration":"117.121029ms","start":"2026-04-08T06:32:37.202059Z","end":"2026-04-08T06:32:37.31918Z","steps":["trace[2142580936] 'process raft request' (duration: 116.853561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:37.319701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.555267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:223811"} {"level":"info","ts":"2026-04-08T06:32:37.319764Z","caller":"traceutil/trace.go:171","msg":"trace[690908168] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8336; }","duration":"118.682841ms","start":"2026-04-08T06:32:37.201068Z","end":"2026-04-08T06:32:37.319751Z","steps":["trace[690908168] 'agreement among raft nodes before linearized reading' (duration: 118.184368ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:06.01114Z","caller":"traceutil/trace.go:171","msg":"trace[1941484955] linearizableReadLoop","detail":"{readStateIndex:8841; appliedIndex:8839; }","duration":"319.22481ms","start":"2026-04-08T06:33:05.691887Z","end":"2026-04-08T06:33:06.011112Z","steps":["trace[1941484955] 'read index received' (duration: 111.970458ms)","trace[1941484955] 'applied index is now lower than readState.Index' (duration: 207.253112ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:06.011339Z","caller":"traceutil/trace.go:171","msg":"trace[964299937] transaction","detail":"{read_only:false; response_revision:8542; number_of_response:1; }","duration":"241.873744ms","start":"2026-04-08T06:33:05.769429Z","end":"2026-04-08T06:33:06.011303Z","steps":["trace[964299937] 'process raft request' (duration: 241.586476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:06.011443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.525479ms","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-04-08T06:33:06.011524Z","caller":"traceutil/trace.go:171","msg":"trace[12027110] 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:8542; }","duration":"319.631882ms","start":"2026-04-08T06:33:05.691872Z","end":"2026-04-08T06:33:06.011504Z","steps":["trace[12027110] 'agreement among raft nodes before linearized reading' (duration: 319.478957ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:06.011573Z","caller":"traceutil/trace.go:171","msg":"trace[976867876] transaction","detail":"{read_only:false; response_revision:8541; number_of_response:1; }","duration":"431.596629ms","start":"2026-04-08T06:33:05.579967Z","end":"2026-04-08T06:33:06.011564Z","steps":["trace[976867876] 'process raft request' (duration: 412.805458ms)","trace[976867876] 'compare' (duration: 18.01023ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:33:06.011578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:33:05.691726Z","time spent":"319.839057ms","remote":"127.0.0.1:34932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-08T06:33:06.011679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:33:05.579943Z","time spent":"431.648661ms","remote":"127.0.0.1:48676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:33:06.020636Z","caller":"traceutil/trace.go:171","msg":"trace[1083144858] transaction","detail":"{read_only:false; response_revision:8543; number_of_response:1; }","duration":"215.401084ms","start":"2026-04-08T06:33:05.805201Z","end":"2026-04-08T06:33:06.020602Z","steps":["trace[1083144858] 'process raft request' (duration: 215.280371ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:08.463984Z","caller":"traceutil/trace.go:171","msg":"trace[2122528081] linearizableReadLoop","detail":"{readStateIndex:8854; appliedIndex:8853; }","duration":"113.257433ms","start":"2026-04-08T06:33:08.350659Z","end":"2026-04-08T06:33:08.463916Z","steps":["trace[2122528081] 'read index received' (duration: 113.088099ms)","trace[2122528081] 'applied index is now lower than readState.Index' (duration: 168.324µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:33:08.464113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.436268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:33:08.464086Z","caller":"traceutil/trace.go:171","msg":"trace[1557433731] transaction","detail":"{read_only:false; response_revision:8554; number_of_response:1; }","duration":"173.149953ms","start":"2026-04-08T06:33:08.290878Z","end":"2026-04-08T06:33:08.464028Z","steps":["trace[1557433731] 'process raft request' (duration: 172.863636ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:08.464148Z","caller":"traceutil/trace.go:171","msg":"trace[373424769] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8554; }","duration":"113.51489ms","start":"2026-04-08T06:33:08.350622Z","end":"2026-04-08T06:33:08.464137Z","steps":["trace[373424769] 'agreement among raft nodes before linearized reading' (duration: 113.440568ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:18.684796Z","caller":"traceutil/trace.go:171","msg":"trace[856309571] linearizableReadLoop","detail":"{readStateIndex:8951; appliedIndex:8950; }","duration":"119.024791ms","start":"2026-04-08T06:33:18.565741Z","end":"2026-04-08T06:33:18.684766Z","steps":["trace[856309571] 'read index received' (duration: 58.893724ms)","trace[856309571] 'applied index is now lower than readState.Index' (duration: 60.129737ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:18.684873Z","caller":"traceutil/trace.go:171","msg":"trace[925295553] transaction","detail":"{read_only:false; response_revision:8646; number_of_response:1; }","duration":"121.068666ms","start":"2026-04-08T06:33:18.563785Z","end":"2026-04-08T06:33:18.684854Z","steps":["trace[925295553] 'process raft request' (duration: 60.906078ms)","trace[925295553] 'compare' (duration: 59.952422ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:33:18.685069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.353942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-08T06:33:18.685116Z","caller":"traceutil/trace.go:171","msg":"trace[671640845] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8646; }","duration":"118.438615ms","start":"2026-04-08T06:33:18.566665Z","end":"2026-04-08T06:33:18.685103Z","steps":["trace[671640845] 'agreement among raft nodes before linearized reading' (duration: 118.26586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:18.685129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.280437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-4ptmg\" ","response":"range_response_count:1 size:4641"} {"level":"info","ts":"2026-04-08T06:33:18.685392Z","caller":"traceutil/trace.go:171","msg":"trace[536306807] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-4ptmg; range_end:; response_count:1; response_revision:8646; }","duration":"119.690288ms","start":"2026-04-08T06:33:18.565676Z","end":"2026-04-08T06:33:18.685367Z","steps":["trace[536306807] 'agreement among raft nodes before linearized reading' (duration: 119.229205ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:19.678658Z","caller":"traceutil/trace.go:171","msg":"trace[2071132197] transaction","detail":"{read_only:false; response_revision:8656; number_of_response:1; }","duration":"102.317655ms","start":"2026-04-08T06:33:19.576316Z","end":"2026-04-08T06:33:19.678634Z","steps":["trace[2071132197] 'process raft request' (duration: 102.10773ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:19.837547Z","caller":"traceutil/trace.go:171","msg":"trace[819534704] transaction","detail":"{read_only:false; response_revision:8657; number_of_response:1; }","duration":"154.703232ms","start":"2026-04-08T06:33:19.682817Z","end":"2026-04-08T06:33:19.83752Z","steps":["trace[819534704] 'process raft request' (duration: 154.527897ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:19.886847Z","caller":"traceutil/trace.go:171","msg":"trace[1541250707] transaction","detail":"{read_only:false; response_revision:8659; number_of_response:1; }","duration":"203.87961ms","start":"2026-04-08T06:33:19.68294Z","end":"2026-04-08T06:33:19.886819Z","steps":["trace[1541250707] 'process raft request' (duration: 203.758396ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:19.886982Z","caller":"traceutil/trace.go:171","msg":"trace[1125243661] linearizableReadLoop","detail":"{readStateIndex:8964; appliedIndex:8961; }","duration":"203.383796ms","start":"2026-04-08T06:33:19.683568Z","end":"2026-04-08T06:33:19.886952Z","steps":["trace[1125243661] 'read index received' (duration: 153.834298ms)","trace[1125243661] 'applied index is now lower than readState.Index' (duration: 49.547618ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:19.886854Z","caller":"traceutil/trace.go:171","msg":"trace[1260445463] transaction","detail":"{read_only:false; response_revision:8658; number_of_response:1; }","duration":"203.90037ms","start":"2026-04-08T06:33:19.682911Z","end":"2026-04-08T06:33:19.886811Z","steps":["trace[1260445463] 'process raft request' (duration: 203.614643ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:19.8871Z","caller":"traceutil/trace.go:171","msg":"trace[1437486814] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"203.098079ms","start":"2026-04-08T06:33:19.683989Z","end":"2026-04-08T06:33:19.887087Z","steps":["trace[1437486814] 'process raft request' (duration: 202.77912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:19.887479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.711896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-04-08T06:33:19.887552Z","caller":"traceutil/trace.go:171","msg":"trace[932988435] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:8660; }","duration":"203.803028ms","start":"2026-04-08T06:33:19.683733Z","end":"2026-04-08T06:33:19.887536Z","steps":["trace[932988435] 'agreement among raft nodes before linearized reading' (duration: 203.562762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:19.887586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.997153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228457"} {"level":"info","ts":"2026-04-08T06:33:19.887641Z","caller":"traceutil/trace.go:171","msg":"trace[788653812] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8660; }","duration":"204.090706ms","start":"2026-04-08T06:33:19.683539Z","end":"2026-04-08T06:33:19.88763Z","steps":["trace[788653812] 'agreement among raft nodes before linearized reading' (duration: 203.596492ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:20.576239Z","caller":"traceutil/trace.go:171","msg":"trace[48622828] transaction","detail":"{read_only:false; response_revision:8664; number_of_response:1; }","duration":"217.83022ms","start":"2026-04-08T06:33:20.358374Z","end":"2026-04-08T06:33:20.576204Z","steps":["trace[48622828] 'process raft request' (duration: 217.634794ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:20.665009Z","caller":"traceutil/trace.go:171","msg":"trace[917882034] transaction","detail":"{read_only:false; response_revision:8665; number_of_response:1; }","duration":"155.910555ms","start":"2026-04-08T06:33:20.50905Z","end":"2026-04-08T06:33:20.66496Z","steps":["trace[917882034] 'process raft request' (duration: 115.866125ms)","trace[917882034] 'compare' (duration: 39.919606ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:59.473212Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002475.wal"} {"level":"info","ts":"2026-04-08T06:35:10.47655Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f3d52791b64f7591","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T06:35:10.482779Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T06:35:10.482881Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T06:37:32.557359Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8306} {"level":"info","ts":"2026-04-08T06:37:32.640851Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8306,"took":"81.317806ms","hash":1065569006,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":25812992,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-08T06:37:32.64093Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1065569006,"revision":8306,"compact-revision":6111} {"level":"info","ts":"2026-04-08T06:42:32.563162Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10706} {"level":"info","ts":"2026-04-08T06:42:32.646237Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10706,"took":"81.295875ms","hash":2033814911,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":20660224,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-08T06:42:32.64632Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2033814911,"revision":10706,"compact-revision":8306}