{"level":"warn","ts":"2026-03-12T21:38:57.661502Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-12T21:38:57.661739Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.209: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.209:2380","--initial-cluster=instance=https://199.204.45.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.209: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-03-12T21:38:57.6618Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-12T21:38:57.661812Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]}
{"level":"info","ts":"2026-03-12T21:38:57.661831Z","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-03-12T21:38:57.662923Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"]}
{"level":"info","ts":"2026-03-12T21:38:57.663078Z","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.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.209: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-03-12T21:38:57.66722Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.82518ms"}
{"level":"info","ts":"2026-03-12T21:38:57.682008Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"}
{"level":"info","ts":"2026-03-12T21:38:57.682216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"}
{"level":"info","ts":"2026-03-12T21:38:57.682295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"}
{"level":"info","ts":"2026-03-12T21:38:57.682723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adfb641115bf6cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-12T21:38:57.682766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"}
{"level":"info","ts":"2026-03-12T21:38:57.683027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"}
{"level":"warn","ts":"2026-03-12T21:38:57.693769Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-12T21:38:57.695097Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-12T21:38:57.697676Z","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-03-12T21:38:57.699488Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adfb641115bf6cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-12T21:38:57.702612Z","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-03-12T21:38:57.702738Z","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-03-12T21:38:57.702751Z","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-03-12T21:38:57.702963Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adfb641115bf6cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-12T21:38:57.703615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"}
{"level":"info","ts":"2026-03-12T21:38:57.704931Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","added-peer-id":"adfb641115bf6cbd","added-peer-peer-urls":["https://199.204.45.209:2380"]}
{"level":"info","ts":"2026-03-12T21:38:57.705959Z","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-03-12T21:38:57.706593Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"}
{"level":"info","ts":"2026-03-12T21:38:57.7067Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"}
{"level":"info","ts":"2026-03-12T21:38:57.70813Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adfb641115bf6cbd","initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-12T21:38:57.708165Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-12T21:38:57.785766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"}
{"level":"info","ts":"2026-03-12T21:38:57.785824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-12T21:38:57.785871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"}
{"level":"info","ts":"2026-03-12T21:38:57.785896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"}
{"level":"info","ts":"2026-03-12T21:38:57.785911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"}
{"level":"info","ts":"2026-03-12T21:38:57.78593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"}
{"level":"info","ts":"2026-03-12T21:38:57.785948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"}
{"level":"info","ts":"2026-03-12T21:38:57.786916Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-12T21:38:57.78768Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adfb641115bf6cbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.209:2379]}","request-path":"/0/members/adfb641115bf6cbd/attributes","cluster-id":"3da6b677d4b80c6","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-12T21:38:57.78775Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-12T21:38:57.787857Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-12T21:38:57.787971Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-12T21:38:57.788131Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-12T21:38:57.788117Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-12T21:38:57.788173Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-12T21:38:57.788171Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-12T21:38:57.789571Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"}
{"level":"info","ts":"2026-03-12T21:38:57.79112Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-12T21:39:23.792046Z","caller":"traceutil/trace.go:171","msg":"trace[1308491973] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"671.462603ms","start":"2026-03-12T21:39:23.120553Z","end":"2026-03-12T21:39:23.792016Z","steps":["trace[1308491973] 'process raft request'  (duration: 671.293058ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:23.792979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:23.120534Z","time spent":"671.633899ms","remote":"127.0.0.1:52086","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:459 > 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":"warn","ts":"2026-03-12T21:39:24.672618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.044101ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591429711468538 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:411 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-12T21:39:24.672742Z","caller":"traceutil/trace.go:171","msg":"trace[1302360878] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:480; }","duration":"1.09375346s","start":"2026-03-12T21:39:23.578969Z","end":"2026-03-12T21:39:24.672723Z","steps":["trace[1302360878] 'read index received'  (duration: 213.012517ms)","trace[1302360878] 'applied index is now lower than readState.Index'  (duration: 880.739853ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:39:24.672829Z","caller":"traceutil/trace.go:171","msg":"trace[19757629] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"1.531352348s","start":"2026-03-12T21:39:23.141466Z","end":"2026-03-12T21:39:24.672818Z","steps":["trace[19757629] 'process raft request'  (duration: 1.368875914s)","trace[19757629] 'compare'  (duration: 161.950388ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T21:39:24.672882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:23.141444Z","time spent":"1.53140816s","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:411 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-12T21:39:24.673068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.094099651s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:39:24.673124Z","caller":"traceutil/trace.go:171","msg":"trace[295725478] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:465; }","duration":"1.094187293s","start":"2026-03-12T21:39:23.578928Z","end":"2026-03-12T21:39:24.673115Z","steps":["trace[295725478] 'agreement among raft nodes before linearized reading'  (duration: 1.094110971s)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:24.673151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:23.578912Z","time spent":"1.094232195s","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-12T21:39:24.673648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.712038ms","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-03-12T21:39:24.673731Z","caller":"traceutil/trace.go:171","msg":"trace[742479263] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:465; }","duration":"923.8007ms","start":"2026-03-12T21:39:23.749905Z","end":"2026-03-12T21:39:24.673706Z","steps":["trace[742479263] 'agreement among raft nodes before linearized reading'  (duration: 923.649316ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:24.673746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.773928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-12T21:39:24.673771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:23.749848Z","time spent":"923.915024ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-12T21:39:24.673813Z","caller":"traceutil/trace.go:171","msg":"trace[1369633030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:465; }","duration":"631.883472ms","start":"2026-03-12T21:39:24.04191Z","end":"2026-03-12T21:39:24.673793Z","steps":["trace[1369633030] 'agreement among raft nodes before linearized reading'  (duration: 631.752458ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:24.673797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.398679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-12T21:39:24.673857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:24.04189Z","time spent":"631.957233ms","remote":"127.0.0.1:51830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-12T21:39:24.673895Z","caller":"traceutil/trace.go:171","msg":"trace[1088779428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:465; }","duration":"395.519032ms","start":"2026-03-12T21:39:24.27835Z","end":"2026-03-12T21:39:24.673869Z","steps":["trace[1088779428] 'agreement among raft nodes before linearized reading'  (duration: 395.341297ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:24.673923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.001225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-12T21:39:24.673946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:24.27825Z","time spent":"395.684237ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-12T21:39:24.674054Z","caller":"traceutil/trace.go:171","msg":"trace[1110137287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:465; }","duration":"703.076148ms","start":"2026-03-12T21:39:23.970877Z","end":"2026-03-12T21:39:24.673954Z","steps":["trace[1110137287] 'agreement among raft nodes before linearized reading'  (duration: 702.966744ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:24.674132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:23.970861Z","time spent":"703.259833ms","remote":"127.0.0.1:52086","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":"info","ts":"2026-03-12T21:39:24.835718Z","caller":"traceutil/trace.go:171","msg":"trace[1448483754] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"157.057581ms","start":"2026-03-12T21:39:24.678633Z","end":"2026-03-12T21:39:24.83569Z","steps":["trace[1448483754] 'process raft request'  (duration: 110.919345ms)","trace[1448483754] 'compare'  (duration: 45.96337ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:39:24.835901Z","caller":"traceutil/trace.go:171","msg":"trace[221046052] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"155.517123ms","start":"2026-03-12T21:39:24.680367Z","end":"2026-03-12T21:39:24.835884Z","steps":["trace[221046052] 'process raft request'  (duration: 155.282666ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:39:28.148584Z","caller":"traceutil/trace.go:171","msg":"trace[769240953] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:524; }","duration":"106.282972ms","start":"2026-03-12T21:39:28.042278Z","end":"2026-03-12T21:39:28.148561Z","steps":["trace[769240953] 'read index received'  (duration: 106.104637ms)","trace[769240953] 'applied index is now lower than readState.Index'  (duration: 177.505µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:39:28.148648Z","caller":"traceutil/trace.go:171","msg":"trace[1870547170] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"338.457177ms","start":"2026-03-12T21:39:27.810154Z","end":"2026-03-12T21:39:28.148611Z","steps":["trace[1870547170] 'process raft request'  (duration: 338.24387ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:28.148713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.400655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:39:28.148748Z","caller":"traceutil/trace.go:171","msg":"trace[1876918639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"106.466557ms","start":"2026-03-12T21:39:28.04227Z","end":"2026-03-12T21:39:28.148736Z","steps":["trace[1876918639] 'agreement among raft nodes before linearized reading'  (duration: 106.384725ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:28.148831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:27.810122Z","time spent":"338.607481ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:469 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-12T21:39:28.965654Z","caller":"traceutil/trace.go:171","msg":"trace[1054033809] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:525; }","duration":"116.656853ms","start":"2026-03-12T21:39:28.848969Z","end":"2026-03-12T21:39:28.965626Z","steps":["trace[1054033809] 'read index received'  (duration: 116.456407ms)","trace[1054033809] 'applied index is now lower than readState.Index'  (duration: 198.225µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:39:28.965779Z","caller":"traceutil/trace.go:171","msg":"trace[2059564850] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"180.200429ms","start":"2026-03-12T21:39:28.785568Z","end":"2026-03-12T21:39:28.965768Z","steps":["trace[2059564850] 'process raft request'  (duration: 179.920191ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:28.965888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.371651ms","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-03-12T21:39:28.965914Z","caller":"traceutil/trace.go:171","msg":"trace[180213028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:508; }","duration":"110.449303ms","start":"2026-03-12T21:39:28.855457Z","end":"2026-03-12T21:39:28.965906Z","steps":["trace[180213028] 'agreement among raft nodes before linearized reading'  (duration: 110.35802ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:28.965975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.006343ms","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-03-12T21:39:28.965988Z","caller":"traceutil/trace.go:171","msg":"trace[837256996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:508; }","duration":"117.031363ms","start":"2026-03-12T21:39:28.848951Z","end":"2026-03-12T21:39:28.965983Z","steps":["trace[837256996] 'agreement among raft nodes before linearized reading'  (duration: 116.998352ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:31.470873Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591429711468628,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-12T21:39:31.517529Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.360338221s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-12T21:39:31.517878Z","caller":"traceutil/trace.go:171","msg":"trace[2137265399] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.360776064s","start":"2026-03-12T21:39:30.157064Z","end":"2026-03-12T21:39:31.51784Z","steps":["trace[2137265399] 'process raft request'  (duration: 1.36064069s)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:31.518051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:30.157045Z","time spent":"1.360900917s","remote":"127.0.0.1:52086","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:507 > 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-03-12T21:39:31.522154Z","caller":"traceutil/trace.go:171","msg":"trace[165619614] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:529; }","duration":"552.022842ms","start":"2026-03-12T21:39:30.970113Z","end":"2026-03-12T21:39:31.522136Z","steps":["trace[165619614] 'read index received'  (duration: 547.581158ms)","trace[165619614] 'applied index is now lower than readState.Index'  (duration: 4.440793ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:39:31.522248Z","caller":"traceutil/trace.go:171","msg":"trace[1254494584] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"872.041207ms","start":"2026-03-12T21:39:30.650198Z","end":"2026-03-12T21:39:31.522239Z","steps":["trace[1254494584] 'process raft request'  (duration: 871.841372ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:31.522396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:30.650182Z","time spent":"872.095259ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:458 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-12T21:39:31.522449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.322931ms","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-03-12T21:39:31.522559Z","caller":"traceutil/trace.go:171","msg":"trace[1305194371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"552.478105ms","start":"2026-03-12T21:39:30.97006Z","end":"2026-03-12T21:39:31.522538Z","steps":["trace[1305194371] 'agreement among raft nodes before linearized reading'  (duration: 552.210267ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:31.522654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:30.970042Z","time spent":"552.580017ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-12T21:39:31.52302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.676127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-12T21:39:31.523047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.045436ms","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-03-12T21:39:31.523073Z","caller":"traceutil/trace.go:171","msg":"trace[340704477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"480.745258ms","start":"2026-03-12T21:39:31.042315Z","end":"2026-03-12T21:39:31.523061Z","steps":["trace[340704477] 'agreement among raft nodes before linearized reading'  (duration: 480.656896ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:31.523113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.954794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-12T21:39:31.523134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:31.042294Z","time spent":"480.812751ms","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-12T21:39:31.523166Z","caller":"traceutil/trace.go:171","msg":"trace[1642525184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"527.047376ms","start":"2026-03-12T21:39:30.996105Z","end":"2026-03-12T21:39:31.523152Z","steps":["trace[1642525184] 'agreement among raft nodes before linearized reading'  (duration: 526.898422ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:31.523145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.683331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-03-12T21:39:31.523207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:30.996084Z","time spent":"527.114478ms","remote":"127.0.0.1:52086","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":"info","ts":"2026-03-12T21:39:31.523231Z","caller":"traceutil/trace.go:171","msg":"trace[66270816] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:513; }","duration":"395.784213ms","start":"2026-03-12T21:39:31.127416Z","end":"2026-03-12T21:39:31.5232Z","steps":["trace[66270816] 'agreement among raft nodes before linearized reading'  (duration: 395.698651ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:31.523272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:31.127396Z","time spent":"395.866436ms","remote":"127.0.0.1:51852","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.209\" "}
{"level":"info","ts":"2026-03-12T21:39:31.523631Z","caller":"traceutil/trace.go:171","msg":"trace[221810158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"527.100078ms","start":"2026-03-12T21:39:30.995973Z","end":"2026-03-12T21:39:31.523073Z","steps":["trace[221810158] 'agreement among raft nodes before linearized reading'  (duration: 526.987665ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:31.523681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:30.995948Z","time spent":"527.721284ms","remote":"127.0.0.1:52086","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":"info","ts":"2026-03-12T21:39:35.204423Z","caller":"traceutil/trace.go:171","msg":"trace[893008502] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"371.776287ms","start":"2026-03-12T21:39:34.832607Z","end":"2026-03-12T21:39:35.204383Z","steps":["trace[893008502] 'process raft request'  (duration: 371.587202ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:35.204582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:34.832589Z","time spent":"371.914171ms","remote":"127.0.0.1:52004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-szfmf\" mod_revision:498 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-szfmf\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-szfmf\" > >"}
{"level":"info","ts":"2026-03-12T21:39:35.27233Z","caller":"traceutil/trace.go:171","msg":"trace[1392751740] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:566; }","duration":"229.594833ms","start":"2026-03-12T21:39:35.042709Z","end":"2026-03-12T21:39:35.272304Z","steps":["trace[1392751740] 'read index received'  (duration: 161.48955ms)","trace[1392751740] 'applied index is now lower than readState.Index'  (duration: 68.103983ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T21:39:35.27248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.755657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:39:35.272519Z","caller":"traceutil/trace.go:171","msg":"trace[1386504442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"229.835339ms","start":"2026-03-12T21:39:35.042675Z","end":"2026-03-12T21:39:35.27251Z","steps":["trace[1386504442] 'agreement among raft nodes before linearized reading'  (duration: 229.742197ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:39:35.2728Z","caller":"traceutil/trace.go:171","msg":"trace[1092079437] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"367.981875ms","start":"2026-03-12T21:39:34.904811Z","end":"2026-03-12T21:39:35.272793Z","steps":["trace[1092079437] 'process raft request'  (duration: 367.359078ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:35.272853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:34.904801Z","time spent":"368.016155ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:465 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-12T21:39:35.870114Z","caller":"traceutil/trace.go:171","msg":"trace[2145769022] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"331.469687ms","start":"2026-03-12T21:39:35.538623Z","end":"2026-03-12T21:39:35.870092Z","steps":["trace[2145769022] 'read index received'  (duration: 331.305022ms)","trace[2145769022] 'applied index is now lower than readState.Index'  (duration: 163.905µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:39:35.870184Z","caller":"traceutil/trace.go:171","msg":"trace[738876448] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"334.420475ms","start":"2026-03-12T21:39:35.535727Z","end":"2026-03-12T21:39:35.870148Z","steps":["trace[738876448] 'process raft request'  (duration: 334.23479ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:35.870401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:35.535685Z","time spent":"334.60133ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:540 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-12T21:39:35.870438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.810385ms","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-03-12T21:39:35.870487Z","caller":"traceutil/trace.go:171","msg":"trace[1838724078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:549; }","duration":"331.907299ms","start":"2026-03-12T21:39:35.538566Z","end":"2026-03-12T21:39:35.870473Z","steps":["trace[1838724078] 'agreement among raft nodes before linearized reading'  (duration: 331.676443ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:35.870501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.263354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-12T21:39:35.870529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:35.538545Z","time spent":"331.97625ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-12T21:39:35.870582Z","caller":"traceutil/trace.go:171","msg":"trace[273754054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"327.389567ms","start":"2026-03-12T21:39:35.543174Z","end":"2026-03-12T21:39:35.870563Z","steps":["trace[273754054] 'agreement among raft nodes before linearized reading'  (duration: 327.149551ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:35.870626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:35.543157Z","time spent":"327.460869ms","remote":"127.0.0.1:52086","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-03-12T21:39:35.870764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.101016ms","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-03-12T21:39:35.870802Z","caller":"traceutil/trace.go:171","msg":"trace[980850884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"328.470706ms","start":"2026-03-12T21:39:35.542322Z","end":"2026-03-12T21:39:35.870793Z","steps":["trace[980850884] 'agreement among raft nodes before linearized reading'  (duration: 327.942262ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:35.870834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:35.542297Z","time spent":"328.526327ms","remote":"127.0.0.1:52086","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-03-12T21:39:37.08342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.404697ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591429711468710 > lease_revoke:<id:6cbd9ce3fd0c17ea>","response":"size:28"}
{"level":"warn","ts":"2026-03-12T21:39:38.422777Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591429711468713,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-12T21:39:38.923756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591429711468713,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-12T21:39:39.424784Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591429711468713,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-12T21:39:39.925653Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591429711468713,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-12T21:39:40.372496Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.492471813s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-12T21:39:40.372826Z","caller":"traceutil/trace.go:171","msg":"trace[1261961112] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"2.45106325s","start":"2026-03-12T21:39:37.921743Z","end":"2026-03-12T21:39:40.372807Z","steps":["trace[1261961112] 'read index received'  (duration: 2.450856074s)","trace[1261961112] 'applied index is now lower than readState.Index'  (duration: 206.456µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:39:40.372914Z","caller":"traceutil/trace.go:171","msg":"trace[2012128664] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"2.492972467s","start":"2026-03-12T21:39:37.879922Z","end":"2026-03-12T21:39:40.372895Z","steps":["trace[2012128664] 'process raft request'  (duration: 2.492762901s)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:40.373018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:37.879898Z","time spent":"2.493044068s","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:549 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-12T21:39:40.37324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.432251266s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-12T21:39:40.373295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.431433025s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-12T21:39:40.373254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.332969377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:39:40.373322Z","caller":"traceutil/trace.go:171","msg":"trace[1726214951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"2.431481386s","start":"2026-03-12T21:39:37.941833Z","end":"2026-03-12T21:39:40.373314Z","steps":["trace[1726214951] 'agreement among raft nodes before linearized reading'  (duration: 2.431376114s)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:40.373349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:37.941822Z","time spent":"2.431520367s","remote":"127.0.0.1:52086","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":"info","ts":"2026-03-12T21:39:40.373335Z","caller":"traceutil/trace.go:171","msg":"trace[1248092712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"2.43239273s","start":"2026-03-12T21:39:37.940917Z","end":"2026-03-12T21:39:40.37331Z","steps":["trace[1248092712] 'agreement among raft nodes before linearized reading'  (duration: 2.432103373s)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:39:40.37336Z","caller":"traceutil/trace.go:171","msg":"trace[1340592066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"1.333150301s","start":"2026-03-12T21:39:39.040188Z","end":"2026-03-12T21:39:40.373338Z","steps":["trace[1340592066] 'agreement among raft nodes before linearized reading'  (duration: 1.332964626s)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:40.373388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:37.940905Z","time spent":"2.432472092s","remote":"127.0.0.1:52086","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-03-12T21:39:40.37341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:39.040158Z","time spent":"1.333243454s","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-12T21:39:40.373441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.451706185s","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-03-12T21:39:40.373462Z","caller":"traceutil/trace.go:171","msg":"trace[1660313655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"2.451760227s","start":"2026-03-12T21:39:37.921695Z","end":"2026-03-12T21:39:40.373456Z","steps":["trace[1660313655] 'agreement among raft nodes before linearized reading'  (duration: 2.451705406s)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:40.373479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:37.921679Z","time spent":"2.451795907s","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-12T21:39:40.947929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.1623ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591429711468718 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:552 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-12T21:39:40.948048Z","caller":"traceutil/trace.go:171","msg":"trace[1797279989] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:574; }","duration":"564.039721ms","start":"2026-03-12T21:39:40.383997Z","end":"2026-03-12T21:39:40.948037Z","steps":["trace[1797279989] 'read index received'  (duration: 431.718246ms)","trace[1797279989] 'applied index is now lower than readState.Index'  (duration: 132.321015ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T21:39:40.948123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.134343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:39:40.948181Z","caller":"traceutil/trace.go:171","msg":"trace[549639917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"564.181833ms","start":"2026-03-12T21:39:40.383962Z","end":"2026-03-12T21:39:40.948143Z","steps":["trace[549639917] 'agreement among raft nodes before linearized reading'  (duration: 564.103892ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:40.948203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:40.383946Z","time spent":"564.252926ms","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-12T21:39:40.948161Z","caller":"traceutil/trace.go:171","msg":"trace[862141166] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"568.514894ms","start":"2026-03-12T21:39:40.379565Z","end":"2026-03-12T21:39:40.94808Z","steps":["trace[862141166] 'process raft request'  (duration: 436.137178ms)","trace[862141166] 'compare'  (duration: 132.024597ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:39:40.948312Z","caller":"traceutil/trace.go:171","msg":"trace[192835350] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"568.211337ms","start":"2026-03-12T21:39:40.380053Z","end":"2026-03-12T21:39:40.948265Z","steps":["trace[192835350] 'process raft request'  (duration: 567.94207ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:40.948396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:40.379544Z","time spent":"568.73741ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:552 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-12T21:39:40.948348Z","caller":"traceutil/trace.go:171","msg":"trace[1828869294] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"567.95274ms","start":"2026-03-12T21:39:40.380331Z","end":"2026-03-12T21:39:40.948284Z","steps":["trace[1828869294] 'process raft request'  (duration: 567.687673ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:40.948471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:40.380022Z","time spent":"568.36934ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:550 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-12T21:39:40.948641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:40.380323Z","time spent":"568.150455ms","remote":"127.0.0.1:52086","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:551 > 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":"warn","ts":"2026-03-12T21:39:42.519789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.814041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:39:42.519884Z","caller":"traceutil/trace.go:171","msg":"trace[123554070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:562; }","duration":"477.955155ms","start":"2026-03-12T21:39:42.041906Z","end":"2026-03-12T21:39:42.519861Z","steps":["trace[123554070] 'range keys from in-memory index tree'  (duration: 477.73601ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:39:42.519926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:39:42.041892Z","time spent":"478.025746ms","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-12T21:39:42.520097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.243187ms","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-03-12T21:39:42.520148Z","caller":"traceutil/trace.go:171","msg":"trace[357827953] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:562; }","duration":"141.336099ms","start":"2026-03-12T21:39:42.378799Z","end":"2026-03-12T21:39:42.520135Z","steps":["trace[357827953] 'range keys from in-memory index tree'  (duration: 140.99521ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:39:42.698046Z","caller":"traceutil/trace.go:171","msg":"trace[2110667857] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"174.135303ms","start":"2026-03-12T21:39:42.523881Z","end":"2026-03-12T21:39:42.698016Z","steps":["trace[2110667857] 'process raft request'  (duration: 173.980849ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:39:46.255294Z","caller":"traceutil/trace.go:171","msg":"trace[801434787] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"229.818943ms","start":"2026-03-12T21:39:46.025443Z","end":"2026-03-12T21:39:46.255262Z","steps":["trace[801434787] 'process raft request'  (duration: 227.879806ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:39:46.255284Z","caller":"traceutil/trace.go:171","msg":"trace[590848592] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"214.299783ms","start":"2026-03-12T21:39:46.040903Z","end":"2026-03-12T21:39:46.255203Z","steps":["trace[590848592] 'read index received'  (duration: 212.146212ms)","trace[590848592] 'applied index is now lower than readState.Index'  (duration: 2.148031ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T21:39:46.255769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.800765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:39:46.255938Z","caller":"traceutil/trace.go:171","msg":"trace[423410717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"215.054151ms","start":"2026-03-12T21:39:46.040857Z","end":"2026-03-12T21:39:46.255912Z","steps":["trace[423410717] 'agreement among raft nodes before linearized reading'  (duration: 214.713103ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:41:01.528908Z","caller":"traceutil/trace.go:171","msg":"trace[1873584661] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1003; }","duration":"171.889372ms","start":"2026-03-12T21:41:01.356991Z","end":"2026-03-12T21:41:01.52888Z","steps":["trace[1873584661] 'read index received'  (duration: 171.73921ms)","trace[1873584661] 'applied index is now lower than readState.Index'  (duration: 149.002µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:41:01.529011Z","caller":"traceutil/trace.go:171","msg":"trace[1516435632] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"172.206206ms","start":"2026-03-12T21:41:01.356758Z","end":"2026-03-12T21:41:01.528964Z","steps":["trace[1516435632] 'process raft request'  (duration: 171.947812ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:01.529164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.132265ms","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-03-12T21:41:01.529216Z","caller":"traceutil/trace.go:171","msg":"trace[258814608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:962; }","duration":"172.235617ms","start":"2026-03-12T21:41:01.356965Z","end":"2026-03-12T21:41:01.529201Z","steps":["trace[258814608] 'agreement among raft nodes before linearized reading'  (duration: 172.050034ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:01.861851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.528251ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591429711469691 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:954 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-12T21:41:01.86196Z","caller":"traceutil/trace.go:171","msg":"trace[75838421] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1004; }","duration":"332.956405ms","start":"2026-03-12T21:41:01.528987Z","end":"2026-03-12T21:41:01.861944Z","steps":["trace[75838421] 'read index received'  (duration: 65.356193ms)","trace[75838421] 'applied index is now lower than readState.Index'  (duration: 267.599042ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T21:41:01.862115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.88159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-12T21:41:01.862204Z","caller":"traceutil/trace.go:171","msg":"trace[408587892] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:963; }","duration":"436.967031ms","start":"2026-03-12T21:41:01.425224Z","end":"2026-03-12T21:41:01.862191Z","steps":["trace[408587892] 'agreement among raft nodes before linearized reading'  (duration: 436.765328ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:01.862337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:01.42518Z","time spent":"437.143703ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-03-12T21:41:01.862608Z","caller":"traceutil/trace.go:171","msg":"trace[335758383] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"503.991896ms","start":"2026-03-12T21:41:01.358572Z","end":"2026-03-12T21:41:01.862564Z","steps":["trace[335758383] 'process raft request'  (duration: 235.641894ms)","trace[335758383] 'compare'  (duration: 267.40544ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T21:41:01.862821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:01.358561Z","time spent":"504.144748ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:954 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-03-12T21:41:01.866948Z","caller":"traceutil/trace.go:171","msg":"trace[443326962] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"333.182048ms","start":"2026-03-12T21:41:01.533736Z","end":"2026-03-12T21:41:01.866918Z","steps":["trace[443326962] 'process raft request'  (duration: 332.921194ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:01.867355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:01.533715Z","time spent":"333.462071ms","remote":"127.0.0.1:52086","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:955 > 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-03-12T21:41:09.378881Z","caller":"traceutil/trace.go:171","msg":"trace[316161201] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"168.586645ms","start":"2026-03-12T21:41:09.210274Z","end":"2026-03-12T21:41:09.378861Z","steps":["trace[316161201] 'process raft request'  (duration: 168.500914ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:09.705168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.351382ms","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-03-12T21:41:09.705276Z","caller":"traceutil/trace.go:171","msg":"trace[1224122291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:990; }","duration":"136.509944ms","start":"2026-03-12T21:41:09.568739Z","end":"2026-03-12T21:41:09.705249Z","steps":["trace[1224122291] 'range keys from in-memory index tree'  (duration: 136.117249ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:10.212163Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591429711469763,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-12T21:41:10.712841Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591429711469763,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-12T21:41:10.874275Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.16356592s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-12T21:41:10.875204Z","caller":"traceutil/trace.go:171","msg":"trace[625508635] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"1.163261955s","start":"2026-03-12T21:41:09.711919Z","end":"2026-03-12T21:41:10.875181Z","steps":["trace[625508635] 'read index received'  (duration: 1.163047342s)","trace[625508635] 'applied index is now lower than readState.Index'  (duration: 213.603µs)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:41:10.875262Z","caller":"traceutil/trace.go:171","msg":"trace[906087733] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"1.164671893s","start":"2026-03-12T21:41:09.71056Z","end":"2026-03-12T21:41:10.875231Z","steps":["trace[906087733] 'process raft request'  (duration: 1.16446572s)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:10.875371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.163438318s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:41:10.875402Z","caller":"traceutil/trace.go:171","msg":"trace[1510688424] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:991; }","duration":"1.163489229s","start":"2026-03-12T21:41:09.711903Z","end":"2026-03-12T21:41:10.875393Z","steps":["trace[1510688424] 'agreement among raft nodes before linearized reading'  (duration: 1.163363867s)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:10.875444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:09.711837Z","time spent":"1.163599839s","remote":"127.0.0.1:51972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "}
{"level":"warn","ts":"2026-03-12T21:41:10.875588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.113235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-03-12T21:41:10.87563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.701493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:41:10.875681Z","caller":"traceutil/trace.go:171","msg":"trace[1486161617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:991; }","duration":"954.260886ms","start":"2026-03-12T21:41:09.921395Z","end":"2026-03-12T21:41:10.875656Z","steps":["trace[1486161617] 'agreement among raft nodes before linearized reading'  (duration: 953.993353ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:10.875707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.361332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-03-12T21:41:10.875735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:09.921373Z","time spent":"954.352077ms","remote":"127.0.0.1:52086","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":"info","ts":"2026-03-12T21:41:10.875739Z","caller":"traceutil/trace.go:171","msg":"trace[265409123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:991; }","duration":"833.838055ms","start":"2026-03-12T21:41:10.041856Z","end":"2026-03-12T21:41:10.875694Z","steps":["trace[265409123] 'agreement among raft nodes before linearized reading'  (duration: 833.690664ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:41:10.875764Z","caller":"traceutil/trace.go:171","msg":"trace[1850551309] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:991; }","duration":"859.449743ms","start":"2026-03-12T21:41:10.016293Z","end":"2026-03-12T21:41:10.875742Z","steps":["trace[1850551309] 'agreement among raft nodes before linearized reading'  (duration: 859.18385ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:10.87579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:10.041832Z","time spent":"833.949097ms","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-12T21:41:10.875819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:10.016277Z","time spent":"859.526704ms","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-12T21:41:10.875761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:09.710528Z","time spent":"1.164850696s","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:984 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-12T21:41:10.876287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.222809ms","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-03-12T21:41:10.88053Z","caller":"traceutil/trace.go:171","msg":"trace[1021467723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:991; }","duration":"931.494491ms","start":"2026-03-12T21:41:09.949016Z","end":"2026-03-12T21:41:10.88051Z","steps":["trace[1021467723] 'agreement among raft nodes before linearized reading'  (duration: 926.505689ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:10.880584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-12T21:41:09.948999Z","time spent":"931.572573ms","remote":"127.0.0.1:52086","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-03-12T21:41:11.065189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.325676ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591429711469768 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:985 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-12T21:41:11.065469Z","caller":"traceutil/trace.go:171","msg":"trace[643395325] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"172.987893ms","start":"2026-03-12T21:41:10.89246Z","end":"2026-03-12T21:41:11.065447Z","steps":["trace[643395325] 'process raft request'  (duration: 58.298493ms)","trace[643395325] 'compare'  (duration: 114.237655ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:41:11.065587Z","caller":"traceutil/trace.go:171","msg":"trace[1368501177] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"173.068255ms","start":"2026-03-12T21:41:10.892473Z","end":"2026-03-12T21:41:11.065542Z","steps":["trace[1368501177] 'process raft request'  (duration: 172.810371ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:41:11.065848Z","caller":"traceutil/trace.go:171","msg":"trace[955108725] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"171.10686ms","start":"2026-03-12T21:41:10.894713Z","end":"2026-03-12T21:41:11.06582Z","steps":["trace[955108725] 'process raft request'  (duration: 170.615424ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:11.363821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.810975ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591429711469774 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:6cbd9ce3fd0c1ccd>","response":"size:40"}
{"level":"info","ts":"2026-03-12T21:41:11.550563Z","caller":"traceutil/trace.go:171","msg":"trace[679546591] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"103.706661ms","start":"2026-03-12T21:41:11.446826Z","end":"2026-03-12T21:41:11.550533Z","steps":["trace[679546591] 'read index received'  (duration: 27.155495ms)","trace[679546591] 'applied index is now lower than readState.Index'  (duration: 76.550516ms)"],"step_count":2}
{"level":"info","ts":"2026-03-12T21:41:11.550634Z","caller":"traceutil/trace.go:171","msg":"trace[539623267] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"104.130567ms","start":"2026-03-12T21:41:11.446482Z","end":"2026-03-12T21:41:11.550612Z","steps":["trace[539623267] 'process raft request'  (duration: 27.53607ms)","trace[539623267] 'compare'  (duration: 76.435065ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T21:41:11.550712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.866743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-03-12T21:41:11.550942Z","caller":"traceutil/trace.go:171","msg":"trace[1803984872] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:996; }","duration":"104.096256ms","start":"2026-03-12T21:41:11.446808Z","end":"2026-03-12T21:41:11.550905Z","steps":["trace[1803984872] 'agreement among raft nodes before linearized reading'  (duration: 103.815373ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:41:13.154505Z","caller":"traceutil/trace.go:171","msg":"trace[666738521] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1040; }","duration":"181.752974ms","start":"2026-03-12T21:41:12.972716Z","end":"2026-03-12T21:41:13.154469Z","steps":["trace[666738521] 'read index received'  (duration: 181.501021ms)","trace[666738521] 'applied index is now lower than readState.Index'  (duration: 250.483µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-12T21:41:13.154725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.966416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:41:13.154809Z","caller":"traceutil/trace.go:171","msg":"trace[47503289] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:997; }","duration":"182.115849ms","start":"2026-03-12T21:41:12.97267Z","end":"2026-03-12T21:41:13.154786Z","steps":["trace[47503289] 'agreement among raft nodes before linearized reading'  (duration: 181.918076ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:41:13.155232Z","caller":"traceutil/trace.go:171","msg":"trace[1761549424] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"259.888344ms","start":"2026-03-12T21:41:12.895321Z","end":"2026-03-12T21:41:13.155209Z","steps":["trace[1761549424] 'process raft request'  (duration: 258.927272ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-12T21:41:13.155482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.040752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-12T21:41:13.155537Z","caller":"traceutil/trace.go:171","msg":"trace[444798933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"113.127063ms","start":"2026-03-12T21:41:13.042398Z","end":"2026-03-12T21:41:13.155525Z","steps":["trace[444798933] 'agreement among raft nodes before linearized reading'  (duration: 112.969741ms)"],"step_count":1}
{"level":"info","ts":"2026-03-12T21:41:39.805447Z","caller":"traceutil/trace.go:171","msg":"trace[281803461] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"105.805294ms","start":"2026-03-12T21:41:39.699622Z","end":"2026-03-12T21:41:39.805427Z","steps":["trace[281803461] 'process raft request'  (duration: 105.682493ms)"],"step_count":1}