{"level":"warn","ts":"2026-02-25T19:24:24.608447Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T19:24:24.608544Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-02-25T19:24:24.608622Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-25T19:24:24.608639Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]}
{"level":"info","ts":"2026-02-25T19:24:24.608665Z","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-02-25T19:24:24.609402Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]}
{"level":"info","ts":"2026-02-25T19:24:24.609489Z","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.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49: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-02-25T19:24:24.613331Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.59595ms"}
{"level":"info","ts":"2026-02-25T19:24:24.620751Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"}
{"level":"info","ts":"2026-02-25T19:24:24.620806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T19:24:24.620822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"}
{"level":"info","ts":"2026-02-25T19:24:24.620832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T19:24:24.620841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"}
{"level":"info","ts":"2026-02-25T19:24:24.620872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"}
{"level":"warn","ts":"2026-02-25T19:24:24.627444Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T19:24:24.628901Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T19:24:24.631717Z","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-02-25T19:24:24.635551Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T19:24:24.63599Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T19:24:24.636007Z","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-02-25T19:24:24.639229Z","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-02-25T19:24:24.639271Z","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-02-25T19:24:24.640068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"}
{"level":"info","ts":"2026-02-25T19:24:24.640139Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]}
{"level":"info","ts":"2026-02-25T19:24:24.641218Z","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-02-25T19:24:24.641252Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"}
{"level":"info","ts":"2026-02-25T19:24:24.641278Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"}
{"level":"info","ts":"2026-02-25T19:24:24.641518Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T19:24:24.641564Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T19:24:24.822819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T19:24:24.822881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T19:24:24.822913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"}
{"level":"info","ts":"2026-02-25T19:24:24.822933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"}
{"level":"info","ts":"2026-02-25T19:24:24.822945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"}
{"level":"info","ts":"2026-02-25T19:24:24.822957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"}
{"level":"info","ts":"2026-02-25T19:24:24.822972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"}
{"level":"info","ts":"2026-02-25T19:24:24.830872Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:24:24.839036Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:24:24.839027Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T19:24:24.839176Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T19:24:24.839528Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T19:24:24.839602Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T19:24:24.842012Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T19:24:24.842147Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"}
{"level":"info","ts":"2026-02-25T19:24:24.842769Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:24:24.843105Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:24:24.843286Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T19:24:41.206003Z","caller":"traceutil/trace.go:171","msg":"trace[207785420] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"103.152314ms","start":"2026-02-25T19:24:41.102827Z","end":"2026-02-25T19:24:41.205979Z","steps":["trace[207785420] 'process raft request'  (duration: 103.029004ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:53.154406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.459022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:24:53.154544Z","caller":"traceutil/trace.go:171","msg":"trace[1646669966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:462; }","duration":"590.629925ms","start":"2026-02-25T19:24:52.563894Z","end":"2026-02-25T19:24:53.154524Z","steps":["trace[1646669966] 'range keys from in-memory index tree'  (duration: 590.402877ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:53.154529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.586595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"}
{"level":"warn","ts":"2026-02-25T19:24:53.154555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.129628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"}
{"level":"info","ts":"2026-02-25T19:24:53.154636Z","caller":"traceutil/trace.go:171","msg":"trace[189586328] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:462; }","duration":"612.729407ms","start":"2026-02-25T19:24:52.54187Z","end":"2026-02-25T19:24:53.1546Z","steps":["trace[189586328] 'range keys from in-memory index tree'  (duration: 612.496598ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:24:53.154662Z","caller":"traceutil/trace.go:171","msg":"trace[1440682883] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:462; }","duration":"613.286951ms","start":"2026-02-25T19:24:52.541354Z","end":"2026-02-25T19:24:53.154641Z","steps":["trace[1440682883] 'range keys from in-memory index tree'  (duration: 613.004498ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:53.154704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:52.541861Z","time spent":"612.831925ms","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":562,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "}
{"level":"warn","ts":"2026-02-25T19:24:53.154712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:52.541313Z","time spent":"613.389059ms","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":544,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "}
{"level":"warn","ts":"2026-02-25T19:24:53.154592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:52.563866Z","time spent":"590.715863ms","remote":"127.0.0.1:38740","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-02-25T19:24:53.154672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.563839ms","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-02-25T19:24:53.155139Z","caller":"traceutil/trace.go:171","msg":"trace[1446743657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:462; }","duration":"452.045928ms","start":"2026-02-25T19:24:52.703054Z","end":"2026-02-25T19:24:53.1551Z","steps":["trace[1446743657] 'range keys from in-memory index tree'  (duration: 451.44835ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:53.15524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.310135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"}
{"level":"warn","ts":"2026-02-25T19:24:53.155244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:52.703035Z","time spent":"452.180449ms","remote":"127.0.0.1:38992","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":"info","ts":"2026-02-25T19:24:53.155294Z","caller":"traceutil/trace.go:171","msg":"trace[1066811403] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:462; }","duration":"718.366659ms","start":"2026-02-25T19:24:52.436913Z","end":"2026-02-25T19:24:53.15528Z","steps":["trace[1066811403] 'range keys from in-memory index tree'  (duration: 717.981877ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:53.155332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:52.436894Z","time spent":"718.429834ms","remote":"127.0.0.1:38810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329972,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "}
{"level":"info","ts":"2026-02-25T19:24:54.5581Z","caller":"traceutil/trace.go:171","msg":"trace[1198116311] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"217.360754ms","start":"2026-02-25T19:24:54.340717Z","end":"2026-02-25T19:24:54.558078Z","steps":["trace[1198116311] 'process raft request'  (duration: 217.234694ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:24:54.764402Z","caller":"traceutil/trace.go:171","msg":"trace[339739025] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"421.827395ms","start":"2026-02-25T19:24:54.34256Z","end":"2026-02-25T19:24:54.764387Z","steps":["trace[339739025] 'process raft request'  (duration: 375.818275ms)","trace[339739025] 'compare'  (duration: 45.785022ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:24:54.764555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.878634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:24:54.764611Z","caller":"traceutil/trace.go:171","msg":"trace[907208781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:468; }","duration":"198.96469ms","start":"2026-02-25T19:24:54.565633Z","end":"2026-02-25T19:24:54.764597Z","steps":["trace[907208781] 'agreement among raft nodes before linearized reading'  (duration: 198.863582ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:54.764995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:54.342547Z","time spent":"421.910692ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:461 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-25T19:24:54.764316Z","caller":"traceutil/trace.go:171","msg":"trace[1042136330] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"198.633684ms","start":"2026-02-25T19:24:54.565656Z","end":"2026-02-25T19:24:54.76429Z","steps":["trace[1042136330] 'read index received'  (duration: 152.663037ms)","trace[1042136330] 'applied index is now lower than readState.Index'  (duration: 45.969287ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:24:55.075973Z","caller":"traceutil/trace.go:171","msg":"trace[1465200676] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"115.707965ms","start":"2026-02-25T19:24:54.960241Z","end":"2026-02-25T19:24:55.075949Z","steps":["trace[1465200676] 'process raft request'  (duration: 115.560793ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:57.269641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256277091397709865,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:24:57.295036Z","caller":"traceutil/trace.go:171","msg":"trace[50550088] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"726.945911ms","start":"2026-02-25T19:24:56.56807Z","end":"2026-02-25T19:24:57.295016Z","steps":["trace[50550088] 'process raft request'  (duration: 726.82019ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:57.295182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:56.568054Z","time spent":"727.040829ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:467 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T19:24:57.296396Z","caller":"traceutil/trace.go:171","msg":"trace[687246947] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:485; }","duration":"527.828785ms","start":"2026-02-25T19:24:56.768546Z","end":"2026-02-25T19:24:57.296375Z","steps":["trace[687246947] 'read index received'  (duration: 526.395658ms)","trace[687246947] 'applied index is now lower than readState.Index'  (duration: 1.432097ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:24:57.296506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.959895ms","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-02-25T19:24:57.296552Z","caller":"traceutil/trace.go:171","msg":"trace[1165511936] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:473; }","duration":"528.031221ms","start":"2026-02-25T19:24:56.768508Z","end":"2026-02-25T19:24:57.296539Z","steps":["trace[1165511936] 'agreement among raft nodes before linearized reading'  (duration: 527.961856ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:24:57.296582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:24:56.768491Z","time spent":"528.083965ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-25T19:25:01.753962Z","caller":"traceutil/trace.go:171","msg":"trace[944820730] linearizableReadLoop","detail":"{readStateIndex:523; appliedIndex:522; }","duration":"348.705057ms","start":"2026-02-25T19:25:01.405236Z","end":"2026-02-25T19:25:01.753942Z","steps":["trace[944820730] 'read index received'  (duration: 348.50782ms)","trace[944820730] 'applied index is now lower than readState.Index'  (duration: 196.427µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:01.754106Z","caller":"traceutil/trace.go:171","msg":"trace[1289191863] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"356.796457ms","start":"2026-02-25T19:25:01.397276Z","end":"2026-02-25T19:25:01.754072Z","steps":["trace[1289191863] 'process raft request'  (duration: 356.540005ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:01.754273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:01.396848Z","time spent":"357.33921ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:500 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T19:25:01.754305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.352869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ms7v9\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-02-25T19:25:01.754352Z","caller":"traceutil/trace.go:171","msg":"trace[1257785694] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ms7v9; range_end:; response_count:1; response_revision:508; }","duration":"267.459839ms","start":"2026-02-25T19:25:01.486878Z","end":"2026-02-25T19:25:01.754337Z","steps":["trace[1257785694] 'agreement among raft nodes before linearized reading'  (duration: 267.283494ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:01.754336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.237624ms","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-02-25T19:25:01.754411Z","caller":"traceutil/trace.go:171","msg":"trace[1273403901] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:508; }","duration":"346.333141ms","start":"2026-02-25T19:25:01.408056Z","end":"2026-02-25T19:25:01.754389Z","steps":["trace[1273403901] 'agreement among raft nodes before linearized reading'  (duration: 346.099712ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:01.754459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:01.408045Z","time spent":"346.402347ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T19:25:01.755613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.364923ms","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-02-25T19:25:01.755678Z","caller":"traceutil/trace.go:171","msg":"trace[1105075172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"350.446901ms","start":"2026-02-25T19:25:01.405217Z","end":"2026-02-25T19:25:01.755664Z","steps":["trace[1105075172] 'agreement among raft nodes before linearized reading'  (duration: 348.842459ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:01.755713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:01.405201Z","time spent":"350.503875ms","remote":"127.0.0.1:38992","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":"info","ts":"2026-02-25T19:25:01.879181Z","caller":"traceutil/trace.go:171","msg":"trace[1933179278] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"109.667927ms","start":"2026-02-25T19:25:01.769488Z","end":"2026-02-25T19:25:01.879156Z","steps":["trace[1933179278] 'process raft request'  (duration: 109.531106ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:02.529811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.729006ms","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-02-25T19:25:02.529977Z","caller":"traceutil/trace.go:171","msg":"trace[900984343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"381.941094ms","start":"2026-02-25T19:25:02.148011Z","end":"2026-02-25T19:25:02.529952Z","steps":["trace[900984343] 'range keys from in-memory index tree'  (duration: 380.973144ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:02.530221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:02.147989Z","time spent":"382.102867ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T19:25:03.062192Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256277091397709946,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T19:25:03.209719Z","caller":"traceutil/trace.go:171","msg":"trace[1409709093] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:526; }","duration":"647.9332ms","start":"2026-02-25T19:25:02.56177Z","end":"2026-02-25T19:25:03.209704Z","steps":["trace[1409709093] 'read index received'  (duration: 647.81077ms)","trace[1409709093] 'applied index is now lower than readState.Index'  (duration: 121.79µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:03.209819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.027958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:25:03.20984Z","caller":"traceutil/trace.go:171","msg":"trace[540386163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"648.090153ms","start":"2026-02-25T19:25:02.561745Z","end":"2026-02-25T19:25:03.209835Z","steps":["trace[540386163] 'agreement among raft nodes before linearized reading'  (duration: 648.020667ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:03.209866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:02.561734Z","time spent":"648.128686ms","remote":"127.0.0.1:38740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T19:25:03.210041Z","caller":"traceutil/trace.go:171","msg":"trace[1582580799] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"674.125697ms","start":"2026-02-25T19:25:02.53591Z","end":"2026-02-25T19:25:03.210036Z","steps":["trace[1582580799] 'process raft request'  (duration: 673.69219ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:03.210094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:25:02.535888Z","time spent":"674.171179ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:503 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T19:25:03.441339Z","caller":"traceutil/trace.go:171","msg":"trace[2138952588] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:527; }","duration":"230.663007ms","start":"2026-02-25T19:25:03.210655Z","end":"2026-02-25T19:25:03.441318Z","steps":["trace[2138952588] 'read index received'  (duration: 222.899655ms)","trace[2138952588] 'applied index is now lower than readState.Index'  (duration: 7.761942ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:03.441487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.802498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:25:03.441556Z","caller":"traceutil/trace.go:171","msg":"trace[932893263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"230.886795ms","start":"2026-02-25T19:25:03.210653Z","end":"2026-02-25T19:25:03.44154Z","steps":["trace[932893263] 'agreement among raft nodes before linearized reading'  (duration: 230.756045ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:06.537677Z","caller":"traceutil/trace.go:171","msg":"trace[1465973537] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"128.886609ms","start":"2026-02-25T19:25:06.408773Z","end":"2026-02-25T19:25:06.537659Z","steps":["trace[1465973537] 'process raft request'  (duration: 56.936041ms)","trace[1465973537] 'compare'  (duration: 71.795045ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:06.730426Z","caller":"traceutil/trace.go:171","msg":"trace[1110055250] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"187.946006ms","start":"2026-02-25T19:25:06.542461Z","end":"2026-02-25T19:25:06.730407Z","steps":["trace[1110055250] 'process raft request'  (duration: 120.692198ms)","trace[1110055250] 'compare'  (duration: 67.145429ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:06.730751Z","caller":"traceutil/trace.go:171","msg":"trace[975746026] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"181.148291ms","start":"2026-02-25T19:25:06.549573Z","end":"2026-02-25T19:25:06.730721Z","steps":["trace[975746026] 'process raft request'  (duration: 180.986239ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:06.730806Z","caller":"traceutil/trace.go:171","msg":"trace[517624403] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:578; }","duration":"168.211655ms","start":"2026-02-25T19:25:06.56258Z","end":"2026-02-25T19:25:06.730792Z","steps":["trace[517624403] 'read index received'  (duration: 100.572176ms)","trace[517624403] 'applied index is now lower than readState.Index'  (duration: 67.638019ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T19:25:06.730871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.280971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T19:25:06.730889Z","caller":"traceutil/trace.go:171","msg":"trace[1564821074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"168.328685ms","start":"2026-02-25T19:25:06.562554Z","end":"2026-02-25T19:25:06.730882Z","steps":["trace[1564821074] 'agreement among raft nodes before linearized reading'  (duration: 168.27305ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:06.730908Z","caller":"traceutil/trace.go:171","msg":"trace[98745184] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"181.312145ms","start":"2026-02-25T19:25:06.549567Z","end":"2026-02-25T19:25:06.730879Z","steps":["trace[98745184] 'process raft request'  (duration: 181.120479ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:06.912902Z","caller":"traceutil/trace.go:171","msg":"trace[2005189805] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"130.600271ms","start":"2026-02-25T19:25:06.78228Z","end":"2026-02-25T19:25:06.91288Z","steps":["trace[2005189805] 'process raft request'  (duration: 112.29793ms)","trace[2005189805] 'compare'  (duration: 18.217364ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:25:07.96841Z","caller":"traceutil/trace.go:171","msg":"trace[839263853] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"133.023774ms","start":"2026-02-25T19:25:07.835364Z","end":"2026-02-25T19:25:07.968388Z","steps":["trace[839263853] 'process raft request'  (duration: 132.609361ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:25:22.121484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.401065ms","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-02-25T19:25:22.121574Z","caller":"traceutil/trace.go:171","msg":"trace[195094906] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:708; }","duration":"139.543696ms","start":"2026-02-25T19:25:21.982012Z","end":"2026-02-25T19:25:22.121555Z","steps":["trace[195094906] 'range keys from in-memory index tree'  (duration: 139.224716ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:25:23.427385Z","caller":"traceutil/trace.go:171","msg":"trace[1783491201] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"101.145349ms","start":"2026-02-25T19:25:23.326218Z","end":"2026-02-25T19:25:23.427363Z","steps":["trace[1783491201] 'process raft request'  (duration: 101.010018ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:13.884317Z","caller":"traceutil/trace.go:171","msg":"trace[726520425] linearizableReadLoop","detail":"{readStateIndex:889; appliedIndex:888; }","duration":"111.431582ms","start":"2026-02-25T19:26:13.772856Z","end":"2026-02-25T19:26:13.884287Z","steps":["trace[726520425] 'read index received'  (duration: 104.155189ms)","trace[726520425] 'applied index is now lower than readState.Index'  (duration: 7.275323ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:13.884428Z","caller":"traceutil/trace.go:171","msg":"trace[1505511589] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"172.711463ms","start":"2026-02-25T19:26:13.711685Z","end":"2026-02-25T19:26:13.884397Z","steps":["trace[1505511589] 'process raft request'  (duration: 165.351939ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:13.884486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.602593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T19:26:13.884526Z","caller":"traceutil/trace.go:171","msg":"trace[912964403] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:858; }","duration":"111.691665ms","start":"2026-02-25T19:26:13.772821Z","end":"2026-02-25T19:26:13.884512Z","steps":["trace[912964403] 'agreement among raft nodes before linearized reading'  (duration: 111.575744ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:26.07232Z","caller":"traceutil/trace.go:171","msg":"trace[1204301645] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"104.439151ms","start":"2026-02-25T19:26:25.96786Z","end":"2026-02-25T19:26:26.072299Z","steps":["trace[1204301645] 'process raft request'  (duration: 104.320788ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T19:26:34.56568Z","caller":"traceutil/trace.go:171","msg":"trace[5493560] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"181.305973ms","start":"2026-02-25T19:26:34.384351Z","end":"2026-02-25T19:26:34.565657Z","steps":["trace[5493560] 'read index received'  (duration: 181.117748ms)","trace[5493560] 'applied index is now lower than readState.Index'  (duration: 187.295µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T19:26:34.565869Z","caller":"traceutil/trace.go:171","msg":"trace[1721646882] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"458.352599ms","start":"2026-02-25T19:26:34.107506Z","end":"2026-02-25T19:26:34.565859Z","steps":["trace[1721646882] 'process raft request'  (duration: 458.02886ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T19:26:34.566249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T19:26:34.107476Z","time spent":"458.449361ms","remote":"127.0.0.1:38992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:948 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T19:26:34.566258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.875648ms","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-02-25T19:26:34.566641Z","caller":"traceutil/trace.go:171","msg":"trace[288604883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:955; }","duration":"182.180336ms","start":"2026-02-25T19:26:34.384302Z","end":"2026-02-25T19:26:34.566483Z","steps":["trace[288604883] 'agreement among raft nodes before linearized reading'  (duration: 181.757905ms)"],"step_count":1}