{"level":"warn","ts":"2026-04-09T05:59:27.958742Z","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-09T05:59:27.958825Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.31: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.19.213.31:2380","--initial-cluster=instance=https://199.19.213.31:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.31:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.31: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-09T05:59:27.958884Z","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-09T05:59:27.958893Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.31:2380"]} {"level":"info","ts":"2026-04-09T05:59:27.958913Z","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-09T05:59:27.95953Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.31:2379"]} {"level":"info","ts":"2026-04-09T05:59:27.959596Z","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.19.213.31:2380"],"listen-peer-urls":["https://199.19.213.31:2380"],"advertise-client-urls":["https://199.19.213.31:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.31:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.31: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-09T05:59:27.965818Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.983833ms"} {"level":"info","ts":"2026-04-09T05:59:27.974322Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b3aa5b67741e7c5e","cluster-id":"9896be1db1fb000"} {"level":"info","ts":"2026-04-09T05:59:27.97441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T05:59:27.97443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became follower at term 0"} {"level":"info","ts":"2026-04-09T05:59:27.974438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b3aa5b67741e7c5e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T05:59:27.974448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became follower at term 1"} {"level":"info","ts":"2026-04-09T05:59:27.974681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e switched to configuration voters=(12946260578717826142)"} {"level":"warn","ts":"2026-04-09T05:59:27.980941Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T05:59:27.982278Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T05:59:27.983388Z","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-09T05:59:27.986098Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b3aa5b67741e7c5e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T05:59:27.986769Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b3aa5b67741e7c5e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T05:59:27.986874Z","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-09T05:59:27.98703Z","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-09T05:59:27.987051Z","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-09T05:59:27.988969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e switched to configuration voters=(12946260578717826142)"} {"level":"info","ts":"2026-04-09T05:59:27.989199Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9896be1db1fb000","local-member-id":"b3aa5b67741e7c5e","added-peer-id":"b3aa5b67741e7c5e","added-peer-peer-urls":["https://199.19.213.31:2380"]} {"level":"info","ts":"2026-04-09T05:59:27.991072Z","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-09T05:59:27.991151Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.31:2380"} {"level":"info","ts":"2026-04-09T05:59:27.991204Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.31:2380"} {"level":"info","ts":"2026-04-09T05:59:27.991413Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b3aa5b67741e7c5e","initial-advertise-peer-urls":["https://199.19.213.31:2380"],"listen-peer-urls":["https://199.19.213.31:2380"],"advertise-client-urls":["https://199.19.213.31:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.31:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T05:59:27.991473Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T05:59:28.775822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T05:59:28.775897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T05:59:28.77594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e received MsgPreVoteResp from b3aa5b67741e7c5e at term 1"} {"level":"info","ts":"2026-04-09T05:59:28.775959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became candidate at term 2"} {"level":"info","ts":"2026-04-09T05:59:28.77597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e received MsgVoteResp from b3aa5b67741e7c5e at term 2"} {"level":"info","ts":"2026-04-09T05:59:28.775986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became leader at term 2"} {"level":"info","ts":"2026-04-09T05:59:28.775999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b3aa5b67741e7c5e elected leader b3aa5b67741e7c5e at term 2"} {"level":"info","ts":"2026-04-09T05:59:28.778004Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T05:59:28.778702Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b3aa5b67741e7c5e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.31:2379]}","request-path":"/0/members/b3aa5b67741e7c5e/attributes","cluster-id":"9896be1db1fb000","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T05:59:28.778898Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T05:59:28.779002Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T05:59:28.779237Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9896be1db1fb000","local-member-id":"b3aa5b67741e7c5e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T05:59:28.779324Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T05:59:28.779349Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T05:59:28.780787Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T05:59:28.787103Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.31:2379"} {"level":"info","ts":"2026-04-09T05:59:28.802502Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T05:59:28.802563Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T05:59:40.516713Z","caller":"traceutil/trace.go:171","msg":"trace[1065450026] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"102.025268ms","start":"2026-04-09T05:59:40.414652Z","end":"2026-04-09T05:59:40.516677Z","steps":["trace[1065450026] 'process raft request' (duration: 101.857062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:00:10.85115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.467318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:00:10.851269Z","caller":"traceutil/trace.go:171","msg":"trace[675296406] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"140.541323ms","start":"2026-04-09T06:00:10.710708Z","end":"2026-04-09T06:00:10.85125Z","steps":["trace[675296406] 'compare' (duration: 130.334125ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:00:11.268039Z","caller":"traceutil/trace.go:171","msg":"trace[1252627973] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"299.159928ms","start":"2026-04-09T06:00:10.968825Z","end":"2026-04-09T06:00:11.267985Z","steps":["trace[1252627973] 'process raft request' (duration: 299.011324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:00:11.577983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.604343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:00:11.578199Z","caller":"traceutil/trace.go:171","msg":"trace[454131237] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"263.168996ms","start":"2026-04-09T06:00:11.315007Z","end":"2026-04-09T06:00:11.578176Z","steps":["trace[454131237] 'read index received' (duration: 96.042459ms)","trace[454131237] 'applied index is now lower than readState.Index' (duration: 167.124237ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:00:11.578239Z","caller":"traceutil/trace.go:171","msg":"trace[1817433804] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"545.425562ms","start":"2026-04-09T06:00:11.03278Z","end":"2026-04-09T06:00:11.578206Z","steps":["trace[1817433804] 'process raft request' (duration: 378.510102ms)","trace[1817433804] 'compare' (duration: 165.719898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:00:11.578379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.332451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T06:00:11.578378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:00:11.032747Z","time spent":"545.568747ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:00:11.578468Z","caller":"traceutil/trace.go:171","msg":"trace[239443349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"263.511487ms","start":"2026-04-09T06:00:11.314934Z","end":"2026-04-09T06:00:11.578446Z","steps":["trace[239443349] 'agreement among raft nodes before linearized reading' (duration: 263.340001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:00:11.578612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.630846ms","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-09T06:00:11.578707Z","caller":"traceutil/trace.go:171","msg":"trace[1531704678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"169.75593ms","start":"2026-04-09T06:00:11.408935Z","end":"2026-04-09T06:00:11.578691Z","steps":["trace[1531704678] 'agreement among raft nodes before linearized reading' (duration: 169.492822ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:00:11.787417Z","caller":"traceutil/trace.go:171","msg":"trace[377887507] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"157.670739ms","start":"2026-04-09T06:00:11.629713Z","end":"2026-04-09T06:00:11.787384Z","steps":["trace[377887507] 'process raft request' (duration: 157.616837ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:00:11.787629Z","caller":"traceutil/trace.go:171","msg":"trace[405943378] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"204.695852ms","start":"2026-04-09T06:00:11.582896Z","end":"2026-04-09T06:00:11.787592Z","steps":["trace[405943378] 'process raft request' (duration: 187.993527ms)","trace[405943378] 'compare' (duration: 16.262753ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:00:11.787747Z","caller":"traceutil/trace.go:171","msg":"trace[1441374052] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"204.116376ms","start":"2026-04-09T06:00:11.58359Z","end":"2026-04-09T06:00:11.787707Z","steps":["trace[1441374052] 'read index received' (duration: 187.408501ms)","trace[1441374052] 'applied index is now lower than readState.Index' (duration: 16.703305ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:00:11.787968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.361822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:00:11.78803Z","caller":"traceutil/trace.go:171","msg":"trace[786933193] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"204.469265ms","start":"2026-04-09T06:00:11.583544Z","end":"2026-04-09T06:00:11.788014Z","steps":["trace[786933193] 'agreement among raft nodes before linearized reading' (duration: 204.322752ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:00:13.133212Z","caller":"traceutil/trace.go:171","msg":"trace[2065915953] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"108.87047ms","start":"2026-04-09T06:00:13.024319Z","end":"2026-04-09T06:00:13.133189Z","steps":["trace[2065915953] 'process raft request' (duration: 108.519709ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:00:13.133265Z","caller":"traceutil/trace.go:171","msg":"trace[1748933357] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"108.106568ms","start":"2026-04-09T06:00:13.025139Z","end":"2026-04-09T06:00:13.133246Z","steps":["trace[1748933357] 'process raft request' (duration: 107.942404ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:45.081317Z","caller":"traceutil/trace.go:171","msg":"trace[97670408] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1951; }","duration":"183.707835ms","start":"2026-04-09T06:01:44.897581Z","end":"2026-04-09T06:01:45.081289Z","steps":["trace[97670408] 'read index received' (duration: 183.458618ms)","trace[97670408] 'applied index is now lower than readState.Index' (duration: 248.297µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:45.081442Z","caller":"traceutil/trace.go:171","msg":"trace[2050937818] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"267.949433ms","start":"2026-04-09T06:01:44.813422Z","end":"2026-04-09T06:01:45.081372Z","steps":["trace[2050937818] 'process raft request' (duration: 267.701417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:45.0817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.099245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5a6a05d2-6a12-4598-b9a1-686924587d87\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-09T06:01:45.081753Z","caller":"traceutil/trace.go:171","msg":"trace[1452297451] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5a6a05d2-6a12-4598-b9a1-686924587d87; range_end:; response_count:1; response_revision:1879; }","duration":"184.217828ms","start":"2026-04-09T06:01:44.897523Z","end":"2026-04-09T06:01:45.081741Z","steps":["trace[1452297451] 'agreement among raft nodes before linearized reading' (duration: 183.965281ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:45.739264Z","caller":"traceutil/trace.go:171","msg":"trace[1849834286] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1954; }","duration":"177.412223ms","start":"2026-04-09T06:01:45.561822Z","end":"2026-04-09T06:01:45.739235Z","steps":["trace[1849834286] 'read index received' (duration: 109.296776ms)","trace[1849834286] 'applied index is now lower than readState.Index' (duration: 68.113657ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:45.739617Z","caller":"traceutil/trace.go:171","msg":"trace[393938417] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"199.457996ms","start":"2026-04-09T06:01:45.540122Z","end":"2026-04-09T06:01:45.73958Z","steps":["trace[393938417] 'process raft request' (duration: 130.977618ms)","trace[393938417] 'compare' (duration: 67.804809ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:45.739681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.843595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-09T06:01:45.739722Z","caller":"traceutil/trace.go:171","msg":"trace[1290720092] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1882; }","duration":"177.931277ms","start":"2026-04-09T06:01:45.561778Z","end":"2026-04-09T06:01:45.73971Z","steps":["trace[1290720092] 'agreement among raft nodes before linearized reading' (duration: 177.785673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:45.739846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.772075ms","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-09T06:01:45.739964Z","caller":"traceutil/trace.go:171","msg":"trace[1501271837] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1882; }","duration":"131.082452ms","start":"2026-04-09T06:01:45.608862Z","end":"2026-04-09T06:01:45.739945Z","steps":["trace[1501271837] 'agreement among raft nodes before linearized reading' (duration: 130.653931ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:02.625352Z","caller":"traceutil/trace.go:171","msg":"trace[1111029375] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"236.464681ms","start":"2026-04-09T06:02:02.388862Z","end":"2026-04-09T06:02:02.625326Z","steps":["trace[1111029375] 'process raft request' (duration: 236.332887ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:02.640672Z","caller":"traceutil/trace.go:171","msg":"trace[1271162000] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"251.283397ms","start":"2026-04-09T06:02:02.389366Z","end":"2026-04-09T06:02:02.640649Z","steps":["trace[1271162000] 'process raft request' (duration: 251.063201ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:02.640726Z","caller":"traceutil/trace.go:171","msg":"trace[656948463] linearizableReadLoop","detail":"{readStateIndex:2097; appliedIndex:2095; }","duration":"193.274557ms","start":"2026-04-09T06:02:02.447414Z","end":"2026-04-09T06:02:02.640689Z","steps":["trace[656948463] 'read index received' (duration: 177.843054ms)","trace[656948463] 'applied index is now lower than readState.Index' (duration: 15.430653ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:02:02.640741Z","caller":"traceutil/trace.go:171","msg":"trace[377205605] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"133.198981ms","start":"2026-04-09T06:02:02.50752Z","end":"2026-04-09T06:02:02.640719Z","steps":["trace[377205605] 'process raft request' (duration: 133.034166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:02:02.6409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.482112ms","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-09T06:02:02.640933Z","caller":"traceutil/trace.go:171","msg":"trace[639647723] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2021; }","duration":"193.574534ms","start":"2026-04-09T06:02:02.44735Z","end":"2026-04-09T06:02:02.640924Z","steps":["trace[639647723] 'agreement among raft nodes before linearized reading' (duration: 193.434421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:02:42.229661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.298812ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:02:42.229865Z","caller":"traceutil/trace.go:171","msg":"trace[1069660] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"281.738521ms","start":"2026-04-09T06:02:41.948082Z","end":"2026-04-09T06:02:42.229821Z","steps":["trace[1069660] 'process raft request' (duration: 32.167082ms)","trace[1069660] 'compare' (duration: 249.144657ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:02:42.513704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.974288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:02:42.514072Z","caller":"traceutil/trace.go:171","msg":"trace[1480105085] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"280.512996ms","start":"2026-04-09T06:02:42.233538Z","end":"2026-04-09T06:02:42.514051Z","steps":["trace[1480105085] 'process raft request' (duration: 280.422693ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:42.514094Z","caller":"traceutil/trace.go:171","msg":"trace[600333815] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"281.061811ms","start":"2026-04-09T06:02:42.233009Z","end":"2026-04-09T06:02:42.514071Z","steps":["trace[600333815] 'process raft request' (duration: 149.616ms)","trace[600333815] 'compare' (duration: 130.682551ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:02:42.514087Z","caller":"traceutil/trace.go:171","msg":"trace[1853449808] linearizableReadLoop","detail":"{readStateIndex:2321; appliedIndex:2320; }","duration":"280.676951ms","start":"2026-04-09T06:02:42.233371Z","end":"2026-04-09T06:02:42.514048Z","steps":["trace[1853449808] 'read index received' (duration: 149.266921ms)","trace[1853449808] 'applied index is now lower than readState.Index' (duration: 131.40773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:02:42.514254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.875707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-09T06:02:42.514587Z","caller":"traceutil/trace.go:171","msg":"trace[2124618432] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2235; }","duration":"281.179655ms","start":"2026-04-09T06:02:42.233331Z","end":"2026-04-09T06:02:42.514511Z","steps":["trace[2124618432] 'agreement among raft nodes before linearized reading' (duration: 280.806394ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:03:24.890744Z","caller":"traceutil/trace.go:171","msg":"trace[132285030] transaction","detail":"{read_only:false; response_revision:2637; number_of_response:1; }","duration":"179.421114ms","start":"2026-04-09T06:03:24.711252Z","end":"2026-04-09T06:03:24.890673Z","steps":["trace[132285030] 'process raft request' (duration: 179.178887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:07:45.003276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.681024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:07:45.003381Z","caller":"traceutil/trace.go:171","msg":"trace[1054772626] linearizableReadLoop","detail":"{readStateIndex:4905; appliedIndex:4904; }","duration":"895.596241ms","start":"2026-04-09T06:07:44.10777Z","end":"2026-04-09T06:07:45.003367Z","steps":["trace[1054772626] 'read index received' (duration: 210.047673ms)","trace[1054772626] 'applied index is now lower than readState.Index' (duration: 685.547288ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:07:45.003588Z","caller":"traceutil/trace.go:171","msg":"trace[1818599520] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"900.518415ms","start":"2026-04-09T06:07:44.103061Z","end":"2026-04-09T06:07:45.003579Z","steps":["trace[1818599520] 'process raft request' (duration: 219.44205ms)","trace[1818599520] 'compare' (duration: 679.806701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:07:45.003625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:07:44.10303Z","time spent":"900.576397ms","remote":"127.0.0.1:60440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4655,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:07:45.003842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.066174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-09T06:07:45.003862Z","caller":"traceutil/trace.go:171","msg":"trace[275391589] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4723; }","duration":"896.087275ms","start":"2026-04-09T06:07:44.107766Z","end":"2026-04-09T06:07:45.003854Z","steps":["trace[275391589] 'agreement among raft nodes before linearized reading' (duration: 895.982322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:07:45.003881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:07:44.10773Z","time spent":"896.147126ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1154,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"warn","ts":"2026-04-09T06:07:45.004409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.985084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4736"} {"level":"info","ts":"2026-04-09T06:07:45.004479Z","caller":"traceutil/trace.go:171","msg":"trace[162561405] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4723; }","duration":"895.090666ms","start":"2026-04-09T06:07:44.109372Z","end":"2026-04-09T06:07:45.004463Z","steps":["trace[162561405] 'agreement among raft nodes before linearized reading' (duration: 894.88062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:07:45.004518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:07:44.109362Z","time spent":"895.148497ms","remote":"127.0.0.1:47520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":4759,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" "} {"level":"warn","ts":"2026-04-09T06:07:45.007427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.202502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:49 size:1957109"} {"level":"info","ts":"2026-04-09T06:07:45.007515Z","caller":"traceutil/trace.go:171","msg":"trace[739711071] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:49; response_revision:4723; }","duration":"894.311485ms","start":"2026-04-09T06:07:44.113186Z","end":"2026-04-09T06:07:45.007498Z","steps":["trace[739711071] 'agreement among raft nodes before linearized reading' (duration: 890.949713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:07:45.00755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:07:44.113111Z","time spent":"894.431968ms","remote":"127.0.0.1:60362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":49,"response size":1957132,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-04-09T06:07:47.365326Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.553861176s","expected-duration":"1s"} {"level":"info","ts":"2026-04-09T06:07:47.365936Z","caller":"traceutil/trace.go:171","msg":"trace[1326423253] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"1.554653508s","start":"2026-04-09T06:07:45.811255Z","end":"2026-04-09T06:07:47.365908Z","steps":["trace[1326423253] 'process raft request' (duration: 1.554400821s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:07:47.366128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:07:45.811232Z","time spent":"1.554797961s","remote":"127.0.0.1:60676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15286,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:07:54.100791Z","caller":"traceutil/trace.go:171","msg":"trace[1874840676] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"134.590316ms","start":"2026-04-09T06:07:53.966148Z","end":"2026-04-09T06:07:54.100738Z","steps":["trace[1874840676] 'process raft request' (duration: 131.284846ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:08:13.773897Z","caller":"traceutil/trace.go:171","msg":"trace[801440946] linearizableReadLoop","detail":"{readStateIndex:5572; appliedIndex:5571; }","duration":"112.252374ms","start":"2026-04-09T06:08:13.661607Z","end":"2026-04-09T06:08:13.77386Z","steps":["trace[801440946] 'read index received' (duration: 111.953976ms)","trace[801440946] 'applied index is now lower than readState.Index' (duration: 297.048µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:08:13.774381Z","caller":"traceutil/trace.go:171","msg":"trace[197358857] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"114.049344ms","start":"2026-04-09T06:08:13.660317Z","end":"2026-04-09T06:08:13.774366Z","steps":["trace[197358857] 'process raft request' (duration: 113.348655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:08:13.774737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.104497ms","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-09T06:08:13.77478Z","caller":"traceutil/trace.go:171","msg":"trace[435859448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5371; }","duration":"113.18762ms","start":"2026-04-09T06:08:13.661582Z","end":"2026-04-09T06:08:13.774769Z","steps":["trace[435859448] 'agreement among raft nodes before linearized reading' (duration: 113.009845ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:08:13.879271Z","caller":"traceutil/trace.go:171","msg":"trace[314944979] transaction","detail":"{read_only:false; response_revision:5372; number_of_response:1; }","duration":"215.78828ms","start":"2026-04-09T06:08:13.66345Z","end":"2026-04-09T06:08:13.879239Z","steps":["trace[314944979] 'process raft request' (duration: 144.208359ms)","trace[314944979] 'compare' (duration: 71.378486ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:08:13.879476Z","caller":"traceutil/trace.go:171","msg":"trace[1851597170] linearizableReadLoop","detail":"{readStateIndex:5574; appliedIndex:5572; }","duration":"105.460289ms","start":"2026-04-09T06:08:13.773993Z","end":"2026-04-09T06:08:13.879453Z","steps":["trace[1851597170] 'read index received' (duration: 33.59536ms)","trace[1851597170] 'applied index is now lower than readState.Index' (duration: 71.862699ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:08:13.879637Z","caller":"traceutil/trace.go:171","msg":"trace[843627221] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"215.600135ms","start":"2026-04-09T06:08:13.664023Z","end":"2026-04-09T06:08:13.879623Z","steps":["trace[843627221] 'process raft request' (duration: 215.165964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:08:13.879723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.858473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dd2dce5f-34c5-4143-9a40-30abf730d7ae\" ","response":"range_response_count:1 size:3645"} {"level":"warn","ts":"2026-04-09T06:08:13.879804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.991514ms","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-09T06:08:13.87985Z","caller":"traceutil/trace.go:171","msg":"trace[655707382] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5373; }","duration":"217.082056ms","start":"2026-04-09T06:08:13.662758Z","end":"2026-04-09T06:08:13.879841Z","steps":["trace[655707382] 'agreement among raft nodes before linearized reading' (duration: 216.969483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:08:13.879854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.384001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-swpzg\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-09T06:08:13.879899Z","caller":"traceutil/trace.go:171","msg":"trace[1483951061] range","detail":"{range_begin:/registry/pods/openstack/keepalived-swpzg; range_end:; response_count:1; response_revision:5373; }","duration":"199.431152ms","start":"2026-04-09T06:08:13.680454Z","end":"2026-04-09T06:08:13.879885Z","steps":["trace[1483951061] 'agreement among raft nodes before linearized reading' (duration: 199.046302ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:08:13.879812Z","caller":"traceutil/trace.go:171","msg":"trace[116509391] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dd2dce5f-34c5-4143-9a40-30abf730d7ae; range_end:; response_count:1; response_revision:5373; }","duration":"203.968497ms","start":"2026-04-09T06:08:13.675821Z","end":"2026-04-09T06:08:13.87979Z","steps":["trace[116509391] 'agreement among raft nodes before linearized reading' (duration: 203.690129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:08:13.879744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.518539ms","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-09T06:08:13.880055Z","caller":"traceutil/trace.go:171","msg":"trace[223747657] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5373; }","duration":"205.87219ms","start":"2026-04-09T06:08:13.674163Z","end":"2026-04-09T06:08:13.880035Z","steps":["trace[223747657] 'agreement among raft nodes before linearized reading' (duration: 205.396607ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:08:13.884299Z","caller":"traceutil/trace.go:171","msg":"trace[1258811366] transaction","detail":"{read_only:false; response_revision:5374; number_of_response:1; }","duration":"104.45162ms","start":"2026-04-09T06:08:13.779831Z","end":"2026-04-09T06:08:13.884282Z","steps":["trace[1258811366] 'process raft request' (duration: 104.167673ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:08:14.253738Z","caller":"traceutil/trace.go:171","msg":"trace[1775237585] transaction","detail":"{read_only:false; response_revision:5378; number_of_response:1; }","duration":"304.935092ms","start":"2026-04-09T06:08:13.948768Z","end":"2026-04-09T06:08:14.253703Z","steps":["trace[1775237585] 'process raft request' (duration: 304.721297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:08:14.253933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:08:13.948737Z","time spent":"305.089907ms","remote":"127.0.0.1:60440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9709,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:08:14.480785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.107412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:08:14.480914Z","caller":"traceutil/trace.go:171","msg":"trace[1286759055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5378; }","duration":"165.296978ms","start":"2026-04-09T06:08:14.315589Z","end":"2026-04-09T06:08:14.480886Z","steps":["trace[1286759055] 'range keys from in-memory index tree' (duration: 164.985839ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:28.810129Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3006} {"level":"info","ts":"2026-04-09T06:09:28.894024Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3006,"took":"82.026799ms","hash":590062473,"current-db-size-bytes":58150912,"current-db-size":"58 MB","current-db-size-in-use-bytes":31436800,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-09T06:09:28.894107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":590062473,"revision":3006,"compact-revision":-1} {"level":"warn","ts":"2026-04-09T06:14:22.555902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.525059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-swpzg\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-04-09T06:14:22.555942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.085259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:14:22.556005Z","caller":"traceutil/trace.go:171","msg":"trace[971538709] range","detail":"{range_begin:/registry/pods/openstack/keepalived-swpzg; range_end:; response_count:1; response_revision:8254; }","duration":"365.675963ms","start":"2026-04-09T06:14:22.190309Z","end":"2026-04-09T06:14:22.555985Z","steps":["trace[971538709] 'range keys from in-memory index tree' (duration: 365.333614ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:14:22.556041Z","caller":"traceutil/trace.go:171","msg":"trace[249095875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8254; }","duration":"242.210853ms","start":"2026-04-09T06:14:22.313801Z","end":"2026-04-09T06:14:22.556011Z","steps":["trace[249095875] 'range keys from in-memory index tree' (duration: 242.018597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:14:22.556085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:14:22.190289Z","time spent":"365.777615ms","remote":"127.0.0.1:60440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-swpzg\" "} {"level":"warn","ts":"2026-04-09T06:14:22.556106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.356944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T06:14:22.555944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.795531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T06:14:22.556167Z","caller":"traceutil/trace.go:171","msg":"trace[719257971] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:8254; }","duration":"239.430187ms","start":"2026-04-09T06:14:22.316719Z","end":"2026-04-09T06:14:22.556149Z","steps":["trace[719257971] 'count revisions from in-memory index tree' (duration: 239.311613ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:14:22.556229Z","caller":"traceutil/trace.go:171","msg":"trace[2040827537] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8254; }","duration":"223.1276ms","start":"2026-04-09T06:14:22.333071Z","end":"2026-04-09T06:14:22.556199Z","steps":["trace[2040827537] 'count revisions from in-memory index tree' (duration: 222.703108ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:14:28.859708Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6093} {"level":"info","ts":"2026-04-09T06:14:28.959038Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6093,"took":"96.209094ms","hash":297860587,"current-db-size-bytes":58150912,"current-db-size":"58 MB","current-db-size-in-use-bytes":23662592,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-09T06:14:28.959148Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":297860587,"revision":6093,"compact-revision":3006} {"level":"warn","ts":"2026-04-09T06:14:34.218402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.841011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:14:34.218506Z","caller":"traceutil/trace.go:171","msg":"trace[1420822531] linearizableReadLoop","detail":"{readStateIndex:8610; appliedIndex:8609; }","duration":"273.821418ms","start":"2026-04-09T06:14:33.944667Z","end":"2026-04-09T06:14:34.218488Z","steps":["trace[1420822531] 'read index received' (duration: 19.822993ms)","trace[1420822531] 'applied index is now lower than readState.Index' (duration: 253.997375ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:14:34.218516Z","caller":"traceutil/trace.go:171","msg":"trace[660892673] transaction","detail":"{read_only:false; response_revision:8315; number_of_response:1; }","duration":"288.303554ms","start":"2026-04-09T06:14:33.930187Z","end":"2026-04-09T06:14:34.21849Z","steps":["trace[660892673] 'process raft request' (duration: 34.282758ms)","trace[660892673] 'compare' (duration: 253.733778ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:14:34.21868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.017523ms","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-09T06:14:34.21872Z","caller":"traceutil/trace.go:171","msg":"trace[1063824909] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8315; }","duration":"274.097765ms","start":"2026-04-09T06:14:33.944611Z","end":"2026-04-09T06:14:34.218709Z","steps":["trace[1063824909] 'agreement among raft nodes before linearized reading' (duration: 273.965711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:14:34.218931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.404424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-09T06:14:34.218966Z","caller":"traceutil/trace.go:171","msg":"trace[219703363] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8315; }","duration":"239.499738ms","start":"2026-04-09T06:14:33.979456Z","end":"2026-04-09T06:14:34.218956Z","steps":["trace[219703363] 'agreement among raft nodes before linearized reading' (duration: 239.376164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:14:34.219061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.852869ms","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-09T06:14:34.219106Z","caller":"traceutil/trace.go:171","msg":"trace[1820476419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8315; }","duration":"265.946742ms","start":"2026-04-09T06:14:33.953146Z","end":"2026-04-09T06:14:34.219092Z","steps":["trace[1820476419] 'agreement among raft nodes before linearized reading' (duration: 265.817819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:14:34.219154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.999584ms","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-09T06:14:34.219267Z","caller":"traceutil/trace.go:171","msg":"trace[1564538538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8315; }","duration":"266.162828ms","start":"2026-04-09T06:14:33.953079Z","end":"2026-04-09T06:14:34.219242Z","steps":["trace[1564538538] 'agreement among raft nodes before linearized reading' (duration: 265.748547ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:14:34.365194Z","caller":"traceutil/trace.go:171","msg":"trace[848749963] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"141.515165ms","start":"2026-04-09T06:14:34.223646Z","end":"2026-04-09T06:14:34.365161Z","steps":["trace[848749963] 'process raft request' (duration: 141.409372ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:14:34.365237Z","caller":"traceutil/trace.go:171","msg":"trace[1861423387] transaction","detail":"{read_only:false; response_revision:8319; number_of_response:1; }","duration":"141.531195ms","start":"2026-04-09T06:14:34.223667Z","end":"2026-04-09T06:14:34.365198Z","steps":["trace[1861423387] 'process raft request' (duration: 141.433872ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:14:34.365414Z","caller":"traceutil/trace.go:171","msg":"trace[2040905249] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"142.196153ms","start":"2026-04-09T06:14:34.223176Z","end":"2026-04-09T06:14:34.365372Z","steps":["trace[2040905249] 'process raft request' (duration: 141.68773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:15:02.954525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.641402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-09T06:15:02.954584Z","caller":"traceutil/trace.go:171","msg":"trace[1765454050] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8523; }","duration":"216.765876ms","start":"2026-04-09T06:15:02.737807Z","end":"2026-04-09T06:15:02.954573Z","steps":["trace[1765454050] 'range keys from in-memory index tree' (duration: 216.474158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:15:02.954741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.326286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-09T06:15:02.954764Z","caller":"traceutil/trace.go:171","msg":"trace[1193865033] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8523; }","duration":"215.380197ms","start":"2026-04-09T06:15:02.739378Z","end":"2026-04-09T06:15:02.954758Z","steps":["trace[1193865033] 'range keys from in-memory index tree' (duration: 215.192773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:15:02.955394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.246869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-swpzg\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-09T06:15:02.955472Z","caller":"traceutil/trace.go:171","msg":"trace[1629806496] range","detail":"{range_begin:/registry/pods/openstack/keepalived-swpzg; range_end:; response_count:1; response_revision:8523; }","duration":"129.364562ms","start":"2026-04-09T06:15:02.826091Z","end":"2026-04-09T06:15:02.955456Z","steps":["trace[1629806496] 'range keys from in-memory index tree' (duration: 129.130966ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:15:02.955538Z","caller":"traceutil/trace.go:171","msg":"trace[283118855] transaction","detail":"{read_only:false; response_revision:8524; number_of_response:1; }","duration":"129.394303ms","start":"2026-04-09T06:15:02.826117Z","end":"2026-04-09T06:15:02.955512Z","steps":["trace[283118855] 'process raft request' (duration: 105.230631ms)","trace[283118855] 'compare' (duration: 22.744882ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:15:03.084991Z","caller":"traceutil/trace.go:171","msg":"trace[1223667346] transaction","detail":"{read_only:false; response_revision:8525; number_of_response:1; }","duration":"126.556826ms","start":"2026-04-09T06:15:02.958404Z","end":"2026-04-09T06:15:03.08496Z","steps":["trace[1223667346] 'process raft request' (duration: 126.209976ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:15:03.088207Z","caller":"traceutil/trace.go:171","msg":"trace[111192884] linearizableReadLoop","detail":"{readStateIndex:8829; appliedIndex:8827; }","duration":"126.080643ms","start":"2026-04-09T06:15:02.962089Z","end":"2026-04-09T06:15:03.08817Z","steps":["trace[111192884] 'read index received' (duration: 122.34043ms)","trace[111192884] 'applied index is now lower than readState.Index' (duration: 3.739083ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:15:03.088861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.750981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228552"} {"level":"info","ts":"2026-04-09T06:15:03.088907Z","caller":"traceutil/trace.go:171","msg":"trace[869013653] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8526; }","duration":"126.852614ms","start":"2026-04-09T06:15:02.962044Z","end":"2026-04-09T06:15:03.088896Z","steps":["trace[869013653] 'agreement among raft nodes before linearized reading' (duration: 126.275798ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:15:03.089391Z","caller":"traceutil/trace.go:171","msg":"trace[181336815] transaction","detail":"{read_only:false; response_revision:8526; number_of_response:1; }","duration":"128.580921ms","start":"2026-04-09T06:15:02.960787Z","end":"2026-04-09T06:15:03.089368Z","steps":["trace[181336815] 'process raft request' (duration: 127.244524ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:15:32.301763Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023ad.wal"} {"level":"info","ts":"2026-04-09T06:16:31.19762Z","caller":"traceutil/trace.go:171","msg":"trace[2057503118] transaction","detail":"{read_only:false; response_revision:9374; number_of_response:1; }","duration":"112.740867ms","start":"2026-04-09T06:16:31.084853Z","end":"2026-04-09T06:16:31.197594Z","steps":["trace[2057503118] 'process raft request' (duration: 22.480246ms)","trace[2057503118] 'compare' (duration: 90.141878ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:17:09.248544Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b3aa5b67741e7c5e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-09T06:17:09.256693Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-09T06:17:09.256788Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-09T06:19:28.866514Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8285} {"level":"info","ts":"2026-04-09T06:19:28.949467Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8285,"took":"80.544253ms","hash":3693735846,"current-db-size-bytes":58150912,"current-db-size":"58 MB","current-db-size-in-use-bytes":25812992,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-09T06:19:28.949534Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3693735846,"revision":8285,"compact-revision":6093} {"level":"info","ts":"2026-04-09T06:24:28.871624Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10683} {"level":"info","ts":"2026-04-09T06:24:28.954342Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10683,"took":"79.91436ms","hash":1366016745,"current-db-size-bytes":58150912,"current-db-size":"58 MB","current-db-size-in-use-bytes":20443136,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-09T06:24:28.954403Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1366016745,"revision":10683,"compact-revision":8285}