{"level":"warn","ts":"2026-04-13T20:51:52.189955Z","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-13T20:51:52.190097Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.33: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.33:2380","--initial-cluster=instance=https://199.204.45.33:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.33:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.33: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-13T20:51:52.190227Z","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-13T20:51:52.190246Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-13T20:51:52.190269Z","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-13T20:51:52.191152Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"]} {"level":"info","ts":"2026-04-13T20:51:52.191253Z","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.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.33: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-13T20:51:52.194032Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.469356ms"} {"level":"info","ts":"2026-04-13T20:51:52.200612Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e5729930cf7e1f","cluster-id":"14aeb8c3ec66b749"} {"level":"info","ts":"2026-04-13T20:51:52.200784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T20:51:52.200836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 0"} {"level":"info","ts":"2026-04-13T20:51:52.200868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e5729930cf7e1f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T20:51:52.200892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became follower at term 1"} {"level":"info","ts":"2026-04-13T20:51:52.200973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"warn","ts":"2026-04-13T20:51:52.210889Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T20:51:52.212366Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T20:51:52.213576Z","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-13T20:51:52.21643Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e5729930cf7e1f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T20:51:52.217182Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e5729930cf7e1f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T20:51:52.217388Z","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-13T20:51:52.217436Z","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-13T20:51:52.217594Z","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-13T20:51:52.219501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f switched to configuration voters=(17430463935081840159)"} {"level":"info","ts":"2026-04-13T20:51:52.219808Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","added-peer-id":"f1e5729930cf7e1f","added-peer-peer-urls":["https://199.204.45.33:2380"]} {"level":"info","ts":"2026-04-13T20:51:52.222702Z","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-13T20:51:52.222897Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-13T20:51:52.222957Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.33:2380"} {"level":"info","ts":"2026-04-13T20:51:52.223959Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e5729930cf7e1f","initial-advertise-peer-urls":["https://199.204.45.33:2380"],"listen-peer-urls":["https://199.204.45.33:2380"],"advertise-client-urls":["https://199.204.45.33:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.33:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T20:51:52.224028Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T20:51:52.90205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T20:51:52.902125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T20:51:52.902149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgPreVoteResp from f1e5729930cf7e1f at term 1"} {"level":"info","ts":"2026-04-13T20:51:52.902169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became candidate at term 2"} {"level":"info","ts":"2026-04-13T20:51:52.902181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f received MsgVoteResp from f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-13T20:51:52.902197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e5729930cf7e1f became leader at term 2"} {"level":"info","ts":"2026-04-13T20:51:52.902211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e5729930cf7e1f elected leader f1e5729930cf7e1f at term 2"} {"level":"info","ts":"2026-04-13T20:51:52.903194Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:51:52.904203Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e5729930cf7e1f","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.33:2379]}","request-path":"/0/members/f1e5729930cf7e1f/attributes","cluster-id":"14aeb8c3ec66b749","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T20:51:52.904304Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T20:51:52.904266Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T20:51:52.904603Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"14aeb8c3ec66b749","local-member-id":"f1e5729930cf7e1f","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:51:52.90473Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:51:52.904764Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T20:51:52.904834Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T20:51:52.904865Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T20:51:52.907374Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.33:2379"} {"level":"info","ts":"2026-04-13T20:51:52.908212Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T20:52:09.173088Z","caller":"traceutil/trace.go:171","msg":"trace[342159824] linearizableReadLoop","detail":"{readStateIndex:424; appliedIndex:423; }","duration":"106.650647ms","start":"2026-04-13T20:52:09.066412Z","end":"2026-04-13T20:52:09.173063Z","steps":["trace[342159824] 'read index received' (duration: 106.420413ms)","trace[342159824] 'applied index is now lower than readState.Index' (duration: 228.574µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:52:09.17326Z","caller":"traceutil/trace.go:171","msg":"trace[1218797345] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"242.979545ms","start":"2026-04-13T20:52:08.930235Z","end":"2026-04-13T20:52:09.173215Z","steps":["trace[1218797345] 'process raft request' (duration: 242.68313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:52:09.173291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.847941ms","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-13T20:52:09.173374Z","caller":"traceutil/trace.go:171","msg":"trace[861649927] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:412; }","duration":"106.981244ms","start":"2026-04-13T20:52:09.066379Z","end":"2026-04-13T20:52:09.173361Z","steps":["trace[861649927] 'agreement among raft nodes before linearized reading' (duration: 106.79231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:52:09.457638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.540576ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T20:52:09.457776Z","caller":"traceutil/trace.go:171","msg":"trace[903534677] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"280.569477ms","start":"2026-04-13T20:52:09.177188Z","end":"2026-04-13T20:52:09.457757Z","steps":["trace[903534677] 'process raft request' (duration: 147.992361ms)","trace[903534677] 'compare' (duration: 131.126429ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:52:29.879498Z","caller":"traceutil/trace.go:171","msg":"trace[1008937424] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"303.109541ms","start":"2026-04-13T20:52:29.576356Z","end":"2026-04-13T20:52:29.879465Z","steps":["trace[1008937424] 'process raft request' (duration: 302.921657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:52:29.879749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:52:29.576333Z","time spent":"303.310144ms","remote":"127.0.0.1:51822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T20:52:29.929318Z","caller":"traceutil/trace.go:171","msg":"trace[2069113186] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"315.654301ms","start":"2026-04-13T20:52:29.613636Z","end":"2026-04-13T20:52:29.929291Z","steps":["trace[2069113186] 'process raft request' (duration: 313.52474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:52:29.929485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:52:29.613588Z","time spent":"315.812014ms","remote":"127.0.0.1:51634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T20:52:30.375904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.125967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T20:52:30.376074Z","caller":"traceutil/trace.go:171","msg":"trace[1951031255] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"327.556378ms","start":"2026-04-13T20:52:30.048498Z","end":"2026-04-13T20:52:30.376055Z","steps":["trace[1951031255] 'read index received' (duration: 192.197838ms)","trace[1951031255] 'applied index is now lower than readState.Index' (duration: 135.35678ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:52:30.376163Z","caller":"traceutil/trace.go:171","msg":"trace[330876861] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"385.835765ms","start":"2026-04-13T20:52:29.990289Z","end":"2026-04-13T20:52:30.376125Z","steps":["trace[330876861] 'process raft request' (duration: 250.386242ms)","trace[330876861] 'compare' (duration: 134.79651ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:52:30.37632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:52:29.990249Z","time spent":"385.999267ms","remote":"127.0.0.1:52070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T20:52:30.376319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.806014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbrch\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-13T20:52:30.376477Z","caller":"traceutil/trace.go:171","msg":"trace[1623546197] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbrch; range_end:; response_count:1; response_revision:619; }","duration":"328.011447ms","start":"2026-04-13T20:52:30.048441Z","end":"2026-04-13T20:52:30.376452Z","steps":["trace[1623546197] 'agreement among raft nodes before linearized reading' (duration: 327.700651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:52:30.376601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T20:52:30.048415Z","time spent":"328.17311ms","remote":"127.0.0.1:51726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-kbrch\" "} {"level":"warn","ts":"2026-04-13T20:52:53.57668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.455717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-13T20:52:53.576821Z","caller":"traceutil/trace.go:171","msg":"trace[1121873814] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:803; }","duration":"120.661731ms","start":"2026-04-13T20:52:53.456131Z","end":"2026-04-13T20:52:53.576793Z","steps":["trace[1121873814] 'range keys from in-memory index tree' (duration: 120.198232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:53:20.263677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.514576ms","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-13T20:53:20.263802Z","caller":"traceutil/trace.go:171","msg":"trace[1824014642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1195; }","duration":"119.72162ms","start":"2026-04-13T20:53:20.144056Z","end":"2026-04-13T20:53:20.263778Z","steps":["trace[1824014642] 'range keys from in-memory index tree' (duration: 119.261901ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:54:50.89067Z","caller":"traceutil/trace.go:171","msg":"trace[302669256] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"103.999506ms","start":"2026-04-13T20:54:50.786643Z","end":"2026-04-13T20:54:50.890643Z","steps":["trace[302669256] 'process raft request' (duration: 69.572962ms)","trace[302669256] 'compare' (duration: 34.18038ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:54:57.138019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.015618ms","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-13T20:54:57.13811Z","caller":"traceutil/trace.go:171","msg":"trace[1374501915] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2190; }","duration":"222.11928ms","start":"2026-04-13T20:54:56.915972Z","end":"2026-04-13T20:54:57.138091Z","steps":["trace[1374501915] 'range keys from in-memory index tree' (duration: 221.705742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:54:57.138194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.286359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-13T20:54:57.138271Z","caller":"traceutil/trace.go:171","msg":"trace[212534408] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2190; }","duration":"166.411752ms","start":"2026-04-13T20:54:56.971823Z","end":"2026-04-13T20:54:57.138235Z","steps":["trace[212534408] 'range keys from in-memory index tree' (duration: 166.045135ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:54:57.280198Z","caller":"traceutil/trace.go:171","msg":"trace[355220403] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"137.139325ms","start":"2026-04-13T20:54:57.143021Z","end":"2026-04-13T20:54:57.280161Z","steps":["trace[355220403] 'process raft request' (duration: 136.819659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:55:49.321468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.452425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T20:55:49.321545Z","caller":"traceutil/trace.go:171","msg":"trace[1827256327] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:2645; }","duration":"153.597908ms","start":"2026-04-13T20:55:49.167931Z","end":"2026-04-13T20:55:49.321529Z","steps":["trace[1827256327] 'count revisions from in-memory index tree' (duration: 153.312552ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:56:22.711462Z","caller":"traceutil/trace.go:171","msg":"trace[143991448] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"132.771723ms","start":"2026-04-13T20:56:22.578665Z","end":"2026-04-13T20:56:22.711437Z","steps":["trace[143991448] 'process raft request' (duration: 132.6026ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:56:23.033845Z","caller":"traceutil/trace.go:171","msg":"trace[800757896] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"133.257433ms","start":"2026-04-13T20:56:22.900544Z","end":"2026-04-13T20:56:23.033801Z","steps":["trace[800757896] 'process raft request' (duration: 133.028168ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T20:58:48.630404Z","caller":"traceutil/trace.go:171","msg":"trace[1637371441] linearizableReadLoop","detail":"{readStateIndex:3960; appliedIndex:3959; }","duration":"211.671518ms","start":"2026-04-13T20:58:48.418698Z","end":"2026-04-13T20:58:48.630369Z","steps":["trace[1637371441] 'read index received' (duration: 138.007339ms)","trace[1637371441] 'applied index is now lower than readState.Index' (duration: 73.662549ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T20:58:48.630614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.898723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T20:58:48.630475Z","caller":"traceutil/trace.go:171","msg":"trace[1374283026] transaction","detail":"{read_only:false; response_revision:3821; number_of_response:1; }","duration":"235.647734ms","start":"2026-04-13T20:58:48.394785Z","end":"2026-04-13T20:58:48.630433Z","steps":["trace[1374283026] 'process raft request' (duration: 161.939404ms)","trace[1374283026] 'compare' (duration: 73.256751ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T20:58:48.630667Z","caller":"traceutil/trace.go:171","msg":"trace[1375610667] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:3821; }","duration":"212.005515ms","start":"2026-04-13T20:58:48.418649Z","end":"2026-04-13T20:58:48.630655Z","steps":["trace[1375610667] 'agreement among raft nodes before linearized reading' (duration: 211.894633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T20:58:48.630955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.89729ms","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-13T20:58:48.631011Z","caller":"traceutil/trace.go:171","msg":"trace[95786375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3821; }","duration":"175.017342ms","start":"2026-04-13T20:58:48.45598Z","end":"2026-04-13T20:58:48.630998Z","steps":["trace[95786375] 'agreement among raft nodes before linearized reading' (duration: 174.816879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:24.856843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.126589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:00:24.857145Z","caller":"traceutil/trace.go:171","msg":"trace[1067138825] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"326.636029ms","start":"2026-04-13T21:00:24.530473Z","end":"2026-04-13T21:00:24.857109Z","steps":["trace[1067138825] 'process raft request' (duration: 326.527776ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:24.857246Z","caller":"traceutil/trace.go:171","msg":"trace[1257637376] linearizableReadLoop","detail":"{readStateIndex:5384; appliedIndex:5382; }","duration":"250.740141ms","start":"2026-04-13T21:00:24.606495Z","end":"2026-04-13T21:00:24.857235Z","steps":["trace[1257637376] 'read index received' (duration: 61.911µs)","trace[1257637376] 'applied index is now lower than readState.Index' (duration: 250.67733ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:24.857269Z","caller":"traceutil/trace.go:171","msg":"trace[1736571608] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"326.827753ms","start":"2026-04-13T21:00:24.530393Z","end":"2026-04-13T21:00:24.857221Z","steps":["trace[1736571608] 'process raft request' (duration: 57.218664ms)","trace[1736571608] 'compare' (duration: 268.491248ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:24.857338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:24.53046Z","time spent":"326.788763ms","remote":"127.0.0.1:51710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T21:00:24.85719Z","caller":"traceutil/trace.go:171","msg":"trace[1713587936] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"188.364999ms","start":"2026-04-13T21:00:24.6688Z","end":"2026-04-13T21:00:24.857165Z","steps":["trace[1713587936] 'process raft request' (duration: 188.291148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:24.857437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:24.530384Z","time spent":"326.976966ms","remote":"127.0.0.1:51830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1005,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T21:00:24.857509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.010586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-t2nk5\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-04-13T21:00:24.85755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.195719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-lzkgw\" ","response":"range_response_count:1 size:7817"} {"level":"warn","ts":"2026-04-13T21:00:24.857511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.706059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-9999cf9d7-sbdgg.18a6064b5180e6b3\" ","response":"range_response_count:1 size:895"} {"level":"info","ts":"2026-04-13T21:00:24.857564Z","caller":"traceutil/trace.go:171","msg":"trace[273325827] range","detail":"{range_begin:/registry/pods/openstack/keepalived-t2nk5; range_end:; response_count:1; response_revision:5193; }","duration":"251.115458ms","start":"2026-04-13T21:00:24.606432Z","end":"2026-04-13T21:00:24.857547Z","steps":["trace[273325827] 'agreement among raft nodes before linearized reading' (duration: 250.895374ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:24.857593Z","caller":"traceutil/trace.go:171","msg":"trace[664579185] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-lzkgw; range_end:; response_count:1; response_revision:5193; }","duration":"243.28411ms","start":"2026-04-13T21:00:24.614292Z","end":"2026-04-13T21:00:24.857576Z","steps":["trace[664579185] 'agreement among raft nodes before linearized reading' (duration: 243.048255ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:24.857607Z","caller":"traceutil/trace.go:171","msg":"trace[17031345] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-9999cf9d7-sbdgg.18a6064b5180e6b3; range_end:; response_count:1; response_revision:5193; }","duration":"242.833932ms","start":"2026-04-13T21:00:24.614754Z","end":"2026-04-13T21:00:24.857588Z","steps":["trace[17031345] 'agreement among raft nodes before linearized reading' (duration: 242.596758ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:25.181207Z","caller":"traceutil/trace.go:171","msg":"trace[1750916630] linearizableReadLoop","detail":"{readStateIndex:5393; appliedIndex:5392; }","duration":"103.458271ms","start":"2026-04-13T21:00:25.077705Z","end":"2026-04-13T21:00:25.181163Z","steps":["trace[1750916630] 'read index received' (duration: 81.472624ms)","trace[1750916630] 'applied index is now lower than readState.Index' (duration: 21.983867ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:25.181245Z","caller":"traceutil/trace.go:171","msg":"trace[1607392836] transaction","detail":"{read_only:false; response_revision:5201; number_of_response:1; }","duration":"104.162403ms","start":"2026-04-13T21:00:25.077041Z","end":"2026-04-13T21:00:25.181203Z","steps":["trace[1607392836] 'process raft request' (duration: 82.000903ms)","trace[1607392836] 'compare' (duration: 21.61592ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:25.181445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.717555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-13T21:00:25.181536Z","caller":"traceutil/trace.go:171","msg":"trace[1648191576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5201; }","duration":"103.855998ms","start":"2026-04-13T21:00:25.07766Z","end":"2026-04-13T21:00:25.181516Z","steps":["trace[1648191576] 'agreement among raft nodes before linearized reading' (duration: 103.607004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:51.596985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.166362ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:00:51.597567Z","caller":"traceutil/trace.go:171","msg":"trace[2119849137] transaction","detail":"{read_only:false; response_revision:5591; number_of_response:1; }","duration":"508.114338ms","start":"2026-04-13T21:00:51.089408Z","end":"2026-04-13T21:00:51.597523Z","steps":["trace[2119849137] 'process raft request' (duration: 191.953837ms)","trace[2119849137] 'compare' (duration: 314.849816ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:51.59757Z","caller":"traceutil/trace.go:171","msg":"trace[370312677] linearizableReadLoop","detail":"{readStateIndex:5793; appliedIndex:5792; }","duration":"299.585996ms","start":"2026-04-13T21:00:51.297953Z","end":"2026-04-13T21:00:51.597539Z","steps":["trace[370312677] 'read index received' (duration: 47.391µs)","trace[370312677] 'applied index is now lower than readState.Index' (duration: 299.535315ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:51.597672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:51.089391Z","time spent":"508.23238ms","remote":"127.0.0.1:51822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:00:51.636393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.420262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T21:00:51.636462Z","caller":"traceutil/trace.go:171","msg":"trace[1123848105] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5591; }","duration":"338.540815ms","start":"2026-04-13T21:00:51.297904Z","end":"2026-04-13T21:00:51.636445Z","steps":["trace[1123848105] 'agreement among raft nodes before linearized reading' (duration: 299.729929ms)","trace[1123848105] 'range keys from in-memory index tree' (duration: 38.616561ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:00:51.636467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.340039ms","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-13T21:00:51.63653Z","caller":"traceutil/trace.go:171","msg":"trace[1415953490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5591; }","duration":"302.43258ms","start":"2026-04-13T21:00:51.334081Z","end":"2026-04-13T21:00:51.636514Z","steps":["trace[1415953490] 'agreement among raft nodes before linearized reading' (duration: 302.266047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:00:51.636535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.83279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-13T21:00:51.636568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:51.334071Z","time spent":"302.490471ms","remote":"127.0.0.1:51822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T21:00:51.636496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:00:51.297884Z","time spent":"338.605565ms","remote":"127.0.0.1:51822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-13T21:00:51.636565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.395013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-04-13T21:00:51.636586Z","caller":"traceutil/trace.go:171","msg":"trace[1603899143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5591; }","duration":"234.915441ms","start":"2026-04-13T21:00:51.401657Z","end":"2026-04-13T21:00:51.636573Z","steps":["trace[1603899143] 'agreement among raft nodes before linearized reading' (duration: 234.770488ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:51.636645Z","caller":"traceutil/trace.go:171","msg":"trace[1032641560] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5591; }","duration":"165.482695ms","start":"2026-04-13T21:00:51.471138Z","end":"2026-04-13T21:00:51.636621Z","steps":["trace[1032641560] 'agreement among raft nodes before linearized reading' (duration: 165.22839ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.046943Z","caller":"traceutil/trace.go:171","msg":"trace[1916120731] transaction","detail":"{read_only:false; response_revision:5599; number_of_response:1; }","duration":"131.729176ms","start":"2026-04-13T21:00:51.915179Z","end":"2026-04-13T21:00:52.046908Z","steps":["trace[1916120731] 'process raft request' (duration: 131.519382ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.047027Z","caller":"traceutil/trace.go:171","msg":"trace[598312075] transaction","detail":"{read_only:false; response_revision:5598; number_of_response:1; }","duration":"131.873928ms","start":"2026-04-13T21:00:51.915114Z","end":"2026-04-13T21:00:52.046988Z","steps":["trace[598312075] 'process raft request' (duration: 57.467098ms)","trace[598312075] 'compare' (duration: 73.946642ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:00:52.047058Z","caller":"traceutil/trace.go:171","msg":"trace[1854160862] transaction","detail":"{read_only:false; response_revision:5602; number_of_response:1; }","duration":"130.258338ms","start":"2026-04-13T21:00:51.916766Z","end":"2026-04-13T21:00:52.047024Z","steps":["trace[1854160862] 'process raft request' (duration: 130.089765ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.047196Z","caller":"traceutil/trace.go:171","msg":"trace[1937896277] transaction","detail":"{read_only:false; response_revision:5601; number_of_response:1; }","duration":"131.878929ms","start":"2026-04-13T21:00:51.915304Z","end":"2026-04-13T21:00:52.047183Z","steps":["trace[1937896277] 'process raft request' (duration: 131.505742ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:00:52.047287Z","caller":"traceutil/trace.go:171","msg":"trace[1251437139] transaction","detail":"{read_only:false; response_revision:5600; number_of_response:1; }","duration":"132.018802ms","start":"2026-04-13T21:00:51.915251Z","end":"2026-04-13T21:00:52.04727Z","steps":["trace[1251437139] 'process raft request' (duration: 131.501682ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:01:52.934907Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3015} {"level":"info","ts":"2026-04-13T21:01:53.013311Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3015,"took":"76.893797ms","hash":2719643021,"current-db-size-bytes":57593856,"current-db-size":"58 MB","current-db-size-in-use-bytes":31629312,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-13T21:01:53.013381Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2719643021,"revision":3015,"compact-revision":-1} {"level":"info","ts":"2026-04-13T21:06:47.549152Z","caller":"traceutil/trace.go:171","msg":"trace[1990315423] transaction","detail":"{read_only:false; response_revision:8290; number_of_response:1; }","duration":"147.071334ms","start":"2026-04-13T21:06:47.402055Z","end":"2026-04-13T21:06:47.549127Z","steps":["trace[1990315423] 'process raft request' (duration: 146.907281ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:06:47.741591Z","caller":"traceutil/trace.go:171","msg":"trace[1860429811] linearizableReadLoop","detail":"{readStateIndex:8578; appliedIndex:8576; }","duration":"335.984498ms","start":"2026-04-13T21:06:47.405565Z","end":"2026-04-13T21:06:47.74155Z","steps":["trace[1860429811] 'read index received' (duration: 143.481667ms)","trace[1860429811] 'applied index is now lower than readState.Index' (duration: 192.501751ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:06:47.742046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.460748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T21:06:47.74209Z","caller":"traceutil/trace.go:171","msg":"trace[499723960] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8291; }","duration":"336.54063ms","start":"2026-04-13T21:06:47.405541Z","end":"2026-04-13T21:06:47.742082Z","steps":["trace[499723960] 'agreement among raft nodes before linearized reading' (duration: 336.346796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:47.742118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:47.405534Z","time spent":"336.57931ms","remote":"127.0.0.1:51822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-13T21:06:47.741778Z","caller":"traceutil/trace.go:171","msg":"trace[502557979] transaction","detail":"{read_only:false; response_revision:8291; number_of_response:1; }","duration":"339.2106ms","start":"2026-04-13T21:06:47.402537Z","end":"2026-04-13T21:06:47.741748Z","steps":["trace[502557979] 'process raft request' (duration: 310.63631ms)","trace[502557979] 'compare' (duration: 28.09684ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:06:47.742293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:06:47.402529Z","time spent":"339.648658ms","remote":"127.0.0.1:51822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:06:52.950384Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6122} {"level":"info","ts":"2026-04-13T21:06:53.053268Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6122,"took":"101.394663ms","hash":2350026020,"current-db-size-bytes":57593856,"current-db-size":"58 MB","current-db-size-in-use-bytes":23814144,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-13T21:06:53.053343Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2350026020,"revision":6122,"compact-revision":3015} {"level":"info","ts":"2026-04-13T21:06:59.723416Z","caller":"traceutil/trace.go:171","msg":"trace[1235582682] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"103.311979ms","start":"2026-04-13T21:06:59.620051Z","end":"2026-04-13T21:06:59.723363Z","steps":["trace[1235582682] 'process raft request' (duration: 103.020224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:59.972838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.518514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:06:59.972917Z","caller":"traceutil/trace.go:171","msg":"trace[1169080694] linearizableReadLoop","detail":"{readStateIndex:8643; appliedIndex:8642; }","duration":"175.791296ms","start":"2026-04-13T21:06:59.79711Z","end":"2026-04-13T21:06:59.972901Z","steps":["trace[1169080694] 'read index received' (duration: 38.082308ms)","trace[1169080694] 'applied index is now lower than readState.Index' (duration: 137.708078ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:06:59.972993Z","caller":"traceutil/trace.go:171","msg":"trace[1381209367] transaction","detail":"{read_only:false; response_revision:8352; number_of_response:1; }","duration":"245.013712ms","start":"2026-04-13T21:06:59.727953Z","end":"2026-04-13T21:06:59.972967Z","steps":["trace[1381209367] 'process raft request' (duration: 107.312315ms)","trace[1381209367] 'compare' (duration: 137.430432ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:06:59.973026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.928418ms","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-04-13T21:06:59.973044Z","caller":"traceutil/trace.go:171","msg":"trace[1212762541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8352; }","duration":"175.99083ms","start":"2026-04-13T21:06:59.797048Z","end":"2026-04-13T21:06:59.973038Z","steps":["trace[1212762541] 'agreement among raft nodes before linearized reading' (duration: 175.922868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:06:59.973212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.527382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T21:06:59.973233Z","caller":"traceutil/trace.go:171","msg":"trace[948781952] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8352; }","duration":"156.599513ms","start":"2026-04-13T21:06:59.816626Z","end":"2026-04-13T21:06:59.973226Z","steps":["trace[948781952] 'agreement among raft nodes before linearized reading' (duration: 156.505011ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:28.354138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.65895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:07:28.354247Z","caller":"traceutil/trace.go:171","msg":"trace[1179094244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8556; }","duration":"355.775472ms","start":"2026-04-13T21:07:27.998447Z","end":"2026-04-13T21:07:28.354222Z","steps":["trace[1179094244] 'range keys from in-memory index tree' (duration: 355.589079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:28.354304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:07:27.998392Z","time spent":"355.899054ms","remote":"127.0.0.1:51514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-13T21:07:28.354357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.130119ms","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-04-13T21:07:28.354507Z","caller":"traceutil/trace.go:171","msg":"trace[2078419049] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8556; }","duration":"144.293512ms","start":"2026-04-13T21:07:28.210193Z","end":"2026-04-13T21:07:28.354486Z","steps":["trace[2078419049] 'range keys from in-memory index tree' (duration: 144.114009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:28.354742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.346035ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:07:28.354865Z","caller":"traceutil/trace.go:171","msg":"trace[1918268814] linearizableReadLoop","detail":"{readStateIndex:8856; appliedIndex:8855; }","duration":"227.617043ms","start":"2026-04-13T21:07:28.12723Z","end":"2026-04-13T21:07:28.354847Z","steps":["trace[1918268814] 'read index received' (duration: 75.968223ms)","trace[1918268814] 'applied index is now lower than readState.Index' (duration: 151.64732ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:28.35506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.827947ms","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-13T21:07:28.355099Z","caller":"traceutil/trace.go:171","msg":"trace[718574983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8557; }","duration":"227.895569ms","start":"2026-04-13T21:07:28.127192Z","end":"2026-04-13T21:07:28.355087Z","steps":["trace[718574983] 'agreement among raft nodes before linearized reading' (duration: 227.745906ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:28.354924Z","caller":"traceutil/trace.go:171","msg":"trace[648377431] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"230.08302ms","start":"2026-04-13T21:07:28.124802Z","end":"2026-04-13T21:07:28.354885Z","steps":["trace[648377431] 'process raft request' (duration: 78.397349ms)","trace[648377431] 'compare' (duration: 151.043949ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:28.355705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.586645ms","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-13T21:07:28.355842Z","caller":"traceutil/trace.go:171","msg":"trace[772144776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8557; }","duration":"226.782509ms","start":"2026-04-13T21:07:28.129028Z","end":"2026-04-13T21:07:28.35581Z","steps":["trace[772144776] 'agreement among raft nodes before linearized reading' (duration: 226.312389ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:41.267496Z","caller":"traceutil/trace.go:171","msg":"trace[760123819] transaction","detail":"{read_only:false; response_revision:8670; number_of_response:1; }","duration":"123.247105ms","start":"2026-04-13T21:07:41.144217Z","end":"2026-04-13T21:07:41.267464Z","steps":["trace[760123819] 'process raft request' (duration: 116.095129ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:41.267559Z","caller":"traceutil/trace.go:171","msg":"trace[93864102] linearizableReadLoop","detail":"{readStateIndex:8973; appliedIndex:8971; }","duration":"113.378729ms","start":"2026-04-13T21:07:41.154156Z","end":"2026-04-13T21:07:41.267535Z","steps":["trace[93864102] 'read index received' (duration: 11.883114ms)","trace[93864102] 'applied index is now lower than readState.Index' (duration: 101.494455ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:41.267596Z","caller":"traceutil/trace.go:171","msg":"trace[724401163] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"112.398081ms","start":"2026-04-13T21:07:41.155184Z","end":"2026-04-13T21:07:41.267582Z","steps":["trace[724401163] 'process raft request' (duration: 112.197707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:07:41.267789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.619503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-x5zwm\" ","response":"range_response_count:1 size:4647"} {"level":"info","ts":"2026-04-13T21:07:41.267832Z","caller":"traceutil/trace.go:171","msg":"trace[1758556671] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-x5zwm; range_end:; response_count:1; response_revision:8671; }","duration":"113.702654ms","start":"2026-04-13T21:07:41.154116Z","end":"2026-04-13T21:07:41.267819Z","steps":["trace[1758556671] 'agreement among raft nodes before linearized reading' (duration: 113.504471ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:07:41.525945Z","caller":"traceutil/trace.go:171","msg":"trace[1343452400] transaction","detail":"{read_only:false; response_revision:8672; number_of_response:1; }","duration":"251.27405ms","start":"2026-04-13T21:07:41.274639Z","end":"2026-04-13T21:07:41.525913Z","steps":["trace[1343452400] 'process raft request' (duration: 214.933254ms)","trace[1343452400] 'compare' (duration: 36.03866ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:07:41.544226Z","caller":"traceutil/trace.go:171","msg":"trace[1249828673] linearizableReadLoop","detail":"{readStateIndex:8976; appliedIndex:8974; }","duration":"166.138343ms","start":"2026-04-13T21:07:41.378054Z","end":"2026-04-13T21:07:41.544193Z","steps":["trace[1249828673] 'read index received' (duration: 111.512133ms)","trace[1249828673] 'applied index is now lower than readState.Index' (duration: 54.62412ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:07:41.544596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.4987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-t2nk5\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-13T21:07:41.544718Z","caller":"traceutil/trace.go:171","msg":"trace[1645096384] range","detail":"{range_begin:/registry/pods/openstack/keepalived-t2nk5; range_end:; response_count:1; response_revision:8672; }","duration":"166.676885ms","start":"2026-04-13T21:07:41.378015Z","end":"2026-04-13T21:07:41.544692Z","steps":["trace[1645096384] 'agreement among raft nodes before linearized reading' (duration: 166.312247ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:08:18.988078Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002482.wal"} {"level":"info","ts":"2026-04-13T21:09:31.361118Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f1e5729930cf7e1f","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-13T21:09:31.366993Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-13T21:09:31.367141Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-13T21:11:52.964774Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8317} {"level":"info","ts":"2026-04-13T21:11:53.042868Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8317,"took":"75.854887ms","hash":2215867745,"current-db-size-bytes":57593856,"current-db-size":"58 MB","current-db-size-in-use-bytes":25923584,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-13T21:11:53.04295Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2215867745,"revision":8317,"compact-revision":6122} {"level":"info","ts":"2026-04-13T21:16:52.974224Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10715} {"level":"info","ts":"2026-04-13T21:16:53.058745Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10715,"took":"82.252646ms","hash":4186929853,"current-db-size-bytes":57593856,"current-db-size":"58 MB","current-db-size-in-use-bytes":21090304,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-13T21:16:53.058876Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4186929853,"revision":10715,"compact-revision":8317}