{"level":"warn","ts":"2026-02-25T15:02:08.093115Z","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-25T15:02:08.093243Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.131: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.131:2380","--initial-cluster=instance=https://199.204.45.131:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.131:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.131: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-25T15:02:08.093342Z","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-25T15:02:08.093358Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.131:2380"]}
{"level":"info","ts":"2026-02-25T15:02:08.09338Z","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-25T15:02:08.094336Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"]}
{"level":"info","ts":"2026-02-25T15:02:08.094427Z","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.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.131: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-25T15:02:08.099822Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.091186ms"}
{"level":"info","ts":"2026-02-25T15:02:08.105857Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2fdf33955ed9ec6c","cluster-id":"e3dd6b4ed8cb907a"}
{"level":"info","ts":"2026-02-25T15:02:08.105944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T15:02:08.105965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 0"}
{"level":"info","ts":"2026-02-25T15:02:08.105977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2fdf33955ed9ec6c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T15:02:08.10599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became follower at term 1"}
{"level":"info","ts":"2026-02-25T15:02:08.106027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"}
{"level":"warn","ts":"2026-02-25T15:02:08.112346Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T15:02:08.113762Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T15:02:08.114905Z","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-25T15:02:08.117166Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2fdf33955ed9ec6c","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T15:02:08.117433Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2fdf33955ed9ec6c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T15:02:08.117378Z","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-25T15:02:08.117514Z","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-25T15:02:08.117526Z","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-25T15:02:08.120375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c switched to configuration voters=(3449532556223573100)"}
{"level":"info","ts":"2026-02-25T15:02:08.120639Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","added-peer-id":"2fdf33955ed9ec6c","added-peer-peer-urls":["https://199.204.45.131:2380"]}
{"level":"info","ts":"2026-02-25T15:02:08.123482Z","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-25T15:02:08.123643Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.131:2380"}
{"level":"info","ts":"2026-02-25T15:02:08.123702Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.131:2380"}
{"level":"info","ts":"2026-02-25T15:02:08.123989Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2fdf33955ed9ec6c","initial-advertise-peer-urls":["https://199.204.45.131:2380"],"listen-peer-urls":["https://199.204.45.131:2380"],"advertise-client-urls":["https://199.204.45.131:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.131:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T15:02:08.124212Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T15:02:08.906955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T15:02:08.907031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T15:02:08.90709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgPreVoteResp from 2fdf33955ed9ec6c at term 1"}
{"level":"info","ts":"2026-02-25T15:02:08.907112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became candidate at term 2"}
{"level":"info","ts":"2026-02-25T15:02:08.907124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c received MsgVoteResp from 2fdf33955ed9ec6c at term 2"}
{"level":"info","ts":"2026-02-25T15:02:08.90714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2fdf33955ed9ec6c became leader at term 2"}
{"level":"info","ts":"2026-02-25T15:02:08.90716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2fdf33955ed9ec6c elected leader 2fdf33955ed9ec6c at term 2"}
{"level":"info","ts":"2026-02-25T15:02:08.908465Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T15:02:08.909536Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2fdf33955ed9ec6c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.131:2379]}","request-path":"/0/members/2fdf33955ed9ec6c/attributes","cluster-id":"e3dd6b4ed8cb907a","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T15:02:08.909594Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T15:02:08.90958Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T15:02:08.909899Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T15:02:08.909946Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T15:02:08.910143Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e3dd6b4ed8cb907a","local-member-id":"2fdf33955ed9ec6c","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T15:02:08.910232Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T15:02:08.910265Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T15:02:08.9134Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T15:02:08.919047Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.131:2379"}
{"level":"warn","ts":"2026-02-25T15:02:14.037517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.103421ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163655581428859 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.189785792ca12670\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.189785792ca12670\" value_size:570 lease:7812791618726652604 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:02:14.037763Z","caller":"traceutil/trace.go:171","msg":"trace[826562593] transaction","detail":"{read_only:false; number_of_response:0; response_revision:281; }","duration":"130.298983ms","start":"2026-02-25T15:02:13.907412Z","end":"2026-02-25T15:02:14.037711Z","steps":["trace[826562593] 'process raft request'  (duration: 130.212772ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:14.037788Z","caller":"traceutil/trace.go:171","msg":"trace[921703296] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"130.945048ms","start":"2026-02-25T15:02:13.906807Z","end":"2026-02-25T15:02:14.037752Z","steps":["trace[921703296] 'process raft request'  (duration: 25.259863ms)","trace[921703296] 'compare'  (duration: 104.961181ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:02:14.037906Z","caller":"traceutil/trace.go:171","msg":"trace[1284561734] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:287; }","duration":"127.117201ms","start":"2026-02-25T15:02:13.910778Z","end":"2026-02-25T15:02:14.037895Z","steps":["trace[1284561734] 'read index received'  (duration: 21.239523ms)","trace[1284561734] 'applied index is now lower than readState.Index'  (duration: 105.876138ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:02:14.037913Z","caller":"traceutil/trace.go:171","msg":"trace[644904384] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"130.345113ms","start":"2026-02-25T15:02:13.907542Z","end":"2026-02-25T15:02:14.037887Z","steps":["trace[644904384] 'process raft request'  (duration: 130.110282ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:14.037949Z","caller":"traceutil/trace.go:171","msg":"trace[1002470065] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"130.323403ms","start":"2026-02-25T15:02:13.90759Z","end":"2026-02-25T15:02:14.037913Z","steps":["trace[1002470065] 'process raft request'  (duration: 130.096462ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:14.038027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.236622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3707"}
{"level":"info","ts":"2026-02-25T15:02:14.038056Z","caller":"traceutil/trace.go:171","msg":"trace[972780229] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:285; }","duration":"127.309303ms","start":"2026-02-25T15:02:13.910739Z","end":"2026-02-25T15:02:14.038048Z","steps":["trace[972780229] 'agreement among raft nodes before linearized reading'  (duration: 127.204012ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:14.038063Z","caller":"traceutil/trace.go:171","msg":"trace[193350964] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"129.78293ms","start":"2026-02-25T15:02:13.908267Z","end":"2026-02-25T15:02:14.038049Z","steps":["trace[193350964] 'process raft request'  (duration: 129.453418ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:14.037817Z","caller":"traceutil/trace.go:171","msg":"trace[692561993] transaction","detail":"{read_only:false; number_of_response:0; response_revision:283; }","duration":"130.104631ms","start":"2026-02-25T15:02:13.907693Z","end":"2026-02-25T15:02:14.037798Z","steps":["trace[692561993] 'process raft request'  (duration: 130.009091ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:14.959351Z","caller":"traceutil/trace.go:171","msg":"trace[1246664735] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"285.7398ms","start":"2026-02-25T15:02:14.673593Z","end":"2026-02-25T15:02:14.959333Z","steps":["trace[1246664735] 'read index received'  (duration: 283.658755ms)","trace[1246664735] 'applied index is now lower than readState.Index'  (duration: 2.080285ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:02:14.959416Z","caller":"traceutil/trace.go:171","msg":"trace[723343393] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"516.991521ms","start":"2026-02-25T15:02:14.442388Z","end":"2026-02-25T15:02:14.95938Z","steps":["trace[723343393] 'process raft request'  (duration: 514.982518ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:14.959525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.924721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:02:14.959595Z","caller":"traceutil/trace.go:171","msg":"trace[1681585987] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:297; }","duration":"286.030952ms","start":"2026-02-25T15:02:14.673547Z","end":"2026-02-25T15:02:14.959578Z","steps":["trace[1681585987] 'agreement among raft nodes before linearized reading'  (duration: 285.861451ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:14.959551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.726737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3446"}
{"level":"info","ts":"2026-02-25T15:02:14.959687Z","caller":"traceutil/trace.go:171","msg":"trace[1307370489] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:297; }","duration":"138.918358ms","start":"2026-02-25T15:02:14.820758Z","end":"2026-02-25T15:02:14.959677Z","steps":["trace[1307370489] 'agreement among raft nodes before linearized reading'  (duration: 138.681806ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:14.959636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:14.44237Z","time spent":"517.161453ms","remote":"127.0.0.1:35614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/ttl-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/ttl-controller\" value_size:119 >> failure:<>"}
{"level":"info","ts":"2026-02-25T15:02:20.501633Z","caller":"traceutil/trace.go:171","msg":"trace[1718866180] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"405.960263ms","start":"2026-02-25T15:02:20.095645Z","end":"2026-02-25T15:02:20.501605Z","steps":["trace[1718866180] 'process raft request'  (duration: 362.71056ms)","trace[1718866180] 'compare'  (duration: 42.706229ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:02:20.501715Z","caller":"traceutil/trace.go:171","msg":"trace[1252083528] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"405.507491ms","start":"2026-02-25T15:02:20.096178Z","end":"2026-02-25T15:02:20.501686Z","steps":["trace[1252083528] 'process raft request'  (duration: 405.39505ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:20.501795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:20.095629Z","time spent":"406.093104ms","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T15:02:20.501834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:20.096167Z","time spent":"405.611021ms","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<>"}
{"level":"info","ts":"2026-02-25T15:02:31.492979Z","caller":"traceutil/trace.go:171","msg":"trace[2078283664] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"421.622018ms","start":"2026-02-25T15:02:31.071332Z","end":"2026-02-25T15:02:31.492954Z","steps":["trace[2078283664] 'process raft request'  (duration: 421.454727ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:31.493328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:31.071317Z","time spent":"421.749508ms","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:445 > 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-25T15:02:31.870426Z","caller":"traceutil/trace.go:171","msg":"trace[1020126716] linearizableReadLoop","detail":"{readStateIndex:463; appliedIndex:462; }","duration":"268.099421ms","start":"2026-02-25T15:02:31.602297Z","end":"2026-02-25T15:02:31.870397Z","steps":["trace[1020126716] 'read index received'  (duration: 205.892344ms)","trace[1020126716] 'applied index is now lower than readState.Index'  (duration: 62.205877ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:02:31.870572Z","caller":"traceutil/trace.go:171","msg":"trace[407135336] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"776.263218ms","start":"2026-02-25T15:02:31.09426Z","end":"2026-02-25T15:02:31.870524Z","steps":["trace[407135336] 'process raft request'  (duration: 713.88692ms)","trace[407135336] 'compare'  (duration: 62.120906ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:02:31.870745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.408343ms","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-02-25T15:02:31.870837Z","caller":"traceutil/trace.go:171","msg":"trace[28151293] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:450; }","duration":"268.586844ms","start":"2026-02-25T15:02:31.602236Z","end":"2026-02-25T15:02:31.870822Z","steps":["trace[28151293] 'agreement among raft nodes before linearized reading'  (duration: 268.317132ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:31.870783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:31.094246Z","time spent":"776.432589ms","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:390 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-02-25T15:02:32.251762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.98662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.131\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T15:02:32.251868Z","caller":"traceutil/trace.go:171","msg":"trace[1540290014] range","detail":"{range_begin:/registry/masterleases/199.204.45.131; range_end:; response_count:1; response_revision:451; }","duration":"215.155482ms","start":"2026-02-25T15:02:32.036681Z","end":"2026-02-25T15:02:32.251837Z","steps":["trace[1540290014] 'range keys from in-memory index tree'  (duration: 214.793019ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:40.076721Z","caller":"traceutil/trace.go:171","msg":"trace[1983241849] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"134.816835ms","start":"2026-02-25T15:02:39.941871Z","end":"2026-02-25T15:02:40.076688Z","steps":["trace[1983241849] 'process raft request'  (duration: 134.575435ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:42.775394Z","caller":"traceutil/trace.go:171","msg":"trace[1886882342] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"122.923388ms","start":"2026-02-25T15:02:42.652444Z","end":"2026-02-25T15:02:42.775367Z","steps":["trace[1886882342] 'process raft request'  (duration: 122.779852ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:42.778918Z","caller":"traceutil/trace.go:171","msg":"trace[1512739435] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"125.232173ms","start":"2026-02-25T15:02:42.653669Z","end":"2026-02-25T15:02:42.778902Z","steps":["trace[1512739435] 'process raft request'  (duration: 125.136599ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:47.786094Z","caller":"traceutil/trace.go:171","msg":"trace[1069962373] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"173.075073ms","start":"2026-02-25T15:02:47.613002Z","end":"2026-02-25T15:02:47.786077Z","steps":["trace[1069962373] 'process raft request'  (duration: 172.977259ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:48.665937Z","caller":"traceutil/trace.go:171","msg":"trace[1317564657] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"545.085347ms","start":"2026-02-25T15:02:48.120833Z","end":"2026-02-25T15:02:48.665919Z","steps":["trace[1317564657] 'process raft request'  (duration: 544.973172ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:48.666061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:48.120814Z","time spent":"545.17979ms","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:543 > 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-25T15:02:49.360467Z","caller":"traceutil/trace.go:171","msg":"trace[557350562] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"555.036912ms","start":"2026-02-25T15:02:48.805409Z","end":"2026-02-25T15:02:49.360446Z","steps":["trace[557350562] 'process raft request'  (duration: 554.876346ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:49.3608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:48.805394Z","time spent":"555.159197ms","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:545 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T15:02:49.891006Z","caller":"traceutil/trace.go:171","msg":"trace[641373532] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"101.544219ms","start":"2026-02-25T15:02:49.789444Z","end":"2026-02-25T15:02:49.890988Z","steps":["trace[641373532] 'read index received'  (duration: 66.063094ms)","trace[641373532] 'applied index is now lower than readState.Index'  (duration: 35.480265ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:02:49.891023Z","caller":"traceutil/trace.go:171","msg":"trace[638465827] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"1.085403911s","start":"2026-02-25T15:02:48.805594Z","end":"2026-02-25T15:02:49.890998Z","steps":["trace[638465827] 'process raft request'  (duration: 1.049964288s)","trace[638465827] 'compare'  (duration: 35.170653ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:02:49.89117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.719415ms","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-02-25T15:02:49.891712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:48.805588Z","time spent":"1.085488144s","remote":"127.0.0.1:35676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:546 > 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-25T15:02:49.891805Z","caller":"traceutil/trace.go:171","msg":"trace[1287815408] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"102.385ms","start":"2026-02-25T15:02:49.789402Z","end":"2026-02-25T15:02:49.891787Z","steps":["trace[1287815408] 'agreement among raft nodes before linearized reading'  (duration: 101.679213ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:52.396985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.104871ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17036163655581429474 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" mod_revision:587 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" value_size:3977 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:02:52.397088Z","caller":"traceutil/trace.go:171","msg":"trace[1220806965] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"359.389976ms","start":"2026-02-25T15:02:52.037676Z","end":"2026-02-25T15:02:52.397066Z","steps":["trace[1220806965] 'read index received'  (duration: 149.122039ms)","trace[1220806965] 'applied index is now lower than readState.Index'  (duration: 210.265997ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:02:52.397199Z","caller":"traceutil/trace.go:171","msg":"trace[485741596] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"359.623554ms","start":"2026-02-25T15:02:52.037559Z","end":"2026-02-25T15:02:52.397183Z","steps":["trace[485741596] 'process raft request'  (duration: 149.249573ms)","trace[485741596] 'compare'  (duration: 209.866923ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:02:52.397294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:52.037534Z","time spent":"359.709957ms","remote":"127.0.0.1:35484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" mod_revision:587 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" value_size:3977 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" > >"}
{"level":"warn","ts":"2026-02-25T15:02:52.397535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.79631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.131\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T15:02:52.397688Z","caller":"traceutil/trace.go:171","msg":"trace[191355388] range","detail":"{range_begin:/registry/masterleases/199.204.45.131; range_end:; response_count:1; response_revision:588; }","duration":"359.991098ms","start":"2026-02-25T15:02:52.037638Z","end":"2026-02-25T15:02:52.397629Z","steps":["trace[191355388] 'agreement among raft nodes before linearized reading'  (duration: 359.503241ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:02:52.397795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:02:52.037624Z","time spent":"360.114452ms","remote":"127.0.0.1:35466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.131\" "}
{"level":"info","ts":"2026-02-25T15:02:52.401754Z","caller":"traceutil/trace.go:171","msg":"trace[42882450] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"182.645646ms","start":"2026-02-25T15:02:52.219083Z","end":"2026-02-25T15:02:52.401729Z","steps":["trace[42882450] 'process raft request'  (duration: 182.522061ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:02:55.23331Z","caller":"traceutil/trace.go:171","msg":"trace[301585347] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"147.957625ms","start":"2026-02-25T15:02:55.085327Z","end":"2026-02-25T15:02:55.233284Z","steps":["trace[301585347] 'process raft request'  (duration: 146.986ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:04:32.610887Z","caller":"traceutil/trace.go:171","msg":"trace[1781682969] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"206.575191ms","start":"2026-02-25T15:04:32.404265Z","end":"2026-02-25T15:04:32.61084Z","steps":["trace[1781682969] 'process raft request'  (duration: 206.454749ms)"],"step_count":1}