{"level":"warn","ts":"2026-04-22T06:05:36.278386Z","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-22T06:05:36.278474Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-22T06:05:36.278542Z","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-22T06:05:36.278556Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-04-22T06:05:36.278573Z","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-22T06:05:36.279223Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-04-22T06:05:36.27932Z","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.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-22T06:05:36.283045Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.495298ms"} {"level":"info","ts":"2026-04-22T06:05:36.291198Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-04-22T06:05:36.29142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T06:05:36.291484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-04-22T06:05:36.291524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T06:05:36.291559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-04-22T06:05:36.291654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-04-22T06:05:36.296778Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T06:05:36.298611Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T06:05:36.300579Z","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-22T06:05:36.302766Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T06:05:36.307321Z","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-22T06:05:36.30742Z","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-22T06:05:36.30743Z","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-22T06:05:36.307596Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T06:05:36.308427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-04-22T06:05:36.308566Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-04-22T06:05:36.30872Z","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-22T06:05:36.308825Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-04-22T06:05:36.308863Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-04-22T06:05:36.309236Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T06:05:36.309387Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T06:05:36.692337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T06:05:36.692455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T06:05:36.692489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-04-22T06:05:36.692512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-04-22T06:05:36.692526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-04-22T06:05:36.692542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-04-22T06:05:36.69256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-04-22T06:05:36.693599Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T06:05:36.693816Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:05:36.694029Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:05:36.695057Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:05:36.695172Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:05:36.695205Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T06:05:36.695565Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T06:05:36.697421Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-04-22T06:05:36.698085Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T06:05:36.698425Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T06:05:36.698468Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T06:05:38.203987Z","caller":"traceutil/trace.go:171","msg":"trace[1670467424] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"169.483861ms","start":"2026-04-22T06:05:38.03447Z","end":"2026-04-22T06:05:38.203953Z","steps":["trace[1670467424] 'read index received' (duration: 169.331638ms)","trace[1670467424] 'applied index is now lower than readState.Index' (duration: 150.953µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:05:38.204048Z","caller":"traceutil/trace.go:171","msg":"trace[2031656677] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"169.823128ms","start":"2026-04-22T06:05:38.034178Z","end":"2026-04-22T06:05:38.204001Z","steps":["trace[2031656677] 'process raft request' (duration: 169.521572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:38.204309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.778907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T06:05:38.204497Z","caller":"traceutil/trace.go:171","msg":"trace[1317487989] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"170.017171ms","start":"2026-04-22T06:05:38.034456Z","end":"2026-04-22T06:05:38.204473Z","steps":["trace[1317487989] 'agreement among raft nodes before linearized reading' (duration: 169.640164ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:38.209664Z","caller":"traceutil/trace.go:171","msg":"trace[1612719111] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"175.087863ms","start":"2026-04-22T06:05:38.034542Z","end":"2026-04-22T06:05:38.20963Z","steps":["trace[1612719111] 'process raft request' (duration: 174.892609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:38.210129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.86158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T06:05:38.210186Z","caller":"traceutil/trace.go:171","msg":"trace[1449416718] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"122.975442ms","start":"2026-04-22T06:05:38.087197Z","end":"2026-04-22T06:05:38.210173Z","steps":["trace[1449416718] 'agreement among raft nodes before linearized reading' (duration: 122.810589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:38.210266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.650355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T06:05:38.210315Z","caller":"traceutil/trace.go:171","msg":"trace[1184591492] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"123.737777ms","start":"2026-04-22T06:05:38.086564Z","end":"2026-04-22T06:05:38.210302Z","steps":["trace[1184591492] 'agreement among raft nodes before linearized reading' (duration: 123.647805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:38.211375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.232887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-22T06:05:38.211437Z","caller":"traceutil/trace.go:171","msg":"trace[2112429419] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"125.354949ms","start":"2026-04-22T06:05:38.086064Z","end":"2026-04-22T06:05:38.211419Z","steps":["trace[2112429419] 'agreement among raft nodes before linearized reading' (duration: 123.769128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:46.626856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.138685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-22T06:05:46.626873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.017601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-22T06:05:46.626956Z","caller":"traceutil/trace.go:171","msg":"trace[1615147865] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:331; }","duration":"214.303059ms","start":"2026-04-22T06:05:46.412633Z","end":"2026-04-22T06:05:46.626936Z","steps":["trace[1615147865] 'range keys from in-memory index tree' (duration: 213.956392ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:46.626982Z","caller":"traceutil/trace.go:171","msg":"trace[651628124] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:331; }","duration":"312.171284ms","start":"2026-04-22T06:05:46.314786Z","end":"2026-04-22T06:05:46.626958Z","steps":["trace[651628124] 'range keys from in-memory index tree' (duration: 311.851807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:46.627038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:46.314775Z","time spent":"312.252065ms","remote":"127.0.0.1:59128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-04-22T06:05:46.911591Z","caller":"traceutil/trace.go:171","msg":"trace[1783204] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"280.162301ms","start":"2026-04-22T06:05:46.631404Z","end":"2026-04-22T06:05:46.911566Z","steps":["trace[1783204] 'process raft request' (duration: 279.972326ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:47.018379Z","caller":"traceutil/trace.go:171","msg":"trace[61371599] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"381.222148ms","start":"2026-04-22T06:05:46.63713Z","end":"2026-04-22T06:05:47.018352Z","steps":["trace[61371599] 'process raft request' (duration: 294.232408ms)","trace[61371599] 'compare' (duration: 86.644753ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:05:47.019059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:05:46.637103Z","time spent":"381.385602ms","remote":"127.0.0.1:59112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T06:06:28.485632Z","caller":"traceutil/trace.go:171","msg":"trace[559319661] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"263.172044ms","start":"2026-04-22T06:06:28.222404Z","end":"2026-04-22T06:06:28.485576Z","steps":["trace[559319661] 'process raft request' (duration: 200.837932ms)","trace[559319661] 'compare' (duration: 62.059356ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:06:29.08033Z","caller":"traceutil/trace.go:171","msg":"trace[391425584] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"225.830725ms","start":"2026-04-22T06:06:28.854475Z","end":"2026-04-22T06:06:29.080306Z","steps":["trace[391425584] 'process raft request' (duration: 225.675482ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:06:29.217472Z","caller":"traceutil/trace.go:171","msg":"trace[1863555926] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"326.915723ms","start":"2026-04-22T06:06:28.89053Z","end":"2026-04-22T06:06:29.217446Z","steps":["trace[1863555926] 'process raft request' (duration: 326.273591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:06:29.218264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:06:28.89049Z","time spent":"327.054056ms","remote":"127.0.0.1:59040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:06:44.176179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.093109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2f9rm\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-22T06:06:44.176311Z","caller":"traceutil/trace.go:171","msg":"trace[1707077126] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2f9rm; range_end:; response_count:1; response_revision:772; }","duration":"236.300243ms","start":"2026-04-22T06:06:43.939983Z","end":"2026-04-22T06:06:44.176283Z","steps":["trace[1707077126] 'range keys from in-memory index tree' (duration: 235.839863ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:11.969436Z","caller":"traceutil/trace.go:171","msg":"trace[1009459880] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"159.147183ms","start":"2026-04-22T06:07:11.810269Z","end":"2026-04-22T06:07:11.969416Z","steps":["trace[1009459880] 'process raft request' (duration: 159.027199ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:56.623659Z","caller":"traceutil/trace.go:171","msg":"trace[348152227] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"258.35272ms","start":"2026-04-22T06:07:56.36528Z","end":"2026-04-22T06:07:56.623632Z","steps":["trace[348152227] 'process raft request' (duration: 258.189677ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:09.631422Z","caller":"traceutil/trace.go:171","msg":"trace[584654192] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"132.940119ms","start":"2026-04-22T06:08:09.498457Z","end":"2026-04-22T06:08:09.631397Z","steps":["trace[584654192] 'process raft request' (duration: 132.697624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:36.145401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.283712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T06:08:36.145608Z","caller":"traceutil/trace.go:171","msg":"trace[857742177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2097; }","duration":"110.562987ms","start":"2026-04-22T06:08:36.035024Z","end":"2026-04-22T06:08:36.145587Z","steps":["trace[857742177] 'range keys from in-memory index tree' (duration: 109.968186ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:41.931434Z","caller":"traceutil/trace.go:171","msg":"trace[627891354] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"177.960895ms","start":"2026-04-22T06:08:41.753433Z","end":"2026-04-22T06:08:41.931394Z","steps":["trace[627891354] 'process raft request' (duration: 126.700287ms)","trace[627891354] 'compare' (duration: 50.969993ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:09:36.304958Z","caller":"traceutil/trace.go:171","msg":"trace[52820056] linearizableReadLoop","detail":"{readStateIndex:2699; appliedIndex:2698; }","duration":"106.168396ms","start":"2026-04-22T06:09:36.198763Z","end":"2026-04-22T06:09:36.304931Z","steps":["trace[52820056] 'read index received' (duration: 105.924791ms)","trace[52820056] 'applied index is now lower than readState.Index' (duration: 242.595µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:09:36.305033Z","caller":"traceutil/trace.go:171","msg":"trace[1901586395] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"169.939664ms","start":"2026-04-22T06:09:36.135056Z","end":"2026-04-22T06:09:36.304995Z","steps":["trace[1901586395] 'process raft request' (duration: 169.715049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:09:36.305205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.36791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T06:09:36.305247Z","caller":"traceutil/trace.go:171","msg":"trace[564635169] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2592; }","duration":"106.446651ms","start":"2026-04-22T06:09:36.198787Z","end":"2026-04-22T06:09:36.305234Z","steps":["trace[564635169] 'agreement among raft nodes before linearized reading' (duration: 106.293438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:09:36.305282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.489832ms","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-22T06:09:36.305361Z","caller":"traceutil/trace.go:171","msg":"trace[1821708806] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2592; }","duration":"106.617005ms","start":"2026-04-22T06:09:36.198724Z","end":"2026-04-22T06:09:36.305341Z","steps":["trace[1821708806] 'agreement among raft nodes before linearized reading' (duration: 106.352529ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:10.572324Z","caller":"traceutil/trace.go:171","msg":"trace[1773478887] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"141.922647ms","start":"2026-04-22T06:10:10.430373Z","end":"2026-04-22T06:10:10.572295Z","steps":["trace[1773478887] 'process raft request' (duration: 141.684413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:10:10.868507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.416691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:10:10.868716Z","caller":"traceutil/trace.go:171","msg":"trace[1841678800] transaction","detail":"{read_only:false; response_revision:2803; number_of_response:1; }","duration":"201.031013ms","start":"2026-04-22T06:10:10.667668Z","end":"2026-04-22T06:10:10.868699Z","steps":["trace[1841678800] 'process raft request' (duration: 200.940371ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:10:10.868809Z","caller":"traceutil/trace.go:171","msg":"trace[1789530145] transaction","detail":"{read_only:false; response_revision:2802; number_of_response:1; }","duration":"232.57185ms","start":"2026-04-22T06:10:10.636147Z","end":"2026-04-22T06:10:10.868719Z","steps":["trace[1789530145] 'process raft request' (duration: 119.71048ms)","trace[1789530145] 'compare' (duration: 112.303759ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:10:11.108802Z","caller":"traceutil/trace.go:171","msg":"trace[41835748] transaction","detail":"{read_only:false; response_revision:2804; number_of_response:1; }","duration":"235.294605ms","start":"2026-04-22T06:10:10.873479Z","end":"2026-04-22T06:10:11.108773Z","steps":["trace[41835748] 'process raft request' (duration: 139.803916ms)","trace[41835748] 'compare' (duration: 95.328986ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:10:11.116076Z","caller":"traceutil/trace.go:171","msg":"trace[348608150] transaction","detail":"{read_only:false; response_revision:2805; number_of_response:1; }","duration":"242.303867ms","start":"2026-04-22T06:10:10.873737Z","end":"2026-04-22T06:10:11.116041Z","steps":["trace[348608150] 'process raft request' (duration: 242.179354ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:08.967039Z","caller":"traceutil/trace.go:171","msg":"trace[1498615740] linearizableReadLoop","detail":"{readStateIndex:5054; appliedIndex:5053; }","duration":"134.844936ms","start":"2026-04-22T06:14:08.832154Z","end":"2026-04-22T06:14:08.966999Z","steps":["trace[1498615740] 'read index received' (duration: 134.562839ms)","trace[1498615740] 'applied index is now lower than readState.Index' (duration: 280.507µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:14:08.967167Z","caller":"traceutil/trace.go:171","msg":"trace[1034593479] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"177.901545ms","start":"2026-04-22T06:14:08.789209Z","end":"2026-04-22T06:14:08.96711Z","steps":["trace[1034593479] 'process raft request' (duration: 177.527197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:08.967437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.249253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-22T06:14:08.967497Z","caller":"traceutil/trace.go:171","msg":"trace[1086947841] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4858; }","duration":"135.344265ms","start":"2026-04-22T06:14:08.832135Z","end":"2026-04-22T06:14:08.96748Z","steps":["trace[1086947841] 'agreement among raft nodes before linearized reading' (duration: 135.06749ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:23.816037Z","caller":"traceutil/trace.go:171","msg":"trace[1074861047] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"188.039869ms","start":"2026-04-22T06:14:23.627966Z","end":"2026-04-22T06:14:23.816006Z","steps":["trace[1074861047] 'process raft request' (duration: 187.844745ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:23.828162Z","caller":"traceutil/trace.go:171","msg":"trace[210937191] linearizableReadLoop","detail":"{readStateIndex:5439; appliedIndex:5435; }","duration":"164.144126ms","start":"2026-04-22T06:14:23.663992Z","end":"2026-04-22T06:14:23.828136Z","steps":["trace[210937191] 'read index received' (duration: 151.885729ms)","trace[210937191] 'applied index is now lower than readState.Index' (duration: 12.256357ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:14:23.828482Z","caller":"traceutil/trace.go:171","msg":"trace[1806855111] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"198.96655ms","start":"2026-04-22T06:14:23.629502Z","end":"2026-04-22T06:14:23.828468Z","steps":["trace[1806855111] 'process raft request' (duration: 198.305126ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:23.828798Z","caller":"traceutil/trace.go:171","msg":"trace[1869479694] transaction","detail":"{read_only:false; response_revision:5231; number_of_response:1; }","duration":"198.157624ms","start":"2026-04-22T06:14:23.630626Z","end":"2026-04-22T06:14:23.828784Z","steps":["trace[1869479694] 'process raft request' (duration: 197.326637ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:23.829029Z","caller":"traceutil/trace.go:171","msg":"trace[1647857524] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"169.664849ms","start":"2026-04-22T06:14:23.659355Z","end":"2026-04-22T06:14:23.82902Z","steps":["trace[1647857524] 'process raft request' (duration: 168.663658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:23.829358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.352051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-22T06:14:23.829403Z","caller":"traceutil/trace.go:171","msg":"trace[319679849] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5233; }","duration":"165.450953ms","start":"2026-04-22T06:14:23.663938Z","end":"2026-04-22T06:14:23.829389Z","steps":["trace[319679849] 'agreement among raft nodes before linearized reading' (duration: 165.28291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:23.829735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.479785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-tm8hm.18a8992799ccd6b8\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-22T06:14:23.829778Z","caller":"traceutil/trace.go:171","msg":"trace[577974754] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-tm8hm.18a8992799ccd6b8; range_end:; response_count:1; response_revision:5233; }","duration":"123.566146ms","start":"2026-04-22T06:14:23.706196Z","end":"2026-04-22T06:14:23.829763Z","steps":["trace[577974754] 'agreement among raft nodes before linearized reading' (duration: 123.446194ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:32.046419Z","caller":"traceutil/trace.go:171","msg":"trace[2127205891] transaction","detail":"{read_only:false; response_revision:5395; number_of_response:1; }","duration":"333.996858ms","start":"2026-04-22T06:14:31.712379Z","end":"2026-04-22T06:14:32.046376Z","steps":["trace[2127205891] 'process raft request' (duration: 255.677696ms)","trace[2127205891] 'compare' (duration: 78.048427ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:14:32.046475Z","caller":"traceutil/trace.go:171","msg":"trace[736763329] linearizableReadLoop","detail":"{readStateIndex:5606; appliedIndex:5605; }","duration":"294.762546ms","start":"2026-04-22T06:14:31.751684Z","end":"2026-04-22T06:14:32.046446Z","steps":["trace[736763329] 'read index received' (duration: 216.329371ms)","trace[736763329] 'applied index is now lower than readState.Index' (duration: 78.431345ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:14:32.04657Z","caller":"traceutil/trace.go:171","msg":"trace[242677007] transaction","detail":"{read_only:false; response_revision:5397; number_of_response:1; }","duration":"186.791903ms","start":"2026-04-22T06:14:31.859745Z","end":"2026-04-22T06:14:32.046537Z","steps":["trace[242677007] 'process raft request' (duration: 186.734982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:32.046615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:14:31.712353Z","time spent":"334.163101ms","remote":"127.0.0.1:59112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:14:32.04674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.037621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ca5252b2-dcd3-416d-8c02-a7059f1c1c0e\" ","response":"range_response_count:1 size:3763"} {"level":"info","ts":"2026-04-22T06:14:32.046791Z","caller":"traceutil/trace.go:171","msg":"trace[193083777] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ca5252b2-dcd3-416d-8c02-a7059f1c1c0e; range_end:; response_count:1; response_revision:5397; }","duration":"295.131213ms","start":"2026-04-22T06:14:31.751647Z","end":"2026-04-22T06:14:32.046778Z","steps":["trace[193083777] 'agreement among raft nodes before linearized reading' (duration: 294.944249ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:32.046934Z","caller":"traceutil/trace.go:171","msg":"trace[546661172] transaction","detail":"{read_only:false; response_revision:5396; number_of_response:1; }","duration":"188.324815ms","start":"2026-04-22T06:14:31.858596Z","end":"2026-04-22T06:14:32.04692Z","steps":["trace[546661172] 'process raft request' (duration: 187.773504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:32.046963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.25309ms","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-22T06:14:32.047001Z","caller":"traceutil/trace.go:171","msg":"trace[695531301] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5397; }","duration":"124.352142ms","start":"2026-04-22T06:14:31.922639Z","end":"2026-04-22T06:14:32.046991Z","steps":["trace[695531301] 'agreement among raft nodes before linearized reading' (duration: 124.21815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:32.04717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.434332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-22T06:14:32.047213Z","caller":"traceutil/trace.go:171","msg":"trace[363089213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5397; }","duration":"113.534874ms","start":"2026-04-22T06:14:31.933667Z","end":"2026-04-22T06:14:32.047202Z","steps":["trace[363089213] 'agreement among raft nodes before linearized reading' (duration: 113.407571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:14:32.26176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.444581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:14:32.261953Z","caller":"traceutil/trace.go:171","msg":"trace[1718888236] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"207.975662ms","start":"2026-04-22T06:14:32.053955Z","end":"2026-04-22T06:14:32.261931Z","steps":["trace[1718888236] 'process raft request' (duration: 207.9192ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:32.262356Z","caller":"traceutil/trace.go:171","msg":"trace[954731259] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"209.227037ms","start":"2026-04-22T06:14:32.053115Z","end":"2026-04-22T06:14:32.262342Z","steps":["trace[954731259] 'process raft request' (duration: 99.095492ms)","trace[954731259] 'compare' (duration: 109.152025ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:14:32.263169Z","caller":"traceutil/trace.go:171","msg":"trace[479036887] linearizableReadLoop","detail":"{readStateIndex:5609; appliedIndex:5608; }","duration":"209.968702ms","start":"2026-04-22T06:14:32.053158Z","end":"2026-04-22T06:14:32.263127Z","steps":["trace[479036887] 'read index received' (duration: 99.073991ms)","trace[479036887] 'applied index is now lower than readState.Index' (duration: 110.889001ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:14:32.263742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.543073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:5835"} {"level":"info","ts":"2026-04-22T06:14:32.263853Z","caller":"traceutil/trace.go:171","msg":"trace[1359032537] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:5399; }","duration":"210.745128ms","start":"2026-04-22T06:14:32.053085Z","end":"2026-04-22T06:14:32.26383Z","steps":["trace[1359032537] 'agreement among raft nodes before linearized reading' (duration: 210.212538ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:14:32.266026Z","caller":"traceutil/trace.go:171","msg":"trace[1742937593] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"109.888551ms","start":"2026-04-22T06:14:32.156105Z","end":"2026-04-22T06:14:32.265993Z","steps":["trace[1742937593] 'process raft request' (duration: 109.588824ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:15:36.750543Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2943} {"level":"info","ts":"2026-04-22T06:15:36.834Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2943,"took":"79.541719ms","hash":3535984906,"current-db-size-bytes":56934400,"current-db-size":"57 MB","current-db-size-in-use-bytes":33325056,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-22T06:15:36.834062Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3535984906,"revision":2943,"compact-revision":-1} {"level":"info","ts":"2026-04-22T06:20:14.189717Z","caller":"traceutil/trace.go:171","msg":"trace[744310767] transaction","detail":"{read_only:false; response_revision:7965; number_of_response:1; }","duration":"137.142339ms","start":"2026-04-22T06:20:14.052543Z","end":"2026-04-22T06:20:14.189685Z","steps":["trace[744310767] 'process raft request' (duration: 65.609555ms)","trace[744310767] 'compare' (duration: 71.370441ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:26.346732Z","caller":"traceutil/trace.go:171","msg":"trace[999455972] transaction","detail":"{read_only:false; response_revision:8165; number_of_response:1; }","duration":"229.090467ms","start":"2026-04-22T06:20:26.117597Z","end":"2026-04-22T06:20:26.346687Z","steps":["trace[999455972] 'process raft request' (duration: 228.688339ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:26.48762Z","caller":"traceutil/trace.go:171","msg":"trace[2003260168] transaction","detail":"{read_only:false; response_revision:8166; number_of_response:1; }","duration":"135.870144ms","start":"2026-04-22T06:20:26.351706Z","end":"2026-04-22T06:20:26.487576Z","steps":["trace[2003260168] 'process raft request' (duration: 125.935325ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:26.487667Z","caller":"traceutil/trace.go:171","msg":"trace[981981273] linearizableReadLoop","detail":"{readStateIndex:8462; appliedIndex:8461; }","duration":"115.427797ms","start":"2026-04-22T06:20:26.372217Z","end":"2026-04-22T06:20:26.487645Z","steps":["trace[981981273] 'read index received' (duration: 104.744044ms)","trace[981981273] 'applied index is now lower than readState.Index' (duration: 10.682583ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:20:26.488596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.356795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-22T06:20:26.488623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.802323ms","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-22T06:20:26.48868Z","caller":"traceutil/trace.go:171","msg":"trace[1668037461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8167; }","duration":"116.494298ms","start":"2026-04-22T06:20:26.372165Z","end":"2026-04-22T06:20:26.48866Z","steps":["trace[1668037461] 'agreement among raft nodes before linearized reading' (duration: 115.552999ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:26.488699Z","caller":"traceutil/trace.go:171","msg":"trace[1707946065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8167; }","duration":"115.901025ms","start":"2026-04-22T06:20:26.37278Z","end":"2026-04-22T06:20:26.488681Z","steps":["trace[1707946065] 'agreement among raft nodes before linearized reading' (duration: 115.700121ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:20:36.756548Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6005} {"level":"info","ts":"2026-04-22T06:20:36.859328Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6005,"took":"100.637302ms","hash":1914610198,"current-db-size-bytes":56934400,"current-db-size":"57 MB","current-db-size-in-use-bytes":23191552,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-22T06:20:36.859405Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1914610198,"revision":6005,"compact-revision":2943} {"level":"info","ts":"2026-04-22T06:20:40.150306Z","caller":"traceutil/trace.go:171","msg":"trace[1912361624] transaction","detail":"{read_only:false; response_revision:8241; number_of_response:1; }","duration":"140.616057ms","start":"2026-04-22T06:20:40.009658Z","end":"2026-04-22T06:20:40.150274Z","steps":["trace[1912361624] 'process raft request' (duration: 59.979443ms)","trace[1912361624] 'compare' (duration: 80.207116ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:40.665887Z","caller":"traceutil/trace.go:171","msg":"trace[1449342543] linearizableReadLoop","detail":"{readStateIndex:8544; appliedIndex:8543; }","duration":"109.005969ms","start":"2026-04-22T06:20:40.556849Z","end":"2026-04-22T06:20:40.665855Z","steps":["trace[1449342543] 'read index received' (duration: 108.027039ms)","trace[1449342543] 'applied index is now lower than readState.Index' (duration: 977.87µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:20:40.665967Z","caller":"traceutil/trace.go:171","msg":"trace[1469388667] transaction","detail":"{read_only:false; response_revision:8243; number_of_response:1; }","duration":"129.622159ms","start":"2026-04-22T06:20:40.536322Z","end":"2026-04-22T06:20:40.665944Z","steps":["trace[1469388667] 'process raft request' (duration: 128.550517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:40.666121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.258214ms","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-22T06:20:40.666148Z","caller":"traceutil/trace.go:171","msg":"trace[1061475057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8243; }","duration":"109.353186ms","start":"2026-04-22T06:20:40.556787Z","end":"2026-04-22T06:20:40.66614Z","steps":["trace[1061475057] 'agreement among raft nodes before linearized reading' (duration: 109.201513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:20:40.666141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.097461ms","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-22T06:20:40.666214Z","caller":"traceutil/trace.go:171","msg":"trace[1268600623] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8243; }","duration":"101.244365ms","start":"2026-04-22T06:20:40.564949Z","end":"2026-04-22T06:20:40.666193Z","steps":["trace[1268600623] 'agreement among raft nodes before linearized reading' (duration: 101.063021ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:08.794991Z","caller":"traceutil/trace.go:171","msg":"trace[1135663588] linearizableReadLoop","detail":"{readStateIndex:8754; appliedIndex:8753; }","duration":"197.898388ms","start":"2026-04-22T06:21:08.597062Z","end":"2026-04-22T06:21:08.79496Z","steps":["trace[1135663588] 'read index received' (duration: 197.884068ms)","trace[1135663588] 'applied index is now lower than readState.Index' (duration: 11.77µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:21:08.795004Z","caller":"traceutil/trace.go:171","msg":"trace[65220871] transaction","detail":"{read_only:false; response_revision:8446; number_of_response:1; }","duration":"201.005299ms","start":"2026-04-22T06:21:08.593966Z","end":"2026-04-22T06:21:08.794971Z","steps":["trace[65220871] 'process raft request' (duration: 200.799365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:21:08.795159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.076441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:21:08.795183Z","caller":"traceutil/trace.go:171","msg":"trace[1451870043] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:8446; }","duration":"198.181373ms","start":"2026-04-22T06:21:08.596992Z","end":"2026-04-22T06:21:08.795174Z","steps":["trace[1451870043] 'agreement among raft nodes before linearized reading' (duration: 198.069681ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:08.985718Z","caller":"traceutil/trace.go:171","msg":"trace[1183098874] linearizableReadLoop","detail":"{readStateIndex:8755; appliedIndex:8754; }","duration":"169.768828ms","start":"2026-04-22T06:21:08.81592Z","end":"2026-04-22T06:21:08.985688Z","steps":["trace[1183098874] 'read index received' (duration: 156.242269ms)","trace[1183098874] 'applied index is now lower than readState.Index' (duration: 13.524859ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:21:08.985828Z","caller":"traceutil/trace.go:171","msg":"trace[997309944] transaction","detail":"{read_only:false; response_revision:8447; number_of_response:1; }","duration":"212.59684ms","start":"2026-04-22T06:21:08.773155Z","end":"2026-04-22T06:21:08.985752Z","steps":["trace[997309944] 'process raft request' (duration: 199.043069ms)","trace[997309944] 'compare' (duration: 13.337207ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:21:08.986026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.150476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-22T06:21:08.985996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.054354ms","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-22T06:21:08.986077Z","caller":"traceutil/trace.go:171","msg":"trace[1181100954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8447; }","duration":"160.229748ms","start":"2026-04-22T06:21:08.825833Z","end":"2026-04-22T06:21:08.986063Z","steps":["trace[1181100954] 'agreement among raft nodes before linearized reading' (duration: 160.034444ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:08.9861Z","caller":"traceutil/trace.go:171","msg":"trace[1681355106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8447; }","duration":"170.217057ms","start":"2026-04-22T06:21:08.81586Z","end":"2026-04-22T06:21:08.986077Z","steps":["trace[1681355106] 'agreement among raft nodes before linearized reading' (duration: 169.947912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:21:08.986099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.85468ms","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-22T06:21:08.9862Z","caller":"traceutil/trace.go:171","msg":"trace[1798811227] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8447; }","duration":"159.982933ms","start":"2026-04-22T06:21:08.826186Z","end":"2026-04-22T06:21:08.986169Z","steps":["trace[1798811227] 'agreement among raft nodes before linearized reading' (duration: 159.675357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:21:08.986194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.7466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5l6bl\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-22T06:21:08.986311Z","caller":"traceutil/trace.go:171","msg":"trace[101358516] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5l6bl; range_end:; response_count:1; response_revision:8447; }","duration":"139.929124ms","start":"2026-04-22T06:21:08.846354Z","end":"2026-04-22T06:21:08.986283Z","steps":["trace[101358516] 'agreement among raft nodes before linearized reading' (duration: 139.574097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:21:08.986264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.37054ms","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-22T06:21:08.986491Z","caller":"traceutil/trace.go:171","msg":"trace[1327956855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8447; }","duration":"160.616085ms","start":"2026-04-22T06:21:08.825771Z","end":"2026-04-22T06:21:08.986387Z","steps":["trace[1327956855] 'agreement among raft nodes before linearized reading' (duration: 160.125825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:21:20.985418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.82348ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T06:21:20.985652Z","caller":"traceutil/trace.go:171","msg":"trace[188408917] linearizableReadLoop","detail":"{readStateIndex:8864; appliedIndex:8862; }","duration":"139.004986ms","start":"2026-04-22T06:21:20.846631Z","end":"2026-04-22T06:21:20.985636Z","steps":["trace[188408917] 'read index received' (duration: 43.582337ms)","trace[188408917] 'applied index is now lower than readState.Index' (duration: 95.421389ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:21:20.985693Z","caller":"traceutil/trace.go:171","msg":"trace[958705209] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8550; }","duration":"299.28591ms","start":"2026-04-22T06:21:20.686365Z","end":"2026-04-22T06:21:20.985651Z","steps":["trace[958705209] 'process raft request' (duration: 145.077623ms)","trace[958705209] 'compare' (duration: 153.576104ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:21:20.985832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.20399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-22T06:21:20.985865Z","caller":"traceutil/trace.go:171","msg":"trace[1587692863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8551; }","duration":"139.278872ms","start":"2026-04-22T06:21:20.846576Z","end":"2026-04-22T06:21:20.985855Z","steps":["trace[1587692863] 'agreement among raft nodes before linearized reading' (duration: 139.118489ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:20.98612Z","caller":"traceutil/trace.go:171","msg":"trace[1131273875] transaction","detail":"{read_only:false; response_revision:8551; number_of_response:1; }","duration":"297.993585ms","start":"2026-04-22T06:21:20.688093Z","end":"2026-04-22T06:21:20.986087Z","steps":["trace[1131273875] 'process raft request' (duration: 297.440914ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:21.770936Z","caller":"traceutil/trace.go:171","msg":"trace[1120521364] transaction","detail":"{read_only:false; response_revision:8561; number_of_response:1; }","duration":"113.511617ms","start":"2026-04-22T06:21:21.657399Z","end":"2026-04-22T06:21:21.770911Z","steps":["trace[1120521364] 'process raft request' (duration: 113.364524ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:21.813606Z","caller":"traceutil/trace.go:171","msg":"trace[117319340] transaction","detail":"{read_only:false; response_revision:8562; number_of_response:1; }","duration":"150.093858ms","start":"2026-04-22T06:21:21.663493Z","end":"2026-04-22T06:21:21.813587Z","steps":["trace[117319340] 'process raft request' (duration: 149.928195ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:21.813947Z","caller":"traceutil/trace.go:171","msg":"trace[1105736063] transaction","detail":"{read_only:false; response_revision:8564; number_of_response:1; }","duration":"116.502904ms","start":"2026-04-22T06:21:21.697423Z","end":"2026-04-22T06:21:21.813926Z","steps":["trace[1105736063] 'process raft request' (duration: 116.347171ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:21:21.814007Z","caller":"traceutil/trace.go:171","msg":"trace[755069467] transaction","detail":"{read_only:false; response_revision:8563; number_of_response:1; }","duration":"135.439837ms","start":"2026-04-22T06:21:21.678552Z","end":"2026-04-22T06:21:21.813992Z","steps":["trace[755069467] 'process raft request' (duration: 134.982268ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:22:04.930125Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002481.wal"} {"level":"info","ts":"2026-04-22T06:22:21.598198Z","caller":"traceutil/trace.go:171","msg":"trace[739681896] linearizableReadLoop","detail":"{readStateIndex:9525; appliedIndex:9524; }","duration":"100.831954ms","start":"2026-04-22T06:22:21.497341Z","end":"2026-04-22T06:22:21.598173Z","steps":["trace[739681896] 'read index received' (duration: 40.862283ms)","trace[739681896] 'applied index is now lower than readState.Index' (duration: 59.968581ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:22:21.598255Z","caller":"traceutil/trace.go:171","msg":"trace[1464238558] transaction","detail":"{read_only:false; response_revision:9195; number_of_response:1; }","duration":"109.16638ms","start":"2026-04-22T06:22:21.489051Z","end":"2026-04-22T06:22:21.598218Z","steps":["trace[1464238558] 'process raft request' (duration: 49.191177ms)","trace[1464238558] 'compare' (duration: 59.808258ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:22:21.59846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.09533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5l6bl\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-22T06:22:21.598497Z","caller":"traceutil/trace.go:171","msg":"trace[1877669107] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5l6bl; range_end:; response_count:1; response_revision:9195; }","duration":"101.150831ms","start":"2026-04-22T06:22:21.497335Z","end":"2026-04-22T06:22:21.598486Z","steps":["trace[1877669107] 'agreement among raft nodes before linearized reading' (duration: 100.961127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:22:21.951747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.970033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-f8fk9\" ","response":"range_response_count:1 size:19075"} {"level":"info","ts":"2026-04-22T06:22:21.951861Z","caller":"traceutil/trace.go:171","msg":"trace[1080839477] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-rgw-ceph-a-699b8bdb59-f8fk9; range_end:; response_count:1; response_revision:9195; }","duration":"125.134577ms","start":"2026-04-22T06:22:21.8267Z","end":"2026-04-22T06:22:21.951835Z","steps":["trace[1080839477] 'range keys from in-memory index tree' (duration: 124.72613ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:22:21.951841Z","caller":"traceutil/trace.go:171","msg":"trace[1455815121] transaction","detail":"{read_only:false; response_revision:9196; number_of_response:1; }","duration":"117.632067ms","start":"2026-04-22T06:22:21.834178Z","end":"2026-04-22T06:22:21.95181Z","steps":["trace[1455815121] 'process raft request' (duration: 45.868681ms)","trace[1455815121] 'compare' (duration: 71.555282ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:22:22.107788Z","caller":"traceutil/trace.go:171","msg":"trace[968740508] transaction","detail":"{read_only:false; response_revision:9197; number_of_response:1; }","duration":"143.790366ms","start":"2026-04-22T06:22:21.963964Z","end":"2026-04-22T06:22:22.107755Z","steps":["trace[968740508] 'process raft request' (duration: 131.131705ms)","trace[968740508] 'compare' (duration: 12.525289ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:22:22.143144Z","caller":"traceutil/trace.go:171","msg":"trace[1846612417] transaction","detail":"{read_only:false; response_revision:9199; number_of_response:1; }","duration":"110.117148ms","start":"2026-04-22T06:22:22.032992Z","end":"2026-04-22T06:22:22.143109Z","steps":["trace[1846612417] 'process raft request' (duration: 110.065737ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:22:22.143351Z","caller":"traceutil/trace.go:171","msg":"trace[2009925908] transaction","detail":"{read_only:false; response_revision:9198; number_of_response:1; }","duration":"116.834952ms","start":"2026-04-22T06:22:22.026489Z","end":"2026-04-22T06:22:22.143324Z","steps":["trace[2009925908] 'process raft request' (duration: 116.286901ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:23:21.678803Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"56c01ea8fdc90390","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T06:23:21.684926Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-22T06:23:21.684997Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-22T06:25:36.763301Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8226} {"level":"info","ts":"2026-04-22T06:25:36.846634Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8226,"took":"80.922551ms","hash":1412842507,"current-db-size-bytes":56934400,"current-db-size":"57 MB","current-db-size-in-use-bytes":24838144,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-22T06:25:36.846695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1412842507,"revision":8226,"compact-revision":6005} {"level":"info","ts":"2026-04-22T06:30:36.770115Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10625} {"level":"info","ts":"2026-04-22T06:30:36.842749Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10625,"took":"70.92683ms","hash":2545702363,"current-db-size-bytes":56934400,"current-db-size":"57 MB","current-db-size-in-use-bytes":20635648,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-22T06:30:36.842799Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2545702363,"revision":10625,"compact-revision":8226}