{"level":"warn","ts":"2026-04-17T09:16:00.273854Z","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-17T09:16:00.27396Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-17T09:16:00.274029Z","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-17T09:16:00.27404Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-04-17T09:16:00.27406Z","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-17T09:16:00.274885Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-04-17T09:16:00.274974Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-17T09:16:00.278663Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.454719ms"} {"level":"info","ts":"2026-04-17T09:16:00.285493Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-04-17T09:16:00.285586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T09:16:00.285613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-04-17T09:16:00.285629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T09:16:00.285641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-04-17T09:16:00.285678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-04-17T09:16:00.29359Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T09:16:00.296416Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T09:16:00.299602Z","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-17T09:16:00.302673Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T09:16:00.305795Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T09:16:00.305927Z","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-17T09:16:00.306053Z","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-17T09:16:00.306086Z","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-17T09:16:00.309345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-04-17T09:16:00.30952Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-04-17T09:16:00.310963Z","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-17T09:16:00.311027Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-04-17T09:16:00.311061Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-04-17T09:16:00.311346Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T09:16:00.311455Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T09:16:00.88634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T09:16:00.886393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T09:16:00.88641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-04-17T09:16:00.886431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-04-17T09:16:00.886439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-04-17T09:16:00.886672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-04-17T09:16:00.886741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-04-17T09:16:00.888118Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T09:16:00.888489Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T09:16:00.888569Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T09:16:00.888801Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T09:16:00.889209Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T09:16:00.889402Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T09:16:00.890483Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T09:16:00.890661Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T09:16:00.890749Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T09:16:00.891822Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T09:16:00.902672Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-04-17T09:16:24.050239Z","caller":"traceutil/trace.go:171","msg":"trace[1313057346] linearizableReadLoop","detail":"{readStateIndex:434; appliedIndex:433; }","duration":"174.275002ms","start":"2026-04-17T09:16:23.875939Z","end":"2026-04-17T09:16:24.050214Z","steps":["trace[1313057346] 'read index received' (duration: 174.239301ms)","trace[1313057346] 'applied index is now lower than readState.Index' (duration: 34.331µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T09:16:24.050422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.451897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-04-17T09:16:24.050531Z","caller":"traceutil/trace.go:171","msg":"trace[1094372428] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:419; }","duration":"174.609612ms","start":"2026-04-17T09:16:23.875905Z","end":"2026-04-17T09:16:24.050515Z","steps":["trace[1094372428] 'agreement among raft nodes before linearized reading' (duration: 174.410636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:16:26.835033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.423506ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T09:16:26.835263Z","caller":"traceutil/trace.go:171","msg":"trace[1306431332] linearizableReadLoop","detail":"{readStateIndex:477; appliedIndex:476; }","duration":"347.412452ms","start":"2026-04-17T09:16:26.487829Z","end":"2026-04-17T09:16:26.835241Z","steps":["trace[1306431332] 'read index received' (duration: 67.766692ms)","trace[1306431332] 'applied index is now lower than readState.Index' (duration: 279.644069ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T09:16:26.835444Z","caller":"traceutil/trace.go:171","msg":"trace[1646327160] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"409.488063ms","start":"2026-04-17T09:16:26.425923Z","end":"2026-04-17T09:16:26.835411Z","steps":["trace[1646327160] 'process raft request' (duration: 129.7273ms)","trace[1646327160] 'compare' (duration: 278.101466ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T09:16:26.835525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.682761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-17T09:16:26.835788Z","caller":"traceutil/trace.go:171","msg":"trace[262381675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:462; }","duration":"347.933457ms","start":"2026-04-17T09:16:26.487799Z","end":"2026-04-17T09:16:26.835733Z","steps":["trace[262381675] 'agreement among raft nodes before linearized reading' (duration: 347.6549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:16:26.835961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:16:26.487785Z","time spent":"348.113923ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T09:16:26.835843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:16:26.425903Z","time spent":"409.740731ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T09:16:26.838302Z","caller":"traceutil/trace.go:171","msg":"trace[1644531076] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"268.851614ms","start":"2026-04-17T09:16:26.569433Z","end":"2026-04-17T09:16:26.838285Z","steps":["trace[1644531076] 'process raft request' (duration: 268.780522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:16:26.84413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.140019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T09:16:26.844193Z","caller":"traceutil/trace.go:171","msg":"trace[1542066403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:474; }","duration":"253.232152ms","start":"2026-04-17T09:16:26.590952Z","end":"2026-04-17T09:16:26.844184Z","steps":["trace[1542066403] 'agreement among raft nodes before linearized reading' (duration: 253.14301ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.844301Z","caller":"traceutil/trace.go:171","msg":"trace[1169021802] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"261.767624ms","start":"2026-04-17T09:16:26.582527Z","end":"2026-04-17T09:16:26.844294Z","steps":["trace[1169021802] 'process raft request' (duration: 261.373773ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.844294Z","caller":"traceutil/trace.go:171","msg":"trace[328006923] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"263.75976ms","start":"2026-04-17T09:16:26.580512Z","end":"2026-04-17T09:16:26.844272Z","steps":["trace[328006923] 'process raft request' (duration: 263.369169ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.844415Z","caller":"traceutil/trace.go:171","msg":"trace[790949832] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"253.716175ms","start":"2026-04-17T09:16:26.590693Z","end":"2026-04-17T09:16:26.84441Z","steps":["trace[790949832] 'process raft request' (duration: 253.227992ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.84449Z","caller":"traceutil/trace.go:171","msg":"trace[1549408071] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"274.777502ms","start":"2026-04-17T09:16:26.569702Z","end":"2026-04-17T09:16:26.84448Z","steps":["trace[1549408071] 'process raft request' (duration: 274.022251ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.844511Z","caller":"traceutil/trace.go:171","msg":"trace[1776762720] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"243.193307ms","start":"2026-04-17T09:16:26.601312Z","end":"2026-04-17T09:16:26.844506Z","steps":["trace[1776762720] 'process raft request' (duration: 242.659142ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.84461Z","caller":"traceutil/trace.go:171","msg":"trace[1021832343] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"228.173101ms","start":"2026-04-17T09:16:26.616432Z","end":"2026-04-17T09:16:26.844605Z","steps":["trace[1021832343] 'process raft request' (duration: 227.567764ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.844656Z","caller":"traceutil/trace.go:171","msg":"trace[2070377267] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"271.312204ms","start":"2026-04-17T09:16:26.573332Z","end":"2026-04-17T09:16:26.844644Z","steps":["trace[2070377267] 'process raft request' (duration: 270.44548ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.844727Z","caller":"traceutil/trace.go:171","msg":"trace[166728323] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"112.454789ms","start":"2026-04-17T09:16:26.732267Z","end":"2026-04-17T09:16:26.844721Z","steps":["trace[166728323] 'process raft request' (duration: 111.77894ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.844856Z","caller":"traceutil/trace.go:171","msg":"trace[1177672152] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"270.45523ms","start":"2026-04-17T09:16:26.574392Z","end":"2026-04-17T09:16:26.844847Z","steps":["trace[1177672152] 'process raft request' (duration: 269.40631ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.84491Z","caller":"traceutil/trace.go:171","msg":"trace[1668938687] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"270.385878ms","start":"2026-04-17T09:16:26.574487Z","end":"2026-04-17T09:16:26.844873Z","steps":["trace[1668938687] 'process raft request' (duration: 269.334759ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:26.845055Z","caller":"traceutil/trace.go:171","msg":"trace[269540104] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"266.698483ms","start":"2026-04-17T09:16:26.57835Z","end":"2026-04-17T09:16:26.845048Z","steps":["trace[269540104] 'process raft request' (duration: 265.5001ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:28.314314Z","caller":"traceutil/trace.go:171","msg":"trace[991470449] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"130.326415ms","start":"2026-04-17T09:16:28.183957Z","end":"2026-04-17T09:16:28.314283Z","steps":["trace[991470449] 'process raft request' (duration: 130.052868ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:16:33.973034Z","caller":"traceutil/trace.go:171","msg":"trace[1043500555] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"512.085042ms","start":"2026-04-17T09:16:33.460927Z","end":"2026-04-17T09:16:33.973012Z","steps":["trace[1043500555] 'process raft request' (duration: 511.822534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:16:33.973212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:16:33.460901Z","time spent":"512.256176ms","remote":"127.0.0.1:40064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T09:16:33.973367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.856937ms","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-17T09:16:33.973458Z","caller":"traceutil/trace.go:171","msg":"trace[1752079984] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"468.435474ms","start":"2026-04-17T09:16:33.504492Z","end":"2026-04-17T09:16:33.972927Z","steps":["trace[1752079984] 'read index received' (duration: 468.194348ms)","trace[1752079984] 'applied index is now lower than readState.Index' (duration: 240.176µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T09:16:33.973508Z","caller":"traceutil/trace.go:171","msg":"trace[734038893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:572; }","duration":"469.038692ms","start":"2026-04-17T09:16:33.504443Z","end":"2026-04-17T09:16:33.973481Z","steps":["trace[734038893] 'agreement among raft nodes before linearized reading' (duration: 468.690561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:16:33.973563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.172096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T09:16:33.973573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:16:33.504429Z","time spent":"469.127905ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T09:16:33.973611Z","caller":"traceutil/trace.go:171","msg":"trace[3696039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"384.220597ms","start":"2026-04-17T09:16:33.589377Z","end":"2026-04-17T09:16:33.973597Z","steps":["trace[3696039] 'agreement among raft nodes before linearized reading' (duration: 384.150975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:16:33.973663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:16:33.589317Z","time spent":"384.33302ms","remote":"127.0.0.1:39842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T09:16:33.973973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.293351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p4kgl\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-17T09:16:33.974036Z","caller":"traceutil/trace.go:171","msg":"trace[1253011927] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p4kgl; range_end:; response_count:1; response_revision:572; }","duration":"285.392013ms","start":"2026-04-17T09:16:33.688627Z","end":"2026-04-17T09:16:33.974019Z","steps":["trace[1253011927] 'agreement among raft nodes before linearized reading' (duration: 285.212198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:16:33.974127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.803312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-17T09:16:33.9742Z","caller":"traceutil/trace.go:171","msg":"trace[1213611763] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:572; }","duration":"128.919166ms","start":"2026-04-17T09:16:33.845261Z","end":"2026-04-17T09:16:33.97418Z","steps":["trace[1213611763] 'agreement among raft nodes before linearized reading' (duration: 128.375821ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:17:23.655306Z","caller":"traceutil/trace.go:171","msg":"trace[1773913348] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"168.470701ms","start":"2026-04-17T09:17:23.486812Z","end":"2026-04-17T09:17:23.655283Z","steps":["trace[1773913348] 'process raft request' (duration: 168.073489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:17:24.009607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.516901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-17T09:17:24.009689Z","caller":"traceutil/trace.go:171","msg":"trace[2069908469] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:950; }","duration":"160.648035ms","start":"2026-04-17T09:17:23.849021Z","end":"2026-04-17T09:17:24.009669Z","steps":["trace[2069908469] 'range keys from in-memory index tree' (duration: 160.322085ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:17:24.093947Z","caller":"traceutil/trace.go:171","msg":"trace[1836456417] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"219.304976ms","start":"2026-04-17T09:17:23.874619Z","end":"2026-04-17T09:17:24.093924Z","steps":["trace[1836456417] 'process raft request' (duration: 219.168242ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:17:24.132658Z","caller":"traceutil/trace.go:171","msg":"trace[1902304176] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"157.590497ms","start":"2026-04-17T09:17:23.975043Z","end":"2026-04-17T09:17:24.132634Z","steps":["trace[1902304176] 'process raft request' (duration: 156.974588ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:17:44.575526Z","caller":"traceutil/trace.go:171","msg":"trace[1583881708] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"101.149868ms","start":"2026-04-17T09:17:44.47435Z","end":"2026-04-17T09:17:44.5755Z","steps":["trace[1583881708] 'process raft request' (duration: 101.026204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:17:44.870732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.86446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T09:17:44.870824Z","caller":"traceutil/trace.go:171","msg":"trace[1258793578] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"187.453787ms","start":"2026-04-17T09:17:44.683344Z","end":"2026-04-17T09:17:44.870798Z","steps":["trace[1258793578] 'process raft request' (duration: 34.195176ms)","trace[1258793578] 'compare' (duration: 152.628343ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T09:18:02.154061Z","caller":"traceutil/trace.go:171","msg":"trace[1076645678] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"278.406462ms","start":"2026-04-17T09:18:01.875638Z","end":"2026-04-17T09:18:02.154044Z","steps":["trace[1076645678] 'process raft request' (duration: 278.298229ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:18:02.416132Z","caller":"traceutil/trace.go:171","msg":"trace[407245853] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"150.369578ms","start":"2026-04-17T09:18:02.265728Z","end":"2026-04-17T09:18:02.416097Z","steps":["trace[407245853] 'process raft request' (duration: 145.486907ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:18:15.582917Z","caller":"traceutil/trace.go:171","msg":"trace[644537439] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"191.076543ms","start":"2026-04-17T09:18:15.391824Z","end":"2026-04-17T09:18:15.582901Z","steps":["trace[644537439] 'process raft request' (duration: 190.774544ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:18:19.183148Z","caller":"traceutil/trace.go:171","msg":"trace[1359302193] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"432.635707ms","start":"2026-04-17T09:18:18.750494Z","end":"2026-04-17T09:18:19.18313Z","steps":["trace[1359302193] 'process raft request' (duration: 432.528744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:18:19.183258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:18:18.750478Z","time spent":"432.722641ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T09:18:19.283941Z","caller":"traceutil/trace.go:171","msg":"trace[167697174] linearizableReadLoop","detail":"{readStateIndex:1257; appliedIndex:1255; }","duration":"156.998617ms","start":"2026-04-17T09:18:19.126909Z","end":"2026-04-17T09:18:19.283908Z","steps":["trace[167697174] 'read index received' (duration: 56.131804ms)","trace[167697174] 'applied index is now lower than readState.Index' (duration: 100.864623ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T09:18:19.284267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.321507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T09:18:19.284353Z","caller":"traceutil/trace.go:171","msg":"trace[1683323426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1210; }","duration":"157.45187ms","start":"2026-04-17T09:18:19.126877Z","end":"2026-04-17T09:18:19.284329Z","steps":["trace[1683323426] 'agreement among raft nodes before linearized reading' (duration: 157.183703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:18:19.669179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.073555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T09:18:19.669357Z","caller":"traceutil/trace.go:171","msg":"trace[1156115367] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"172.959643ms","start":"2026-04-17T09:18:19.496369Z","end":"2026-04-17T09:18:19.669329Z","steps":["trace[1156115367] 'process raft request' (duration: 32.654583ms)","trace[1156115367] 'compare' (duration: 139.889479ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T09:18:19.669394Z","caller":"traceutil/trace.go:171","msg":"trace[933148580] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"172.750057ms","start":"2026-04-17T09:18:19.496611Z","end":"2026-04-17T09:18:19.669361Z","steps":["trace[933148580] 'process raft request' (duration: 172.654565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:18:20.287064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.633916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T09:18:20.287234Z","caller":"traceutil/trace.go:171","msg":"trace[1737010] linearizableReadLoop","detail":"{readStateIndex:1265; appliedIndex:1263; }","duration":"267.374403ms","start":"2026-04-17T09:18:20.019845Z","end":"2026-04-17T09:18:20.28722Z","steps":["trace[1737010] 'read index received' (duration: 116.540572ms)","trace[1737010] 'applied index is now lower than readState.Index' (duration: 150.833191ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T09:18:20.287322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.480376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T09:18:20.287349Z","caller":"traceutil/trace.go:171","msg":"trace[146364148] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:0; response_revision:1218; }","duration":"267.532638ms","start":"2026-04-17T09:18:20.01981Z","end":"2026-04-17T09:18:20.287343Z","steps":["trace[146364148] 'agreement among raft nodes before linearized reading' (duration: 267.474816ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:18:20.287346Z","caller":"traceutil/trace.go:171","msg":"trace[914916067] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"613.697013ms","start":"2026-04-17T09:18:19.673591Z","end":"2026-04-17T09:18:20.287288Z","steps":["trace[914916067] 'process raft request' (duration: 335.81996ms)","trace[914916067] 'compare' (duration: 277.292517ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T09:18:20.287302Z","caller":"traceutil/trace.go:171","msg":"trace[1016279109] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"613.212799ms","start":"2026-04-17T09:18:19.674069Z","end":"2026-04-17T09:18:20.287282Z","steps":["trace[1016279109] 'process raft request' (duration: 613.078475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:18:20.28751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:18:19.674056Z","time spent":"613.427095ms","remote":"127.0.0.1:39922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":881,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T09:18:20.28771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:18:19.673574Z","time spent":"614.040603ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T09:18:20.6378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.259752ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T09:18:20.637939Z","caller":"traceutil/trace.go:171","msg":"trace[1214767045] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"344.305852ms","start":"2026-04-17T09:18:20.293614Z","end":"2026-04-17T09:18:20.63792Z","steps":["trace[1214767045] 'process raft request' (duration: 134.835734ms)","trace[1214767045] 'compare' (duration: 209.133489ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T09:18:20.63823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:18:20.293593Z","time spent":"344.597271ms","remote":"127.0.0.1:40018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1475,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T09:18:20.659339Z","caller":"traceutil/trace.go:171","msg":"trace[1653667828] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1267; }","duration":"140.696563ms","start":"2026-04-17T09:18:20.518628Z","end":"2026-04-17T09:18:20.659324Z","steps":["trace[1653667828] 'read index received' (duration: 140.61563ms)","trace[1653667828] 'applied index is now lower than readState.Index' (duration: 80.283µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T09:18:20.659416Z","caller":"traceutil/trace.go:171","msg":"trace[1159498551] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"187.031227ms","start":"2026-04-17T09:18:20.472376Z","end":"2026-04-17T09:18:20.659407Z","steps":["trace[1159498551] 'process raft request' (duration: 186.856362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:18:20.659537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.896168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T09:18:20.65957Z","caller":"traceutil/trace.go:171","msg":"trace[1525346649] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1221; }","duration":"140.97576ms","start":"2026-04-17T09:18:20.518585Z","end":"2026-04-17T09:18:20.65956Z","steps":["trace[1525346649] 'agreement among raft nodes before linearized reading' (duration: 140.910898ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:18:21.333611Z","caller":"traceutil/trace.go:171","msg":"trace[1561177514] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"141.142624ms","start":"2026-04-17T09:18:21.192436Z","end":"2026-04-17T09:18:21.333578Z","steps":["trace[1561177514] 'process raft request' (duration: 140.933528ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:18:37.832251Z","caller":"traceutil/trace.go:171","msg":"trace[1509161048] linearizableReadLoop","detail":"{readStateIndex:1399; appliedIndex:1398; }","duration":"385.50726ms","start":"2026-04-17T09:18:37.446707Z","end":"2026-04-17T09:18:37.832214Z","steps":["trace[1509161048] 'read index received' (duration: 385.265343ms)","trace[1509161048] 'applied index is now lower than readState.Index' (duration: 240.217µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T09:18:37.832632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.895941ms","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-17T09:18:37.832698Z","caller":"traceutil/trace.go:171","msg":"trace[1829276422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1349; }","duration":"386.012464ms","start":"2026-04-17T09:18:37.446669Z","end":"2026-04-17T09:18:37.832682Z","steps":["trace[1829276422] 'agreement among raft nodes before linearized reading' (duration: 385.811039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:18:37.832793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:18:37.446654Z","time spent":"386.121297ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T09:18:37.832902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.003679ms","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-17T09:18:37.833098Z","caller":"traceutil/trace.go:171","msg":"trace[1549935039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1349; }","duration":"241.242986ms","start":"2026-04-17T09:18:37.591832Z","end":"2026-04-17T09:18:37.833075Z","steps":["trace[1549935039] 'agreement among raft nodes before linearized reading' (duration: 240.740361ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T09:18:37.833087Z","caller":"traceutil/trace.go:171","msg":"trace[1532413911] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"415.993102ms","start":"2026-04-17T09:18:37.416402Z","end":"2026-04-17T09:18:37.832395Z","steps":["trace[1532413911] 'process raft request' (duration: 415.56168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T09:18:37.833279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T09:18:37.416391Z","time spent":"416.798175ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T09:18:37.962248Z","caller":"traceutil/trace.go:171","msg":"trace[1956913885] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"124.386595ms","start":"2026-04-17T09:18:37.837833Z","end":"2026-04-17T09:18:37.96222Z","steps":["trace[1956913885] 'process raft request' (duration: 49.905826ms)","trace[1956913885] 'compare' (duration: 74.16575ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T09:18:37.962403Z","caller":"traceutil/trace.go:171","msg":"trace[283715972] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"124.491588ms","start":"2026-04-17T09:18:37.837892Z","end":"2026-04-17T09:18:37.962383Z","steps":["trace[283715972] 'process raft request' (duration: 124.19634ms)"],"step_count":1}