{"level":"warn","ts":"2026-04-09T22:24:03.427018Z","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-09T22:24:03.427102Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250: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-09T22:24:03.427201Z","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-09T22:24:03.427213Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-09T22:24:03.427228Z","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-09T22:24:03.42796Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-04-09T22:24:03.428047Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250: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-09T22:24:03.509441Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"81.091212ms"} {"level":"info","ts":"2026-04-09T22:24:03.576303Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-04-09T22:24:03.576414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T22:24:03.576441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-04-09T22:24:03.576452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T22:24:03.576464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-04-09T22:24:03.576505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-04-09T22:24:03.637163Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T22:24:03.64588Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T22:24:03.658918Z","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-09T22:24:03.684314Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T22:24:03.697563Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T22:24:03.697738Z","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-09T22:24:03.697905Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T22:24:03.697948Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T22:24:03.698381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-04-09T22:24:03.698496Z","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-09T22:24:03.698545Z","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-09T22:24:03.698552Z","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-09T22:24:03.698769Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-09T22:24:03.700288Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-09T22:24:03.70034Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-09T22:24:03.976696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T22:24:03.976763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T22:24:03.976788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-04-09T22:24:03.976809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-04-09T22:24:03.976999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-09T22:24:03.977029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-04-09T22:24:03.977043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-09T22:24:03.979868Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:24:03.981068Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T22:24:03.981085Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T22:24:03.981729Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T22:24:03.981757Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T22:24:03.981402Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T22:24:03.982095Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:24:03.982181Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:24:03.982342Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:24:03.984526Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T22:24:03.985379Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-04-09T22:24:06.391036Z","caller":"traceutil/trace.go:171","msg":"trace[2109721060] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"203.748623ms","start":"2026-04-09T22:24:06.187257Z","end":"2026-04-09T22:24:06.391006Z","steps":["trace[2109721060] 'read index received' (duration: 203.520019ms)","trace[2109721060] 'applied index is now lower than readState.Index' (duration: 226.804µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:24:06.391204Z","caller":"traceutil/trace.go:171","msg":"trace[1559976780] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"207.05477ms","start":"2026-04-09T22:24:06.184138Z","end":"2026-04-09T22:24:06.391193Z","steps":["trace[1559976780] 'process raft request' (duration: 206.681935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:06.391634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.968977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-09T22:24:06.391794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.482624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-09T22:24:06.39187Z","caller":"traceutil/trace.go:171","msg":"trace[684480478] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"121.300172ms","start":"2026-04-09T22:24:06.270531Z","end":"2026-04-09T22:24:06.391831Z","steps":["trace[684480478] 'agreement among raft nodes before linearized reading' (duration: 120.757764ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:24:06.391954Z","caller":"traceutil/trace.go:171","msg":"trace[1172225399] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:72; }","duration":"204.689096ms","start":"2026-04-09T22:24:06.187232Z","end":"2026-04-09T22:24:06.391921Z","steps":["trace[1172225399] 'agreement among raft nodes before linearized reading' (duration: 204.097227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:39.297315Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185522448628935,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-09T22:24:39.373624Z","caller":"traceutil/trace.go:171","msg":"trace[540782078] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"618.470805ms","start":"2026-04-09T22:24:38.755127Z","end":"2026-04-09T22:24:39.373598Z","steps":["trace[540782078] 'process raft request' (duration: 617.165374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:39.374157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:38.755105Z","time spent":"618.586476ms","remote":"127.0.0.1:54160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T22:24:39.863339Z","caller":"traceutil/trace.go:171","msg":"trace[415704523] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"566.920727ms","start":"2026-04-09T22:24:39.296374Z","end":"2026-04-09T22:24:39.863295Z","steps":["trace[415704523] 'process raft request' (duration: 566.586605ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:24:39.863528Z","caller":"traceutil/trace.go:171","msg":"trace[1776858650] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:589; }","duration":"1.067001314s","start":"2026-04-09T22:24:38.796446Z","end":"2026-04-09T22:24:39.863448Z","steps":["trace[1776858650] 'read index received' (duration: 575.689536ms)","trace[1776858650] 'applied index is now lower than readState.Index' (duration: 491.309688ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:24:39.863639Z","caller":"traceutil/trace.go:171","msg":"trace[1797301714] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"514.435695ms","start":"2026-04-09T22:24:39.349171Z","end":"2026-04-09T22:24:39.863607Z","steps":["trace[1797301714] 'process raft request' (duration: 514.041932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:39.863669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:39.296356Z","time spent":"567.177479ms","remote":"127.0.0.1:54256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T22:24:39.863794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067319586s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-09T22:24:39.86383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:39.34914Z","time spent":"514.596886ms","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T22:24:39.863882Z","caller":"traceutil/trace.go:171","msg":"trace[359486225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"1.067457527s","start":"2026-04-09T22:24:38.796405Z","end":"2026-04-09T22:24:39.863862Z","steps":["trace[359486225] 'agreement among raft nodes before linearized reading' (duration: 1.067240795s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:39.863933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:38.796384Z","time spent":"1.067540679s","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-09T22:24:40.2442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.617562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-09T22:24:40.24438Z","caller":"traceutil/trace.go:171","msg":"trace[1660075953] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"373.721067ms","start":"2026-04-09T22:24:39.870643Z","end":"2026-04-09T22:24:40.244364Z","steps":["trace[1660075953] 'process raft request' (duration: 373.655147ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:24:40.244516Z","caller":"traceutil/trace.go:171","msg":"trace[786655369] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"380.928591ms","start":"2026-04-09T22:24:39.863562Z","end":"2026-04-09T22:24:40.24449Z","steps":["trace[786655369] 'read index received' (duration: 51.803296ms)","trace[786655369] 'applied index is now lower than readState.Index' (duration: 329.123115ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:24:40.244562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:39.870623Z","time spent":"373.885198ms","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T22:24:40.244684Z","caller":"traceutil/trace.go:171","msg":"trace[1151777774] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"813.616262ms","start":"2026-04-09T22:24:39.431056Z","end":"2026-04-09T22:24:40.244672Z","steps":["trace[1151777774] 'process raft request' (duration: 484.297724ms)","trace[1151777774] 'compare' (duration: 328.294849ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:24:40.244732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:39.431033Z","time spent":"813.679492ms","remote":"127.0.0.1:54602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-09T22:24:40.244705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.199933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T22:24:40.244787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.169011ms","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-09T22:24:40.244798Z","caller":"traceutil/trace.go:171","msg":"trace[397197797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"531.341134ms","start":"2026-04-09T22:24:39.713426Z","end":"2026-04-09T22:24:40.244767Z","steps":["trace[397197797] 'agreement among raft nodes before linearized reading' (duration: 531.157912ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:24:40.244836Z","caller":"traceutil/trace.go:171","msg":"trace[1397974004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"602.269901ms","start":"2026-04-09T22:24:39.642551Z","end":"2026-04-09T22:24:40.244821Z","steps":["trace[1397974004] 'agreement among raft nodes before linearized reading' (duration: 602.082049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:40.244845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:39.713407Z","time spent":"531.429244ms","remote":"127.0.0.1:54080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-09T22:24:40.244876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:39.64253Z","time spent":"602.337811ms","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-09T22:24:40.244904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.247058ms","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-09T22:24:40.245022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.254455367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mkcst\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-09T22:24:40.245029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.859036ms","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-09T22:24:40.245047Z","caller":"traceutil/trace.go:171","msg":"trace[2144586050] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:575; }","duration":"268.42605ms","start":"2026-04-09T22:24:39.976609Z","end":"2026-04-09T22:24:40.245035Z","steps":["trace[2144586050] 'agreement among raft nodes before linearized reading' (duration: 268.200257ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:24:40.245071Z","caller":"traceutil/trace.go:171","msg":"trace[199636778] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mkcst; range_end:; response_count:1; response_revision:575; }","duration":"1.254544138s","start":"2026-04-09T22:24:38.990509Z","end":"2026-04-09T22:24:40.245053Z","steps":["trace[199636778] 'agreement among raft nodes before linearized reading' (duration: 1.254414377s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:40.24511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:38.990462Z","time spent":"1.254641398s","remote":"127.0.0.1:54262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-mkcst\" "} {"level":"info","ts":"2026-04-09T22:24:40.245118Z","caller":"traceutil/trace.go:171","msg":"trace[1279914534] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"385.993947ms","start":"2026-04-09T22:24:39.8591Z","end":"2026-04-09T22:24:40.245094Z","steps":["trace[1279914534] 'agreement among raft nodes before linearized reading' (duration: 385.433012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:40.245173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:24:39.859067Z","time spent":"386.093408ms","remote":"127.0.0.1:54352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-09T22:24:40.382112Z","caller":"traceutil/trace.go:171","msg":"trace[329778092] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"132.394087ms","start":"2026-04-09T22:24:40.249698Z","end":"2026-04-09T22:24:40.382092Z","steps":["trace[329778092] 'process raft request' (duration: 127.855277ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:24:40.382426Z","caller":"traceutil/trace.go:171","msg":"trace[89024330] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"132.040266ms","start":"2026-04-09T22:24:40.250365Z","end":"2026-04-09T22:24:40.382406Z","steps":["trace[89024330] 'process raft request' (duration: 131.689102ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:24:40.382548Z","caller":"traceutil/trace.go:171","msg":"trace[1626004024] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:594; }","duration":"127.08313ms","start":"2026-04-09T22:24:40.255442Z","end":"2026-04-09T22:24:40.382526Z","steps":["trace[1626004024] 'read index received' (duration: 60.250446ms)","trace[1626004024] 'applied index is now lower than readState.Index' (duration: 66.831584ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:24:40.382713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.252122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:24:40.382756Z","caller":"traceutil/trace.go:171","msg":"trace[1270372775] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"123.184026ms","start":"2026-04-09T22:24:40.259558Z","end":"2026-04-09T22:24:40.382742Z","steps":["trace[1270372775] 'process raft request' (duration: 122.849834ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:24:40.382759Z","caller":"traceutil/trace.go:171","msg":"trace[1446904737] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:579; }","duration":"127.327092ms","start":"2026-04-09T22:24:40.255417Z","end":"2026-04-09T22:24:40.382744Z","steps":["trace[1446904737] 'agreement among raft nodes before linearized reading' (duration: 127.202501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:25:34.838446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.05345ms","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-09T22:25:34.838537Z","caller":"traceutil/trace.go:171","msg":"trace[300835469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1171; }","duration":"144.195944ms","start":"2026-04-09T22:25:34.694317Z","end":"2026-04-09T22:25:34.838513Z","steps":["trace[300835469] 'range keys from in-memory index tree' (duration: 143.787142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:25:34.838822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.23587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:25:34.838929Z","caller":"traceutil/trace.go:171","msg":"trace[1091992167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1171; }","duration":"124.418195ms","start":"2026-04-09T22:25:34.714484Z","end":"2026-04-09T22:25:34.838903Z","steps":["trace[1091992167] 'range keys from in-memory index tree' (duration: 124.155518ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:26:18.930006Z","caller":"traceutil/trace.go:171","msg":"trace[141653501] linearizableReadLoop","detail":"{readStateIndex:1867; appliedIndex:1866; }","duration":"141.93085ms","start":"2026-04-09T22:26:18.788056Z","end":"2026-04-09T22:26:18.929987Z","steps":["trace[141653501] 'read index received' (duration: 141.771737ms)","trace[141653501] 'applied index is now lower than readState.Index' (duration: 158.453µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:26:18.930111Z","caller":"traceutil/trace.go:171","msg":"trace[1440839043] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"142.154704ms","start":"2026-04-09T22:26:18.787946Z","end":"2026-04-09T22:26:18.9301Z","steps":["trace[1440839043] 'process raft request' (duration: 141.92926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:26:18.930315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.239856ms","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-09T22:26:18.930345Z","caller":"traceutil/trace.go:171","msg":"trace[1588463026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1813; }","duration":"142.307697ms","start":"2026-04-09T22:26:18.788029Z","end":"2026-04-09T22:26:18.930337Z","steps":["trace[1588463026] 'agreement among raft nodes before linearized reading' (duration: 142.197505ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:27:01.376802Z","caller":"traceutil/trace.go:171","msg":"trace[1964992712] linearizableReadLoop","detail":"{readStateIndex:2224; appliedIndex:2222; }","duration":"149.899978ms","start":"2026-04-09T22:27:01.226877Z","end":"2026-04-09T22:27:01.376777Z","steps":["trace[1964992712] 'read index received' (duration: 117.143519ms)","trace[1964992712] 'applied index is now lower than readState.Index' (duration: 32.755489ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:27:01.376982Z","caller":"traceutil/trace.go:171","msg":"trace[243992265] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"171.229668ms","start":"2026-04-09T22:27:01.205717Z","end":"2026-04-09T22:27:01.376946Z","steps":["trace[243992265] 'process raft request' (duration: 171.010685ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:27:01.377349Z","caller":"traceutil/trace.go:171","msg":"trace[1278165403] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"173.292807ms","start":"2026-04-09T22:27:01.204035Z","end":"2026-04-09T22:27:01.377328Z","steps":["trace[1278165403] 'process raft request' (duration: 139.971121ms)","trace[1278165403] 'compare' (duration: 32.571935ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:27:01.377593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.704948ms","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-09T22:27:01.377641Z","caller":"traceutil/trace.go:171","msg":"trace[2058926717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2153; }","duration":"150.768009ms","start":"2026-04-09T22:27:01.226859Z","end":"2026-04-09T22:27:01.377627Z","steps":["trace[2058926717] 'agreement among raft nodes before linearized reading' (duration: 150.07369ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:27:43.131294Z","caller":"traceutil/trace.go:171","msg":"trace[891132543] transaction","detail":"{read_only:false; response_revision:2538; number_of_response:1; }","duration":"100.163143ms","start":"2026-04-09T22:27:43.031113Z","end":"2026-04-09T22:27:43.131276Z","steps":["trace[891132543] 'process raft request' (duration: 100.04005ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:27:44.008458Z","caller":"traceutil/trace.go:171","msg":"trace[1553816473] linearizableReadLoop","detail":"{readStateIndex:2640; appliedIndex:2639; }","duration":"102.46023ms","start":"2026-04-09T22:27:43.905969Z","end":"2026-04-09T22:27:44.008429Z","steps":["trace[1553816473] 'read index received' (duration: 102.192657ms)","trace[1553816473] 'applied index is now lower than readState.Index' (duration: 266.563µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:27:44.008655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.603971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:27:44.008718Z","caller":"traceutil/trace.go:171","msg":"trace[1571283331] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2548; }","duration":"102.754193ms","start":"2026-04-09T22:27:43.905945Z","end":"2026-04-09T22:27:44.008699Z","steps":["trace[1571283331] 'agreement among raft nodes before linearized reading' (duration: 102.594061ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:27:44.008739Z","caller":"traceutil/trace.go:171","msg":"trace[590309700] transaction","detail":"{read_only:false; response_revision:2548; number_of_response:1; }","duration":"108.860907ms","start":"2026-04-09T22:27:43.899843Z","end":"2026-04-09T22:27:44.008704Z","steps":["trace[590309700] 'process raft request' (duration: 108.385531ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:28:11.467026Z","caller":"traceutil/trace.go:171","msg":"trace[1432080823] transaction","detail":"{read_only:false; response_revision:2735; number_of_response:1; }","duration":"119.860216ms","start":"2026-04-09T22:28:11.347127Z","end":"2026-04-09T22:28:11.466987Z","steps":["trace[1432080823] 'process raft request' (duration: 119.623863ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:28:11.628746Z","caller":"traceutil/trace.go:171","msg":"trace[689227701] linearizableReadLoop","detail":"{readStateIndex:2839; appliedIndex:2838; }","duration":"102.314394ms","start":"2026-04-09T22:28:11.526398Z","end":"2026-04-09T22:28:11.628713Z","steps":["trace[689227701] 'read index received' (duration: 102.078942ms)","trace[689227701] 'applied index is now lower than readState.Index' (duration: 227.782µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:28:11.628902Z","caller":"traceutil/trace.go:171","msg":"trace[787719594] transaction","detail":"{read_only:false; response_revision:2736; number_of_response:1; }","duration":"154.200119ms","start":"2026-04-09T22:28:11.474624Z","end":"2026-04-09T22:28:11.628824Z","steps":["trace[787719594] 'process raft request' (duration: 153.876456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:11.629243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.825289ms","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-09T22:28:11.629423Z","caller":"traceutil/trace.go:171","msg":"trace[182242514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2736; }","duration":"103.057342ms","start":"2026-04-09T22:28:11.526341Z","end":"2026-04-09T22:28:11.629399Z","steps":["trace[182242514] 'agreement among raft nodes before linearized reading' (duration: 102.583756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:30:35.38696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.27981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-924f9619-7b37-4669-b775-fbc65e1c95e6\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-09T22:30:35.387063Z","caller":"traceutil/trace.go:171","msg":"trace[977034849] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-924f9619-7b37-4669-b775-fbc65e1c95e6; range_end:; response_count:1; response_revision:4456; }","duration":"119.455584ms","start":"2026-04-09T22:30:35.267584Z","end":"2026-04-09T22:30:35.387039Z","steps":["trace[977034849] 'range keys from in-memory index tree' (duration: 119.092586ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:30:35.981336Z","caller":"traceutil/trace.go:171","msg":"trace[8151403] linearizableReadLoop","detail":"{readStateIndex:4649; appliedIndex:4648; }","duration":"227.09148ms","start":"2026-04-09T22:30:35.754202Z","end":"2026-04-09T22:30:35.981294Z","steps":["trace[8151403] 'read index received' (duration: 226.784713ms)","trace[8151403] 'applied index is now lower than readState.Index' (duration: 305.727µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:30:35.981352Z","caller":"traceutil/trace.go:171","msg":"trace[184340889] transaction","detail":"{read_only:false; response_revision:4460; number_of_response:1; }","duration":"232.924413ms","start":"2026-04-09T22:30:35.748401Z","end":"2026-04-09T22:30:35.981326Z","steps":["trace[184340889] 'process raft request' (duration: 232.644906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:30:35.981551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.320845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-65547dbf45-tb6v5.18a4d0e4ea69c89e\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-09T22:30:35.981985Z","caller":"traceutil/trace.go:171","msg":"trace[1865058377] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-65547dbf45-tb6v5.18a4d0e4ea69c89e; range_end:; response_count:1; response_revision:4460; }","duration":"227.778034ms","start":"2026-04-09T22:30:35.754178Z","end":"2026-04-09T22:30:35.981956Z","steps":["trace[1865058377] 'agreement among raft nodes before linearized reading' (duration: 227.224413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:30:48.508156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.451683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-09T22:30:48.508261Z","caller":"traceutil/trace.go:171","msg":"trace[850126355] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:4646; }","duration":"200.563096ms","start":"2026-04-09T22:30:48.307677Z","end":"2026-04-09T22:30:48.50824Z","steps":["trace[850126355] 'range keys from in-memory index tree' (duration: 200.279409ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:30:48.565122Z","caller":"traceutil/trace.go:171","msg":"trace[686756107] linearizableReadLoop","detail":"{readStateIndex:4844; appliedIndex:4843; }","duration":"114.920246ms","start":"2026-04-09T22:30:48.450166Z","end":"2026-04-09T22:30:48.565087Z","steps":["trace[686756107] 'read index received' (duration: 114.670112ms)","trace[686756107] 'applied index is now lower than readState.Index' (duration: 248.594µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:30:48.565218Z","caller":"traceutil/trace.go:171","msg":"trace[1813691772] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"121.956377ms","start":"2026-04-09T22:30:48.443225Z","end":"2026-04-09T22:30:48.565182Z","steps":["trace[1813691772] 'process raft request' (duration: 121.634351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:30:48.565378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.190711ms","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-09T22:30:48.565476Z","caller":"traceutil/trace.go:171","msg":"trace[1360717483] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4647; }","duration":"115.311924ms","start":"2026-04-09T22:30:48.450141Z","end":"2026-04-09T22:30:48.565453Z","steps":["trace[1360717483] 'agreement among raft nodes before linearized reading' (duration: 115.06623ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:30:48.828369Z","caller":"traceutil/trace.go:171","msg":"trace[1480959100] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"103.746782ms","start":"2026-04-09T22:30:48.7246Z","end":"2026-04-09T22:30:48.828347Z","steps":["trace[1480959100] 'process raft request' (duration: 103.357224ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:34:04.012925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3180} {"level":"info","ts":"2026-04-09T22:34:04.105123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3180,"took":"90.928516ms","hash":2638333670,"current-db-size-bytes":58519552,"current-db-size":"58 MB","current-db-size-in-use-bytes":32088064,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-09T22:34:04.105176Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2638333670,"revision":3180,"compact-revision":-1}