{"level":"warn","ts":"2026-02-25T02:12:16.389092Z","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-25T02:12:16.38917Z","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-02-25T02:12:16.389229Z","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-25T02:12:16.389243Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]}
{"level":"info","ts":"2026-02-25T02:12:16.389259Z","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-25T02:12:16.389926Z","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-02-25T02:12:16.390008Z","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-02-25T02:12:16.395396Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.879379ms"}
{"level":"info","ts":"2026-02-25T02:12:16.406729Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"}
{"level":"info","ts":"2026-02-25T02:12:16.406841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T02:12:16.406873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"}
{"level":"info","ts":"2026-02-25T02:12:16.406899Z","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-02-25T02:12:16.406939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"}
{"level":"info","ts":"2026-02-25T02:12:16.406988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"}
{"level":"warn","ts":"2026-02-25T02:12:16.417639Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T02:12:16.423869Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T02:12:16.426776Z","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-25T02:12:16.429144Z","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-02-25T02:12:16.430348Z","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-02-25T02:12:16.430567Z","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-25T02:12:16.43064Z","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-25T02:12:16.43065Z","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-25T02:12:16.435406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"}
{"level":"info","ts":"2026-02-25T02:12:16.435936Z","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-02-25T02:12:16.436884Z","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-25T02:12:16.437317Z","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-02-25T02:12:16.437373Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T02:12:16.437553Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"}
{"level":"info","ts":"2026-02-25T02:12:16.437577Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"}
{"level":"info","ts":"2026-02-25T02:12:16.808408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T02:12:16.808484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T02:12:16.808526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"}
{"level":"info","ts":"2026-02-25T02:12:16.808549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"}
{"level":"info","ts":"2026-02-25T02:12:16.808561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"}
{"level":"info","ts":"2026-02-25T02:12:16.808578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"}
{"level":"info","ts":"2026-02-25T02:12:16.808593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"}
{"level":"info","ts":"2026-02-25T02:12:16.809963Z","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-02-25T02:12:16.8102Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T02:12:16.810229Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T02:12:16.810541Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T02:12:16.810634Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T02:12:16.810156Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T02:12:16.811183Z","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-02-25T02:12:16.811348Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T02:12:16.811403Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T02:12:16.815124Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"}
{"level":"info","ts":"2026-02-25T02:12:16.81766Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T02:12:29.753172Z","caller":"traceutil/trace.go:171","msg":"trace[507125389] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"384.231819ms","start":"2026-02-25T02:12:29.368879Z","end":"2026-02-25T02:12:29.753111Z","steps":["trace[507125389] 'process raft request'  (duration: 383.954682ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:12:29.754037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:29.368861Z","time spent":"384.454035ms","remote":"127.0.0.1:58290","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:306 > 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-02-25T02:12:35.353364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.869951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"}
{"level":"info","ts":"2026-02-25T02:12:35.353501Z","caller":"traceutil/trace.go:171","msg":"trace[624974468] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:401; }","duration":"188.086196ms","start":"2026-02-25T02:12:35.165392Z","end":"2026-02-25T02:12:35.353478Z","steps":["trace[624974468] 'range keys from in-memory index tree'  (duration: 187.682066ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:12:35.652443Z","caller":"traceutil/trace.go:171","msg":"trace[1804124071] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"294.45029ms","start":"2026-02-25T02:12:35.357961Z","end":"2026-02-25T02:12:35.652411Z","steps":["trace[1804124071] 'process raft request'  (duration: 294.236135ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:12:35.738388Z","caller":"traceutil/trace.go:171","msg":"trace[6077530] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"378.214393ms","start":"2026-02-25T02:12:35.360138Z","end":"2026-02-25T02:12:35.738353Z","steps":["trace[6077530] 'process raft request'  (duration: 374.77302ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:12:35.738609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:35.360099Z","time spent":"378.385388ms","remote":"127.0.0.1:58208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4245,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:270 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4187 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"info","ts":"2026-02-25T02:12:49.71908Z","caller":"traceutil/trace.go:171","msg":"trace[1089328612] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"352.94268ms","start":"2026-02-25T02:12:49.366099Z","end":"2026-02-25T02:12:49.719041Z","steps":["trace[1089328612] 'process raft request'  (duration: 352.771695ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:12:49.719267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:12:49.366016Z","time spent":"353.152135ms","remote":"127.0.0.1:58192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:366 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4179 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-25T02:12:49.719638Z","caller":"traceutil/trace.go:171","msg":"trace[1223650740] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"279.002915ms","start":"2026-02-25T02:12:49.440597Z","end":"2026-02-25T02:12:49.7196Z","steps":["trace[1223650740] 'process raft request'  (duration: 278.859102ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:12:56.83044Z","caller":"traceutil/trace.go:171","msg":"trace[129915653] linearizableReadLoop","detail":"{readStateIndex:509; appliedIndex:508; }","duration":"103.3658ms","start":"2026-02-25T02:12:56.727043Z","end":"2026-02-25T02:12:56.830409Z","steps":["trace[129915653] 'read index received'  (duration: 103.022031ms)","trace[129915653] 'applied index is now lower than readState.Index'  (duration: 342.059µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:12:56.830497Z","caller":"traceutil/trace.go:171","msg":"trace[1356016584] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"155.727591ms","start":"2026-02-25T02:12:56.674734Z","end":"2026-02-25T02:12:56.830461Z","steps":["trace[1356016584] 'process raft request'  (duration: 155.452654ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:12:56.830605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.540644ms","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-25T02:12:56.830651Z","caller":"traceutil/trace.go:171","msg":"trace[1435499686] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:492; }","duration":"103.612445ms","start":"2026-02-25T02:12:56.727023Z","end":"2026-02-25T02:12:56.830636Z","steps":["trace[1435499686] 'agreement among raft nodes before linearized reading'  (duration: 103.500783ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:12:57.951399Z","caller":"traceutil/trace.go:171","msg":"trace[31257621] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"154.373857ms","start":"2026-02-25T02:12:57.796988Z","end":"2026-02-25T02:12:57.951362Z","steps":["trace[31257621] 'process raft request'  (duration: 154.115102ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:00.082313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.782914ms","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-02-25T02:13:00.082377Z","caller":"traceutil/trace.go:171","msg":"trace[1857848148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:522; }","duration":"125.880547ms","start":"2026-02-25T02:12:59.956481Z","end":"2026-02-25T02:13:00.082361Z","steps":["trace[1857848148] 'range keys from in-memory index tree'  (duration: 125.573559ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:00.082593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.499203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:13:00.082618Z","caller":"traceutil/trace.go:171","msg":"trace[648680599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:522; }","duration":"159.976084ms","start":"2026-02-25T02:12:59.922636Z","end":"2026-02-25T02:13:00.082612Z","steps":["trace[648680599] 'range keys from in-memory index tree'  (duration: 159.41914ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:13:00.092922Z","caller":"traceutil/trace.go:171","msg":"trace[676054374] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"126.778007ms","start":"2026-02-25T02:12:59.966122Z","end":"2026-02-25T02:13:00.0929Z","steps":["trace[676054374] 'process raft request'  (duration: 126.589904ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:02.994112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.003873ms","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-25T02:13:02.994249Z","caller":"traceutil/trace.go:171","msg":"trace[1819729197] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"106.22566ms","start":"2026-02-25T02:13:02.887994Z","end":"2026-02-25T02:13:02.994219Z","steps":["trace[1819729197] 'range keys from in-memory index tree'  (duration: 105.748827ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:13:17.23098Z","caller":"traceutil/trace.go:171","msg":"trace[789822951] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"165.013809ms","start":"2026-02-25T02:13:17.065906Z","end":"2026-02-25T02:13:17.23092Z","steps":["trace[789822951] 'process raft request'  (duration: 164.749293ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:13:18.30825Z","caller":"traceutil/trace.go:171","msg":"trace[1084164274] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"385.625532ms","start":"2026-02-25T02:13:17.922603Z","end":"2026-02-25T02:13:18.308229Z","steps":["trace[1084164274] 'read index received'  (duration: 385.53212ms)","trace[1084164274] 'applied index is now lower than readState.Index'  (duration: 92.342µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:13:18.308424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.224653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:13:18.308452Z","caller":"traceutil/trace.go:171","msg":"trace[109155613] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:679; }","duration":"280.315265ms","start":"2026-02-25T02:13:18.028127Z","end":"2026-02-25T02:13:18.308443Z","steps":["trace[109155613] 'agreement among raft nodes before linearized reading'  (duration: 280.229903ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:18.308646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.725569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T02:13:18.308666Z","caller":"traceutil/trace.go:171","msg":"trace[2036127115] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:679; }","duration":"155.784541ms","start":"2026-02-25T02:13:18.152875Z","end":"2026-02-25T02:13:18.308659Z","steps":["trace[2036127115] 'agreement among raft nodes before linearized reading'  (duration: 155.74255ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:18.308698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.321487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-02-25T02:13:18.308831Z","caller":"traceutil/trace.go:171","msg":"trace[416274594] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:679; }","duration":"102.507472ms","start":"2026-02-25T02:13:18.206291Z","end":"2026-02-25T02:13:18.308798Z","steps":["trace[416274594] 'agreement among raft nodes before linearized reading'  (duration: 102.103762ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:18.308945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.330469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:13:18.309081Z","caller":"traceutil/trace.go:171","msg":"trace[594430651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:679; }","duration":"386.483613ms","start":"2026-02-25T02:13:17.922542Z","end":"2026-02-25T02:13:18.309025Z","steps":["trace[594430651] 'agreement among raft nodes before linearized reading'  (duration: 386.36137ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:13:18.309148Z","caller":"traceutil/trace.go:171","msg":"trace[1101133477] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"632.225824ms","start":"2026-02-25T02:13:17.676131Z","end":"2026-02-25T02:13:18.308357Z","steps":["trace[1101133477] 'process raft request'  (duration: 631.971598ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:18.30929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:17.922515Z","time spent":"386.638616ms","remote":"127.0.0.1:58022","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-02-25T02:13:18.309485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:17.676105Z","time spent":"633.205518ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:673 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-02-25T02:13:18.562987Z","caller":"traceutil/trace.go:171","msg":"trace[1765070101] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"249.197704ms","start":"2026-02-25T02:13:18.313777Z","end":"2026-02-25T02:13:18.562975Z","steps":["trace[1765070101] 'process raft request'  (duration: 249.082901ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:13:18.566379Z","caller":"traceutil/trace.go:171","msg":"trace[664409569] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"250.591437ms","start":"2026-02-25T02:13:18.315766Z","end":"2026-02-25T02:13:18.566357Z","steps":["trace[664409569] 'process raft request'  (duration: 250.558967ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:13:18.566458Z","caller":"traceutil/trace.go:171","msg":"trace[1318822079] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"251.667502ms","start":"2026-02-25T02:13:18.314779Z","end":"2026-02-25T02:13:18.566446Z","steps":["trace[1318822079] 'process raft request'  (duration: 251.464788ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:44.943427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.122954ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591080015142309 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:756 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T02:13:44.943655Z","caller":"traceutil/trace.go:171","msg":"trace[35138975] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"217.778136ms","start":"2026-02-25T02:13:44.725845Z","end":"2026-02-25T02:13:44.943623Z","steps":["trace[35138975] 'process raft request'  (duration: 67.18753ms)","trace[35138975] 'compare'  (duration: 149.93272ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:13:45.723202Z","caller":"traceutil/trace.go:171","msg":"trace[1573199921] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"346.149682ms","start":"2026-02-25T02:13:45.377023Z","end":"2026-02-25T02:13:45.723173Z","steps":["trace[1573199921] 'process raft request'  (duration: 345.973668ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:45.723407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:45.376993Z","time spent":"346.292426ms","remote":"127.0.0.1:58290","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:757 > 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-02-25T02:13:47.057713Z","caller":"traceutil/trace.go:171","msg":"trace[497859627] linearizableReadLoop","detail":"{readStateIndex:795; appliedIndex:794; }","duration":"271.829822ms","start":"2026-02-25T02:13:46.785852Z","end":"2026-02-25T02:13:47.057682Z","steps":["trace[497859627] 'read index received'  (duration: 271.645928ms)","trace[497859627] 'applied index is now lower than readState.Index'  (duration: 182.594µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:13:47.057784Z","caller":"traceutil/trace.go:171","msg":"trace[1689912339] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"327.393236ms","start":"2026-02-25T02:13:46.730334Z","end":"2026-02-25T02:13:47.057727Z","steps":["trace[1689912339] 'process raft request'  (duration: 327.126939ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:47.058011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.106659ms","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-02-25T02:13:47.058083Z","caller":"traceutil/trace.go:171","msg":"trace[1721663243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:765; }","duration":"272.275764ms","start":"2026-02-25T02:13:46.785791Z","end":"2026-02-25T02:13:47.058067Z","steps":["trace[1721663243] 'agreement among raft nodes before linearized reading'  (duration: 271.999407ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:47.05815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:46.730303Z","time spent":"327.706963ms","remote":"127.0.0.1:58290","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:760 > 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-02-25T02:13:47.058302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.46492ms","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-02-25T02:13:47.058384Z","caller":"traceutil/trace.go:171","msg":"trace[1796473638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:765; }","duration":"110.545222ms","start":"2026-02-25T02:13:46.947816Z","end":"2026-02-25T02:13:47.058362Z","steps":["trace[1796473638] 'agreement among raft nodes before linearized reading'  (duration: 110.218135ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:47.058122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.026416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:13:47.058745Z","caller":"traceutil/trace.go:171","msg":"trace[1412993334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"135.771993ms","start":"2026-02-25T02:13:46.922953Z","end":"2026-02-25T02:13:47.058725Z","steps":["trace[1412993334] 'agreement among raft nodes before linearized reading'  (duration: 135.048386ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:47.649051Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142321,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T02:13:47.860308Z","caller":"traceutil/trace.go:171","msg":"trace[1739018289] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:796; }","duration":"711.867981ms","start":"2026-02-25T02:13:47.148409Z","end":"2026-02-25T02:13:47.860277Z","steps":["trace[1739018289] 'read index received'  (duration: 711.499452ms)","trace[1739018289] 'applied index is now lower than readState.Index'  (duration: 366.849µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:13:47.860485Z","caller":"traceutil/trace.go:171","msg":"trace[1992974922] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"794.1675ms","start":"2026-02-25T02:13:47.066248Z","end":"2026-02-25T02:13:47.860416Z","steps":["trace[1992974922] 'process raft request'  (duration: 793.845333ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:47.860643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.182208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:13:47.86079Z","caller":"traceutil/trace.go:171","msg":"trace[1437284550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"712.428875ms","start":"2026-02-25T02:13:47.148338Z","end":"2026-02-25T02:13:47.860767Z","steps":["trace[1437284550] 'agreement among raft nodes before linearized reading'  (duration: 712.160288ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:47.860849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:47.148305Z","time spent":"712.531747ms","remote":"127.0.0.1:58012","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-02-25T02:13:47.860939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:47.066217Z","time spent":"794.556649ms","remote":"127.0.0.1:58290","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:762 > 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-02-25T02:13:47.86113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.356292ms","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-25T02:13:47.861228Z","caller":"traceutil/trace.go:171","msg":"trace[1122881550] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:767; }","duration":"132.552117ms","start":"2026-02-25T02:13:47.728662Z","end":"2026-02-25T02:13:47.861214Z","steps":["trace[1122881550] 'agreement among raft nodes before linearized reading'  (duration: 132.28056ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:13:48.030729Z","caller":"traceutil/trace.go:171","msg":"trace[246364132] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"164.434775ms","start":"2026-02-25T02:13:47.866255Z","end":"2026-02-25T02:13:48.03069Z","steps":["trace[246364132] 'process raft request'  (duration: 85.412514ms)","trace[246364132] 'compare'  (duration: 78.874778ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:13:53.614539Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142368,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T02:13:53.831112Z","caller":"traceutil/trace.go:171","msg":"trace[589657774] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:812; }","duration":"717.249119ms","start":"2026-02-25T02:13:53.113839Z","end":"2026-02-25T02:13:53.831089Z","steps":["trace[589657774] 'read index received'  (duration: 717.062605ms)","trace[589657774] 'applied index is now lower than readState.Index'  (duration: 185.714µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:13:53.831162Z","caller":"traceutil/trace.go:171","msg":"trace[77267068] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"743.308779ms","start":"2026-02-25T02:13:53.08781Z","end":"2026-02-25T02:13:53.831119Z","steps":["trace[77267068] 'process raft request'  (duration: 743.142495ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:53.831353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.499185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-02-25T02:13:53.831403Z","caller":"traceutil/trace.go:171","msg":"trace[1652914475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:782; }","duration":"717.597598ms","start":"2026-02-25T02:13:53.113791Z","end":"2026-02-25T02:13:53.831389Z","steps":["trace[1652914475] 'agreement among raft nodes before linearized reading'  (duration: 717.377392ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:13:53.831443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:53.113771Z","time spent":"717.662529ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T02:13:53.831445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:53.087778Z","time spent":"743.547255ms","remote":"127.0.0.1:58290","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:777 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T02:13:59.421842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:13:59.92214Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:00.422461Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:00.921549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00067101s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T02:14:00.921649Z","caller":"traceutil/trace.go:171","msg":"trace[1632100869] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000840003s","start":"2026-02-25T02:13:58.920785Z","end":"2026-02-25T02:14:00.921625Z","steps":["trace[1632100869] 'agreement among raft nodes before linearized reading'  (duration: 2.00071028s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:00.921786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:58.920745Z","time spent":"2.001030017s","remote":"127.0.0.1:58012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 02:14:00 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:00.922607Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:01.423069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:01.923264Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:02.423583Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:02.921767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999884031s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:02.921874Z","caller":"traceutil/trace.go:171","msg":"trace[915997565] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000057954s","start":"2026-02-25T02:14:00.921792Z","end":"2026-02-25T02:14:02.92185Z","steps":["trace[915997565] 'agreement among raft nodes before linearized reading'  (duration: 1.99989022s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:02.921935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:00.921776Z","time spent":"2.000147547s","remote":"127.0.0.1:58022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T02:14:02.924396Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:03.424824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:03.620539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:58.624512Z","time spent":"4.996017382s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/25 02:14:03 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:03.925102Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:04.426267Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:04.855407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999390752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:04.856315Z","caller":"traceutil/trace.go:171","msg":"trace[123148879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000323065s","start":"2026-02-25T02:13:59.855918Z","end":"2026-02-25T02:14:04.856241Z","steps":["trace[123148879] 'agreement among raft nodes before linearized reading'  (duration: 4.999431453s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:04.856514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:59.855887Z","time spent":"5.000570751s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T02:14:04.927143Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:04.930777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000072434s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:04.930862Z","caller":"traceutil/trace.go:171","msg":"trace[765565799] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000210648s","start":"2026-02-25T02:14:02.930626Z","end":"2026-02-25T02:14:04.930836Z","steps":["trace[765565799] 'agreement among raft nodes before linearized reading'  (duration: 2.000105245s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:04.931138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:02.93061Z","time spent":"2.000511244s","remote":"127.0.0.1:58012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 02:14:04 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:05.094732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999442353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:05.094842Z","caller":"traceutil/trace.go:171","msg":"trace[2072785112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999667319s","start":"2026-02-25T02:14:00.095151Z","end":"2026-02-25T02:14:05.094818Z","steps":["trace[2072785112] 'agreement among raft nodes before linearized reading'  (duration: 4.999518445s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:05.094905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:00.095125Z","time spent":"4.999769002s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/02/25 02:14:05 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:05.428008Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142502,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:05.921138Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-02-25T02:14:06.421921Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142507,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:06.860606Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"8.2359757s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T02:14:06.930955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999876581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:06.931071Z","caller":"traceutil/trace.go:171","msg":"trace[1235591102] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000055675s","start":"2026-02-25T02:14:04.93099Z","end":"2026-02-25T02:14:06.931046Z","steps":["trace[1235591102] 'agreement among raft nodes before linearized reading'  (duration: 1.999911542s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:06.931117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:04.93095Z","time spent":"2.000159658s","remote":"127.0.0.1:58022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 02:14:06 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:07.737973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.945974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591080015142504 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:776 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T02:14:07.738923Z","caller":"traceutil/trace.go:171","msg":"trace[1364029115] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"4.812139994s","start":"2026-02-25T02:14:02.926754Z","end":"2026-02-25T02:14:07.738894Z","steps":["trace[1364029115] 'process raft request'  (duration: 4.811333045s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.739034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:02.926719Z","time spent":"4.812267347s","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" value_size:672 lease:7835591080015142449 >> failure:<>"}
{"level":"info","ts":"2026-02-25T02:14:07.73898Z","caller":"traceutil/trace.go:171","msg":"trace[1467181903] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"2.959976811s","start":"2026-02-25T02:14:04.778982Z","end":"2026-02-25T02:14:07.738959Z","steps":["trace[1467181903] 'process raft request'  (duration: 2.959159323s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.739478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:04.778953Z","time spent":"2.960311959s","remote":"127.0.0.1:58290","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:786 > 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-02-25T02:14:07.738956Z","caller":"traceutil/trace.go:171","msg":"trace[1399959388] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"6.784206171s","start":"2026-02-25T02:14:00.954697Z","end":"2026-02-25T02:14:07.738903Z","steps":["trace[1399959388] 'process raft request'  (duration: 6.194218183s)","trace[1399959388] 'compare'  (duration: 588.603766ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:07.739867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:00.954677Z","time spent":"6.785062652s","remote":"127.0.0.1:58290","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:776 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T02:14:07.791903Z","caller":"traceutil/trace.go:171","msg":"trace[1484398364] linearizableReadLoop","detail":"{readStateIndex:886; appliedIndex:881; }","duration":"1.870593981s","start":"2026-02-25T02:14:05.921264Z","end":"2026-02-25T02:14:07.791858Z","steps":["trace[1484398364] 'read index received'  (duration: 939.672925ms)","trace[1484398364] 'applied index is now lower than readState.Index'  (duration: 930.918906ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:07.792971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.053077945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-25T02:14:07.793008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.134905294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:07.793075Z","caller":"traceutil/trace.go:171","msg":"trace[1790719662] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:852; }","duration":"7.05329585s","start":"2026-02-25T02:14:00.739757Z","end":"2026-02-25T02:14:07.793053Z","steps":["trace[1790719662] 'agreement among raft nodes before linearized reading'  (duration: 7.053027143s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:07.793111Z","caller":"traceutil/trace.go:171","msg":"trace[1956132156] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:852; }","duration":"1.135090379s","start":"2026-02-25T02:14:06.657998Z","end":"2026-02-25T02:14:07.793088Z","steps":["trace[1956132156] 'agreement among raft nodes before linearized reading'  (duration: 1.134883594s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.793134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:00.739723Z","time spent":"7.053400032s","remote":"127.0.0.1:58362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:07.793167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:06.657962Z","time spent":"1.135195021s","remote":"127.0.0.1:58318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":28,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:07.793303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.787519978s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:07.793419Z","caller":"traceutil/trace.go:171","msg":"trace[647430426] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:852; }","duration":"4.787722253s","start":"2026-02-25T02:14:03.005669Z","end":"2026-02-25T02:14:07.793391Z","steps":["trace[647430426] 'agreement among raft nodes before linearized reading'  (duration: 4.787472787s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.793359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.65688076s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-25T02:14:07.793548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.386638531s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T02:14:07.793586Z","caller":"traceutil/trace.go:171","msg":"trace[810626561] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:852; }","duration":"2.386722362s","start":"2026-02-25T02:14:05.406855Z","end":"2026-02-25T02:14:07.793578Z","steps":["trace[810626561] 'agreement among raft nodes before linearized reading'  (duration: 2.386656891s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:07.793551Z","caller":"traceutil/trace.go:171","msg":"trace[1263848163] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:852; }","duration":"6.657134136s","start":"2026-02-25T02:14:01.136396Z","end":"2026-02-25T02:14:07.79353Z","steps":["trace[1263848163] 'agreement among raft nodes before linearized reading'  (duration: 6.65688821s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.793703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.202361109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:07.793736Z","caller":"traceutil/trace.go:171","msg":"trace[1768255397] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:0; response_revision:852; }","duration":"7.202437331s","start":"2026-02-25T02:14:00.591292Z","end":"2026-02-25T02:14:07.793729Z","steps":["trace[1768255397] 'agreement among raft nodes before linearized reading'  (duration: 7.20238683s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.793705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:01.136372Z","time spent":"6.65731551s","remote":"127.0.0.1:58480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:07.793772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:00.591265Z","time spent":"7.202499693s","remote":"127.0.0.1:58034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.209\" "}
{"level":"warn","ts":"2026-02-25T02:14:07.793895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.108574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T02:14:07.793942Z","caller":"traceutil/trace.go:171","msg":"trace[1501359502] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:852; }","duration":"554.190986ms","start":"2026-02-25T02:14:07.239739Z","end":"2026-02-25T02:14:07.79393Z","steps":["trace[1501359502] 'agreement among raft nodes before linearized reading'  (duration: 554.119684ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.793986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.239717Z","time spent":"554.260428ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:07.794011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.580816ms","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-02-25T02:14:07.79406Z","caller":"traceutil/trace.go:171","msg":"trace[1054929062] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:852; }","duration":"924.679718ms","start":"2026-02-25T02:14:06.869368Z","end":"2026-02-25T02:14:07.794048Z","steps":["trace[1054929062] 'agreement among raft nodes before linearized reading'  (duration: 924.510754ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.794091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:06.869343Z","time spent":"924.74183ms","remote":"127.0.0.1:58290","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-02-25T02:14:07.793485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:03.005639Z","time spent":"4.787835206s","remote":"127.0.0.1:58150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:07.793615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:05.406771Z","time spent":"2.386837075s","remote":"127.0.0.1:58180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:07.794281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.496779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T02:14:07.794321Z","caller":"traceutil/trace.go:171","msg":"trace[1777658312] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:852; }","duration":"663.580851ms","start":"2026-02-25T02:14:07.130729Z","end":"2026-02-25T02:14:07.794309Z","steps":["trace[1777658312] 'agreement among raft nodes before linearized reading'  (duration: 663.51601ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.794358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.130706Z","time spent":"663.636552ms","remote":"127.0.0.1:58214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:07.794547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.144964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-02-25T02:14:07.794582Z","caller":"traceutil/trace.go:171","msg":"trace[146296614] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:852; }","duration":"698.223946ms","start":"2026-02-25T02:14:07.09635Z","end":"2026-02-25T02:14:07.794573Z","steps":["trace[146296614] 'agreement among raft nodes before linearized reading'  (duration: 698.135433ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.794599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.576612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:07.794663Z","caller":"traceutil/trace.go:171","msg":"trace[161496587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:852; }","duration":"855.624623ms","start":"2026-02-25T02:14:06.939012Z","end":"2026-02-25T02:14:07.794636Z","steps":["trace[161496587] 'agreement among raft nodes before linearized reading'  (duration: 855.557991ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.794699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:06.938931Z","time spent":"855.761706ms","remote":"127.0.0.1:58012","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-02-25T02:14:07.79461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.096304Z","time spent":"698.299797ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T02:14:07.794991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.169694903s","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-02-25T02:14:07.795039Z","caller":"traceutil/trace.go:171","msg":"trace[1662395418] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:852; }","duration":"2.169793026s","start":"2026-02-25T02:14:05.625235Z","end":"2026-02-25T02:14:07.795028Z","steps":["trace[1662395418] 'agreement among raft nodes before linearized reading'  (duration: 2.167589383s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.795096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:05.625205Z","time spent":"2.169878438s","remote":"127.0.0.1:58290","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-02-25T02:14:07.795359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.88236772s","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-02-25T02:14:07.7954Z","caller":"traceutil/trace.go:171","msg":"trace[793557738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:852; }","duration":"7.882452592s","start":"2026-02-25T02:13:59.912938Z","end":"2026-02-25T02:14:07.795391Z","steps":["trace[793557738] 'agreement among raft nodes before linearized reading'  (duration: 7.879995174s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.795428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:59.912911Z","time spent":"7.882511184s","remote":"127.0.0.1:58290","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-02-25T02:14:07.796911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.192894686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:07.796973Z","caller":"traceutil/trace.go:171","msg":"trace[286157140] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:852; }","duration":"8.193022738s","start":"2026-02-25T02:13:59.603935Z","end":"2026-02-25T02:14:07.796958Z","steps":["trace[286157140] 'agreement among raft nodes before linearized reading'  (duration: 8.192877875s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.797008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:59.603915Z","time spent":"8.19308488s","remote":"127.0.0.1:58506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:07.797591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.93946699s","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-02-25T02:14:07.797635Z","caller":"traceutil/trace.go:171","msg":"trace[1057479619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:852; }","duration":"7.939529542s","start":"2026-02-25T02:13:59.858092Z","end":"2026-02-25T02:14:07.797622Z","steps":["trace[1057479619] 'agreement among raft nodes before linearized reading'  (duration: 7.934928983s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:07.797686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:13:59.858081Z","time spent":"7.939597214s","remote":"127.0.0.1:58290","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-02-25T02:14:08.141415Z","caller":"traceutil/trace.go:171","msg":"trace[1392785556] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"340.610221ms","start":"2026-02-25T02:14:07.80078Z","end":"2026-02-25T02:14:08.14139Z","steps":["trace[1392785556] 'process raft request'  (duration: 340.530489ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:08.141592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.800756Z","time spent":"340.748025ms","remote":"127.0.0.1:58290","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:843 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T02:14:08.141705Z","caller":"traceutil/trace.go:171","msg":"trace[951994555] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"341.194834ms","start":"2026-02-25T02:14:07.800491Z","end":"2026-02-25T02:14:08.141686Z","steps":["trace[951994555] 'process raft request'  (duration: 340.213981ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:08.141702Z","caller":"traceutil/trace.go:171","msg":"trace[697797363] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"341.105172ms","start":"2026-02-25T02:14:07.800555Z","end":"2026-02-25T02:14:08.14166Z","steps":["trace[697797363] 'process raft request'  (duration: 340.680343ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:08.141804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.800475Z","time spent":"341.278357ms","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" mod_revision:850 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" value_size:672 lease:7835591080015142449 >> failure:<request_range:<key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" > >"}
{"level":"warn","ts":"2026-02-25T02:14:08.141935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.800537Z","time spent":"341.277816ms","remote":"127.0.0.1:58290","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:847 > 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-25T02:14:08.141965Z","caller":"traceutil/trace.go:171","msg":"trace[1571200242] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"341.001869ms","start":"2026-02-25T02:14:07.800955Z","end":"2026-02-25T02:14:08.141957Z","steps":["trace[1571200242] 'process raft request'  (duration: 340.379845ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:08.141776Z","caller":"traceutil/trace.go:171","msg":"trace[1835356921] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"341.125333ms","start":"2026-02-25T02:14:07.800642Z","end":"2026-02-25T02:14:08.141768Z","steps":["trace[1835356921] 'process raft request'  (duration: 340.642392ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:08.142014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.800944Z","time spent":"341.04413ms","remote":"127.0.0.1:58290","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:844 > 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":"warn","ts":"2026-02-25T02:14:08.14217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.800638Z","time spent":"341.41932ms","remote":"127.0.0.1:58290","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:846 > 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-25T02:14:08.142746Z","caller":"traceutil/trace.go:171","msg":"trace[274587306] linearizableReadLoop","detail":"{readStateIndex:893; appliedIndex:886; }","duration":"135.830754ms","start":"2026-02-25T02:14:08.006878Z","end":"2026-02-25T02:14:08.142709Z","steps":["trace[274587306] 'read index received'  (duration: 45.878682ms)","trace[274587306] 'applied index is now lower than readState.Index'  (duration: 89.950442ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:14:08.143086Z","caller":"traceutil/trace.go:171","msg":"trace[671966642] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"340.290492ms","start":"2026-02-25T02:14:07.802782Z","end":"2026-02-25T02:14:08.143072Z","steps":["trace[671966642] 'process raft request'  (duration: 339.113844ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:08.144129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:07.802772Z","time spent":"341.254366ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:848 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-02-25T02:14:08.143375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.467839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:08.144376Z","caller":"traceutil/trace.go:171","msg":"trace[2130872460] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:858; }","duration":"137.516254ms","start":"2026-02-25T02:14:08.006841Z","end":"2026-02-25T02:14:08.144357Z","steps":["trace[2130872460] 'agreement among raft nodes before linearized reading'  (duration: 136.463479ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:08.146701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.802286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:08.147125Z","caller":"traceutil/trace.go:171","msg":"trace[1889396780] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:859; }","duration":"139.234386ms","start":"2026-02-25T02:14:08.007874Z","end":"2026-02-25T02:14:08.147108Z","steps":["trace[1889396780] 'agreement among raft nodes before linearized reading'  (duration: 138.719633ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:12.6746Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:13.174769Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:13.675718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:14.176713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:14.677604Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:15.178249Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:15.678959Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:15.923602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999761098s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T02:14:15.923667Z","caller":"traceutil/trace.go:171","msg":"trace[1373994236] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999843499s","start":"2026-02-25T02:14:13.923809Z","end":"2026-02-25T02:14:15.923652Z","steps":["trace[1373994236] 'agreement among raft nodes before linearized reading'  (duration: 1.999759817s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:15.923705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:13.923709Z","time spent":"1.999984642s","remote":"127.0.0.1:58012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 02:14:15 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:16.179236Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:16.680084Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:17.16048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:12.161515Z","time spent":"4.998955572s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-02-25T02:14:17.173652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999508295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T02:14:17.173821Z","caller":"traceutil/trace.go:171","msg":"trace[1601874701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999886395s","start":"2026-02-25T02:14:12.173903Z","end":"2026-02-25T02:14:17.17379Z","steps":["trace[1601874701] 'agreement among raft nodes before linearized reading'  (duration: 4.999542406s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:17.173926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:12.173882Z","time spent":"4.999995977s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
2026/02/25 02:14:17 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:17.175593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.00010516s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T02:14:17.175649Z","caller":"traceutil/trace.go:171","msg":"trace[790903862] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.000186262s","start":"2026-02-25T02:14:12.175449Z","end":"2026-02-25T02:14:17.175635Z","steps":["trace[790903862] 'agreement among raft nodes before linearized reading'  (duration: 5.000121961s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:17.175697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:12.17544Z","time spent":"5.000247384s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/25 02:14:17 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:17.180958Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:17.681246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:17.924499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000429483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T02:14:17.924608Z","caller":"traceutil/trace.go:171","msg":"trace[258752550] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000617948s","start":"2026-02-25T02:14:15.923965Z","end":"2026-02-25T02:14:17.924583Z","steps":["trace[258752550] 'agreement among raft nodes before linearized reading'  (duration: 2.000463834s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:17.924669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:15.92394Z","time spent":"2.00071439s","remote":"127.0.0.1:58022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 02:14:17 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:18.181998Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:18.683251Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142556,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:19.131887Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"6.970197564s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T02:14:19.147192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000098313s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:19.147273Z","caller":"traceutil/trace.go:171","msg":"trace[1489967326] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000226446s","start":"2026-02-25T02:14:17.147026Z","end":"2026-02-25T02:14:19.147252Z","steps":["trace[1489967326] 'agreement among raft nodes before linearized reading'  (duration: 2.000122174s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.147322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:17.147003Z","time spent":"2.000310439s","remote":"127.0.0.1:58012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T02:14:19.201695Z","caller":"traceutil/trace.go:171","msg":"trace[1739830931] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"1.449117513s","start":"2026-02-25T02:14:17.752536Z","end":"2026-02-25T02:14:19.201654Z","steps":["trace[1739830931] 'process raft request'  (duration: 1.448713763s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.201887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:17.752521Z","time spent":"1.449268437s","remote":"127.0.0.1:58290","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:849 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T02:14:19.201928Z","caller":"traceutil/trace.go:171","msg":"trace[1075947085] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"1.152998541s","start":"2026-02-25T02:14:18.048894Z","end":"2026-02-25T02:14:19.201893Z","steps":["trace[1075947085] 'process raft request'  (duration: 1.152613122s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:19.201901Z","caller":"traceutil/trace.go:171","msg":"trace[810759480] linearizableReadLoop","detail":"{readStateIndex:905; appliedIndex:902; }","duration":"7.02779589s","start":"2026-02-25T02:14:12.173958Z","end":"2026-02-25T02:14:19.201754Z","steps":["trace[810759480] 'read index received'  (duration: 6.958283502s)","trace[810759480] 'applied index is now lower than readState.Index'  (duration: 69.511078ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:19.202093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:18.048859Z","time spent":"1.153146725s","remote":"127.0.0.1:58290","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:851 > 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-02-25T02:14:19.202307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.270249044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T02:14:19.202345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.501218773s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:19.202395Z","caller":"traceutil/trace.go:171","msg":"trace[1402570393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:869; }","duration":"1.270364887s","start":"2026-02-25T02:14:17.932009Z","end":"2026-02-25T02:14:19.202374Z","steps":["trace[1402570393] 'agreement among raft nodes before linearized reading'  (duration: 1.270216543s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:19.202414Z","caller":"traceutil/trace.go:171","msg":"trace[563570118] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:869; }","duration":"1.501337126s","start":"2026-02-25T02:14:17.701059Z","end":"2026-02-25T02:14:19.202396Z","steps":["trace[563570118] 'agreement among raft nodes before linearized reading'  (duration: 1.501214333s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.202437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.027291687s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-25T02:14:19.202453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:17.701033Z","time spent":"1.501411118s","remote":"127.0.0.1:58250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:19.20245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:17.932Z","time spent":"1.270439838s","remote":"127.0.0.1:58022","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-02-25T02:14:19.202466Z","caller":"traceutil/trace.go:171","msg":"trace[358323041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:869; }","duration":"7.027334468s","start":"2026-02-25T02:14:12.175125Z","end":"2026-02-25T02:14:19.202459Z","steps":["trace[358323041] 'agreement among raft nodes before linearized reading'  (duration: 7.027234755s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.202482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:12.175119Z","time spent":"7.027360259s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T02:14:19.202538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.37950304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:19.202555Z","caller":"traceutil/trace.go:171","msg":"trace[2138653684] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:869; }","duration":"4.379557151s","start":"2026-02-25T02:14:14.822993Z","end":"2026-02-25T02:14:19.20255Z","steps":["trace[2138653684] 'agreement among raft nodes before linearized reading'  (duration: 4.37952497s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.202569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:14.822975Z","time spent":"4.379590081s","remote":"127.0.0.1:58228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:19.202622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455397232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:19.202672Z","caller":"traceutil/trace.go:171","msg":"trace[349794704] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:869; }","duration":"1.455505105s","start":"2026-02-25T02:14:17.747154Z","end":"2026-02-25T02:14:19.20266Z","steps":["trace[349794704] 'agreement among raft nodes before linearized reading'  (duration: 1.455437693s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.202691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.80704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T02:14:19.202734Z","caller":"traceutil/trace.go:171","msg":"trace[1261233868] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:869; }","duration":"909.897222ms","start":"2026-02-25T02:14:18.292826Z","end":"2026-02-25T02:14:19.202723Z","steps":["trace[1261233868] 'agreement among raft nodes before linearized reading'  (duration: 909.81995ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.202625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.40889582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-02-25T02:14:19.202777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.274968566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-25T02:14:19.202822Z","caller":"traceutil/trace.go:171","msg":"trace[522138978] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1; range_end:; response_count:1; response_revision:869; }","duration":"1.275054998s","start":"2026-02-25T02:14:17.927759Z","end":"2026-02-25T02:14:19.202814Z","steps":["trace[522138978] 'agreement among raft nodes before linearized reading'  (duration: 1.274962415s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.202853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:17.927736Z","time spent":"1.275111228s","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" "}
{"level":"warn","ts":"2026-02-25T02:14:19.202765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:18.292802Z","time spent":"909.954644ms","remote":"127.0.0.1:54846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "}
{"level":"info","ts":"2026-02-25T02:14:19.202842Z","caller":"traceutil/trace.go:171","msg":"trace[165040579] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:869; }","duration":"4.409227987s","start":"2026-02-25T02:14:14.793576Z","end":"2026-02-25T02:14:19.202804Z","steps":["trace[165040579] 'agreement among raft nodes before linearized reading'  (duration: 4.408724986s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.202966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:14.793553Z","time spent":"4.409399111s","remote":"127.0.0.1:58526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":89,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:19.202703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:17.747126Z","time spent":"1.455568586s","remote":"127.0.0.1:58172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:19.203387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.0282763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-02-25T02:14:19.203454Z","caller":"traceutil/trace.go:171","msg":"trace[388071229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:869; }","duration":"7.028393613s","start":"2026-02-25T02:14:12.175051Z","end":"2026-02-25T02:14:19.203445Z","steps":["trace[388071229] 'agreement among raft nodes before linearized reading'  (duration: 7.027160894s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.208991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:12.175022Z","time spent":"7.033926127s","remote":"127.0.0.1:58290","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-02-25T02:14:19.347272Z","caller":"traceutil/trace.go:171","msg":"trace[366448233] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"141.055675ms","start":"2026-02-25T02:14:19.20522Z","end":"2026-02-25T02:14:19.346276Z","steps":["trace[366448233] 'process raft request'  (duration: 72.03964ms)","trace[366448233] 'compare'  (duration: 68.735018ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:14:19.354091Z","caller":"traceutil/trace.go:171","msg":"trace[477639765] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"145.329908ms","start":"2026-02-25T02:14:19.208716Z","end":"2026-02-25T02:14:19.354046Z","steps":["trace[477639765] 'process raft request'  (duration: 145.087133ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:19.354682Z","caller":"traceutil/trace.go:171","msg":"trace[1915907344] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"145.83547ms","start":"2026-02-25T02:14:19.208821Z","end":"2026-02-25T02:14:19.354657Z","steps":["trace[1915907344] 'process raft request'  (duration: 145.163084ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:19.354746Z","caller":"traceutil/trace.go:171","msg":"trace[1800856460] linearizableReadLoop","detail":"{readStateIndex:910; appliedIndex:905; }","duration":"145.145603ms","start":"2026-02-25T02:14:19.209551Z","end":"2026-02-25T02:14:19.354697Z","steps":["trace[1800856460] 'read index received'  (duration: 67.800357ms)","trace[1800856460] 'applied index is now lower than readState.Index'  (duration: 77.344016ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:14:19.354811Z","caller":"traceutil/trace.go:171","msg":"trace[1043553438] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"143.126586ms","start":"2026-02-25T02:14:19.211664Z","end":"2026-02-25T02:14:19.354791Z","steps":["trace[1043553438] 'process raft request'  (duration: 142.982012ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:19.354865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.287317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:19.354913Z","caller":"traceutil/trace.go:171","msg":"trace[1018587349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:875; }","duration":"145.376909ms","start":"2026-02-25T02:14:19.209522Z","end":"2026-02-25T02:14:19.354899Z","steps":["trace[1018587349] 'agreement among raft nodes before linearized reading'  (duration: 145.268857ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:19.35493Z","caller":"traceutil/trace.go:171","msg":"trace[390862468] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"146.051636ms","start":"2026-02-25T02:14:19.208871Z","end":"2026-02-25T02:14:19.354923Z","steps":["trace[390862468] 'process raft request'  (duration: 145.594925ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:19.354844Z","caller":"traceutil/trace.go:171","msg":"trace[1777152884] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"145.874092ms","start":"2026-02-25T02:14:19.208915Z","end":"2026-02-25T02:14:19.354789Z","steps":["trace[1777152884] 'process raft request'  (duration: 145.685027ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:19.510993Z","caller":"traceutil/trace.go:171","msg":"trace[1820415949] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"152.382398ms","start":"2026-02-25T02:14:19.358571Z","end":"2026-02-25T02:14:19.510953Z","steps":["trace[1820415949] 'process raft request'  (duration: 152.135572ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:20.752015Z","caller":"traceutil/trace.go:171","msg":"trace[2144773535] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"131.654539ms","start":"2026-02-25T02:14:20.62025Z","end":"2026-02-25T02:14:20.751905Z","steps":["trace[2144773535] 'process raft request'  (duration: 46.215796ms)","trace[2144773535] 'compare'  (duration: 84.9093ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:27.902923Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:28.403548Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:28.903718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:29.4044Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:29.904783Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:29.922549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999838693s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:29.92266Z","caller":"traceutil/trace.go:171","msg":"trace[908424630] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999995906s","start":"2026-02-25T02:14:27.92263Z","end":"2026-02-25T02:14:29.922626Z","steps":["trace[908424630] 'agreement among raft nodes before linearized reading'  (duration: 1.999877073s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:29.922711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:27.922605Z","time spent":"2.000096229s","remote":"127.0.0.1:58022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T02:14:30.405793Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:30.906433Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:31.407585Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:31.542023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999991018s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:31.542116Z","caller":"traceutil/trace.go:171","msg":"trace[352427351] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000164191s","start":"2026-02-25T02:14:29.541931Z","end":"2026-02-25T02:14:31.542095Z","steps":["trace[352427351] 'agreement among raft nodes before linearized reading'  (duration: 2.000039948s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:31.542161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:29.541912Z","time spent":"2.000239664s","remote":"127.0.0.1:58012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T02:14:31.908266Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:31.93214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00007928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-02-25T02:14:31.932251Z","caller":"traceutil/trace.go:171","msg":"trace[908239382] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000230712s","start":"2026-02-25T02:14:29.931995Z","end":"2026-02-25T02:14:31.932226Z","steps":["trace[908239382] 'agreement among raft nodes before linearized reading'  (duration: 2.00009492s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:31.932303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:29.931984Z","time spent":"2.000310355s","remote":"127.0.0.1:58022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 02:14:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:32.39629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:27.397213Z","time spent":"4.999070381s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/02/25 02:14:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:32.40216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000078144s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:32.402219Z","caller":"traceutil/trace.go:171","msg":"trace[630894679] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"5.000167307s","start":"2026-02-25T02:14:27.402035Z","end":"2026-02-25T02:14:32.402203Z","steps":["trace[630894679] 'agreement among raft nodes before linearized reading'  (duration: 5.000090495s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:32.4023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:27.402026Z","time spent":"5.000266739s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
2026/02/25 02:14:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:32.402528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999362468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:32.402676Z","caller":"traceutil/trace.go:171","msg":"trace[1302905660] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999580123s","start":"2026-02-25T02:14:27.403066Z","end":"2026-02-25T02:14:32.402646Z","steps":["trace[1302905660] 'agreement among raft nodes before linearized reading'  (duration: 4.999369319s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:32.402796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:27.403057Z","time spent":"4.999724746s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/02/25 02:14:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T02:14:32.408835Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:32.909025Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:33.410048Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:33.910388Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835591080015142629,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T02:14:33.939764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999986335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T02:14:33.939876Z","caller":"traceutil/trace.go:171","msg":"trace[295594133] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000155809s","start":"2026-02-25T02:14:31.939695Z","end":"2026-02-25T02:14:33.939851Z","steps":["trace[295594133] 'agreement among raft nodes before linearized reading'  (duration: 2.000013896s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:33.939941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:31.939675Z","time spent":"2.000255832s","remote":"127.0.0.1:58012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T02:14:34.354021Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"6.95662943s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T02:14:34.371223Z","caller":"traceutil/trace.go:171","msg":"trace[1615326012] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"6.972714999s","start":"2026-02-25T02:14:27.398485Z","end":"2026-02-25T02:14:34.3712Z","steps":["trace[1615326012] 'process raft request'  (duration: 6.972655308s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.371398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:27.398478Z","time spent":"6.972848532s","remote":"127.0.0.1:58290","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:891 > 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-02-25T02:14:34.37154Z","caller":"traceutil/trace.go:171","msg":"trace[1318813698] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"6.973503788s","start":"2026-02-25T02:14:27.398027Z","end":"2026-02-25T02:14:34.371531Z","steps":["trace[1318813698] 'process raft request'  (duration: 6.972976635s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.371611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:27.398014Z","time spent":"6.97357406s","remote":"127.0.0.1:58290","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:890 > 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-25T02:14:34.371715Z","caller":"traceutil/trace.go:171","msg":"trace[89973314] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"4.780927293s","start":"2026-02-25T02:14:29.59078Z","end":"2026-02-25T02:14:34.371708Z","steps":["trace[89973314] 'process raft request'  (duration: 4.780747708s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.371777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:29.590761Z","time spent":"4.780995534s","remote":"127.0.0.1:58290","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:869 > 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-02-25T02:14:34.371716Z","caller":"traceutil/trace.go:171","msg":"trace[208862106] linearizableReadLoop","detail":"{readStateIndex:937; appliedIndex:932; }","duration":"6.969600243s","start":"2026-02-25T02:14:27.402058Z","end":"2026-02-25T02:14:34.371658Z","steps":["trace[208862106] 'read index received'  (duration: 6.952229844s)","trace[208862106] 'applied index is now lower than readState.Index'  (duration: 17.369109ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:34.372035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.765012716s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:34.372091Z","caller":"traceutil/trace.go:171","msg":"trace[790722454] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:898; }","duration":"6.765113169s","start":"2026-02-25T02:14:27.606969Z","end":"2026-02-25T02:14:34.372082Z","steps":["trace[790722454] 'agreement among raft nodes before linearized reading'  (duration: 6.765038127s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.372129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:27.606939Z","time spent":"6.765181911s","remote":"127.0.0.1:50878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:34.372268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.945261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:34.372319Z","caller":"traceutil/trace.go:171","msg":"trace[2086650513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:898; }","duration":"431.042263ms","start":"2026-02-25T02:14:33.941269Z","end":"2026-02-25T02:14:34.372312Z","steps":["trace[2086650513] 'agreement among raft nodes before linearized reading'  (duration: 430.979152ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.37231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.867962713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T02:14:34.372417Z","caller":"traceutil/trace.go:171","msg":"trace[1249447361] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:898; }","duration":"4.868129468s","start":"2026-02-25T02:14:29.504267Z","end":"2026-02-25T02:14:34.372396Z","steps":["trace[1249447361] 'agreement among raft nodes before linearized reading'  (duration: 4.867906372s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.372298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.780677698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-25T02:14:34.372554Z","caller":"traceutil/trace.go:171","msg":"trace[908358141] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:898; }","duration":"3.780956105s","start":"2026-02-25T02:14:30.591549Z","end":"2026-02-25T02:14:34.372505Z","steps":["trace[908358141] 'agreement among raft nodes before linearized reading'  (duration: 3.780507714s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.372472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:29.504244Z","time spent":"4.868218369s","remote":"127.0.0.1:58366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":68,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "}
{"level":"warn","ts":"2026-02-25T02:14:34.372654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:30.591526Z","time spent":"3.781116409s","remote":"127.0.0.1:58034","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":"warn","ts":"2026-02-25T02:14:34.372354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:33.941246Z","time spent":"431.102525ms","remote":"127.0.0.1:58022","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-02-25T02:14:34.372814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.44690705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" ","response":"range_response_count:1 size:774"}
{"level":"info","ts":"2026-02-25T02:14:34.372867Z","caller":"traceutil/trace.go:171","msg":"trace[1826979966] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1; range_end:; response_count:1; response_revision:898; }","duration":"4.446988642s","start":"2026-02-25T02:14:29.925862Z","end":"2026-02-25T02:14:34.37285Z","steps":["trace[1826979966] 'agreement among raft nodes before linearized reading'  (duration: 4.446271044s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.372907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:29.925843Z","time spent":"4.447054964s","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18975b8dc98757e1\" "}
{"level":"info","ts":"2026-02-25T02:14:34.372554Z","caller":"traceutil/trace.go:171","msg":"trace[505914229] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"4.857590043s","start":"2026-02-25T02:14:29.514164Z","end":"2026-02-25T02:14:34.371754Z","steps":["trace[505914229] 'process raft request'  (duration: 4.857001818s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.373232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:29.514133Z","time spent":"4.859050599s","remote":"127.0.0.1:58290","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:868 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T02:14:34.666384Z","caller":"traceutil/trace.go:171","msg":"trace[2066500796] linearizableReadLoop","detail":"{readStateIndex:939; appliedIndex:937; }","duration":"288.73015ms","start":"2026-02-25T02:14:34.377625Z","end":"2026-02-25T02:14:34.666355Z","steps":["trace[2066500796] 'read index received'  (duration: 220.329629ms)","trace[2066500796] 'applied index is now lower than readState.Index'  (duration: 68.399061ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:14:34.66643Z","caller":"traceutil/trace.go:171","msg":"trace[892125075] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"289.469558ms","start":"2026-02-25T02:14:34.376924Z","end":"2026-02-25T02:14:34.666394Z","steps":["trace[892125075] 'process raft request'  (duration: 289.238743ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.666714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.062918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7045"}
{"level":"info","ts":"2026-02-25T02:14:34.666809Z","caller":"traceutil/trace.go:171","msg":"trace[1558962613] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:899; }","duration":"289.218751ms","start":"2026-02-25T02:14:34.377548Z","end":"2026-02-25T02:14:34.666767Z","steps":["trace[1558962613] 'agreement among raft nodes before linearized reading'  (duration: 288.940264ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:34.716866Z","caller":"traceutil/trace.go:171","msg":"trace[1973928953] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"110.471027ms","start":"2026-02-25T02:14:34.606357Z","end":"2026-02-25T02:14:34.716828Z","steps":["trace[1973928953] 'process raft request'  (duration: 102.546355ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.717444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.485914ms","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-02-25T02:14:34.71752Z","caller":"traceutil/trace.go:171","msg":"trace[865212750] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:900; }","duration":"312.626207ms","start":"2026-02-25T02:14:34.404879Z","end":"2026-02-25T02:14:34.717506Z","steps":["trace[865212750] 'agreement among raft nodes before linearized reading'  (duration: 312.103874ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.717593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:34.404858Z","time spent":"312.710839ms","remote":"127.0.0.1:58290","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-02-25T02:14:34.717738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.929028ms","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-25T02:14:34.71784Z","caller":"traceutil/trace.go:171","msg":"trace[699079586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:900; }","duration":"319.047441ms","start":"2026-02-25T02:14:34.398772Z","end":"2026-02-25T02:14:34.717819Z","steps":["trace[699079586] 'agreement among raft nodes before linearized reading'  (duration: 318.834077ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.717857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.160855ms","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-25T02:14:34.717975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:34.39876Z","time spent":"319.161804ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-25T02:14:34.717981Z","caller":"traceutil/trace.go:171","msg":"trace[1043427448] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:900; }","duration":"312.314809ms","start":"2026-02-25T02:14:34.405616Z","end":"2026-02-25T02:14:34.717931Z","steps":["trace[1043427448] 'agreement among raft nodes before linearized reading'  (duration: 311.812597ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.718036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:34.405596Z","time spent":"312.431441ms","remote":"127.0.0.1:58290","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-02-25T02:14:34.718058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.491486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:14:34.718149Z","caller":"traceutil/trace.go:171","msg":"trace[849943338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:900; }","duration":"337.600379ms","start":"2026-02-25T02:14:34.380536Z","end":"2026-02-25T02:14:34.718137Z","steps":["trace[849943338] 'agreement among raft nodes before linearized reading'  (duration: 337.443665ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:34.718204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:34.380527Z","time spent":"337.66733ms","remote":"127.0.0.1:58012","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-02-25T02:14:35.047377Z","caller":"traceutil/trace.go:171","msg":"trace[363388913] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"246.418969ms","start":"2026-02-25T02:14:34.800926Z","end":"2026-02-25T02:14:35.047345Z","steps":["trace[363388913] 'process raft request'  (duration: 246.193244ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:35.202178Z","caller":"traceutil/trace.go:171","msg":"trace[68974880] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"397.542436ms","start":"2026-02-25T02:14:34.804577Z","end":"2026-02-25T02:14:35.202119Z","steps":["trace[68974880] 'process raft request'  (duration: 397.367013ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:35.202467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:34.804567Z","time spent":"397.809963ms","remote":"127.0.0.1:58208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7030,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:901 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:6972 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >"}
{"level":"warn","ts":"2026-02-25T02:14:36.643454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.152843ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591080015142659 > lease_revoke:<id:6cbd9c9291859eaf>","response":"size:28"}
{"level":"info","ts":"2026-02-25T02:14:36.643582Z","caller":"traceutil/trace.go:171","msg":"trace[376472706] linearizableReadLoop","detail":"{readStateIndex:948; appliedIndex:947; }","duration":"265.337425ms","start":"2026-02-25T02:14:36.378225Z","end":"2026-02-25T02:14:36.643562Z","steps":["trace[376472706] 'read index received'  (duration: 53.861µs)","trace[376472706] 'applied index is now lower than readState.Index'  (duration: 265.281624ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:36.643812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.585081ms","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-02-25T02:14:36.643838Z","caller":"traceutil/trace.go:171","msg":"trace[1430585363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:907; }","duration":"265.663793ms","start":"2026-02-25T02:14:36.378166Z","end":"2026-02-25T02:14:36.64383Z","steps":["trace[1430585363] 'agreement among raft nodes before linearized reading'  (duration: 265.49908ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:36.643969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.679663ms","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-02-25T02:14:36.644057Z","caller":"traceutil/trace.go:171","msg":"trace[1084025695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:907; }","duration":"265.824207ms","start":"2026-02-25T02:14:36.378212Z","end":"2026-02-25T02:14:36.644036Z","steps":["trace[1084025695] 'agreement among raft nodes before linearized reading'  (duration: 265.555521ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:36.94106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.201957ms","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-02-25T02:14:36.941148Z","caller":"traceutil/trace.go:171","msg":"trace[1323557489] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:909; }","duration":"141.365732ms","start":"2026-02-25T02:14:36.799764Z","end":"2026-02-25T02:14:36.94113Z","steps":["trace[1323557489] 'range keys from in-memory index tree'  (duration: 140.954212ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:36.941297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.441702ms","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-02-25T02:14:36.94137Z","caller":"traceutil/trace.go:171","msg":"trace[939153375] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:909; }","duration":"196.551795ms","start":"2026-02-25T02:14:36.744802Z","end":"2026-02-25T02:14:36.941354Z","steps":["trace[939153375] 'range keys from in-memory index tree'  (duration: 196.305939ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:36.941426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.776362ms","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-25T02:14:36.941448Z","caller":"traceutil/trace.go:171","msg":"trace[73570532] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:909; }","duration":"141.820813ms","start":"2026-02-25T02:14:36.79962Z","end":"2026-02-25T02:14:36.94144Z","steps":["trace[73570532] 'range keys from in-memory index tree'  (duration: 141.690359ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:39.403238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.553134ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591080015142683 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-252j2.18975b9630bbc904\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-252j2.18975b9630bbc904\" value_size:723 lease:7835591080015142449 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T02:14:39.403498Z","caller":"traceutil/trace.go:171","msg":"trace[382424822] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"357.042438ms","start":"2026-02-25T02:14:39.046434Z","end":"2026-02-25T02:14:39.403476Z","steps":["trace[382424822] 'process raft request'  (duration: 356.967067ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:39.403488Z","caller":"traceutil/trace.go:171","msg":"trace[1420361491] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"384.872699ms","start":"2026-02-25T02:14:39.018562Z","end":"2026-02-25T02:14:39.403435Z","steps":["trace[1420361491] 'process raft request'  (duration: 113.039548ms)","trace[1420361491] 'compare'  (duration: 271.397621ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:39.403584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:39.046412Z","time spent":"357.1261ms","remote":"127.0.0.1:58290","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:911 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-25T02:14:39.403688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:39.018539Z","time spent":"385.041704ms","remote":"127.0.0.1:58090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":816,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-252j2.18975b9630bbc904\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-nodeplugin-252j2.18975b9630bbc904\" value_size:723 lease:7835591080015142449 >> failure:<>"}
{"level":"info","ts":"2026-02-25T02:14:39.403903Z","caller":"traceutil/trace.go:171","msg":"trace[256799578] linearizableReadLoop","detail":"{readStateIndex:957; appliedIndex:956; }","duration":"361.880394ms","start":"2026-02-25T02:14:39.041965Z","end":"2026-02-25T02:14:39.403845Z","steps":["trace[256799578] 'read index received'  (duration: 89.759746ms)","trace[256799578] 'applied index is now lower than readState.Index'  (duration: 272.116498ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:39.404302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.495538ms","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-02-25T02:14:39.404344Z","caller":"traceutil/trace.go:171","msg":"trace[1522714136] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:917; }","duration":"386.554789ms","start":"2026-02-25T02:14:39.017776Z","end":"2026-02-25T02:14:39.404331Z","steps":["trace[1522714136] 'agreement among raft nodes before linearized reading'  (duration: 386.179751ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:39.404375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:39.01777Z","time spent":"386.59824ms","remote":"127.0.0.1:58290","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-02-25T02:14:40.96975Z","caller":"traceutil/trace.go:171","msg":"trace[1616693498] linearizableReadLoop","detail":"{readStateIndex:961; appliedIndex:960; }","duration":"349.597548ms","start":"2026-02-25T02:14:40.620121Z","end":"2026-02-25T02:14:40.969718Z","steps":["trace[1616693498] 'read index received'  (duration: 330.960459ms)","trace[1616693498] 'applied index is now lower than readState.Index'  (duration: 18.635349ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:40.969909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:40.593245Z","time spent":"376.642311ms","remote":"127.0.0.1:58034","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-25T02:14:40.970136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.989599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4742"}
{"level":"warn","ts":"2026-02-25T02:14:40.970229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.048199ms","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-02-25T02:14:40.970278Z","caller":"traceutil/trace.go:171","msg":"trace[2120068493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:919; }","duration":"159.148322ms","start":"2026-02-25T02:14:40.811115Z","end":"2026-02-25T02:14:40.970263Z","steps":["trace[2120068493] 'agreement among raft nodes before linearized reading'  (duration: 158.941157ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:14:40.970269Z","caller":"traceutil/trace.go:171","msg":"trace[1917003043] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:919; }","duration":"350.212073ms","start":"2026-02-25T02:14:40.620036Z","end":"2026-02-25T02:14:40.970248Z","steps":["trace[1917003043] 'agreement among raft nodes before linearized reading'  (duration: 349.908726ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:40.970275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.41088ms","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-02-25T02:14:40.970327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:14:40.620025Z","time spent":"350.287266ms","remote":"127.0.0.1:58192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4765,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-02-25T02:14:40.970364Z","caller":"traceutil/trace.go:171","msg":"trace[547563679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:919; }","duration":"285.568934ms","start":"2026-02-25T02:14:40.684774Z","end":"2026-02-25T02:14:40.970343Z","steps":["trace[547563679] 'agreement among raft nodes before linearized reading'  (duration: 285.204525ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:43.375213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.199297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-252j2\" ","response":"range_response_count:1 size:10928"}
{"level":"info","ts":"2026-02-25T02:14:43.375319Z","caller":"traceutil/trace.go:171","msg":"trace[1698625504] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-252j2; range_end:; response_count:1; response_revision:942; }","duration":"230.340131ms","start":"2026-02-25T02:14:43.144954Z","end":"2026-02-25T02:14:43.375295Z","steps":["trace[1698625504] 'range keys from in-memory index tree'  (duration: 229.973441ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:56.465524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.977753ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7835591080015142901 > lease_revoke:<id:6cbd9c9291859f22>","response":"size:28"}
{"level":"info","ts":"2026-02-25T02:14:56.4657Z","caller":"traceutil/trace.go:171","msg":"trace[1729611168] linearizableReadLoop","detail":"{readStateIndex:1076; appliedIndex:1075; }","duration":"123.830709ms","start":"2026-02-25T02:14:56.341841Z","end":"2026-02-25T02:14:56.465671Z","steps":["trace[1729611168] 'read index received'  (duration: 56.291µs)","trace[1729611168] 'applied index is now lower than readState.Index'  (duration: 123.771878ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:14:56.466037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.156056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"}
{"level":"info","ts":"2026-02-25T02:14:56.46611Z","caller":"traceutil/trace.go:171","msg":"trace[1117127613] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1031; }","duration":"102.262929ms","start":"2026-02-25T02:14:56.363824Z","end":"2026-02-25T02:14:56.466086Z","steps":["trace[1117127613] 'agreement among raft nodes before linearized reading'  (duration: 101.992902ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:14:56.466628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.787633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-02-25T02:14:56.466701Z","caller":"traceutil/trace.go:171","msg":"trace[1355588326] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1031; }","duration":"124.916065ms","start":"2026-02-25T02:14:56.341768Z","end":"2026-02-25T02:14:56.466684Z","steps":["trace[1355588326] 'agreement among raft nodes before linearized reading'  (duration: 123.996953ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:17:54.502833Z","caller":"traceutil/trace.go:171","msg":"trace[537355155] linearizableReadLoop","detail":"{readStateIndex:1864; appliedIndex:1863; }","duration":"436.461929ms","start":"2026-02-25T02:17:54.06634Z","end":"2026-02-25T02:17:54.502801Z","steps":["trace[537355155] 'read index received'  (duration: 436.1145ms)","trace[537355155] 'applied index is now lower than readState.Index'  (duration: 346.259µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:17:54.503047Z","caller":"traceutil/trace.go:171","msg":"trace[776797158] transaction","detail":"{read_only:false; response_revision:1783; number_of_response:1; }","duration":"515.936533ms","start":"2026-02-25T02:17:53.98705Z","end":"2026-02-25T02:17:54.502987Z","steps":["trace[776797158] 'process raft request'  (duration: 515.560784ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:54.503168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.795217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"}
{"level":"info","ts":"2026-02-25T02:17:54.503214Z","caller":"traceutil/trace.go:171","msg":"trace[881667929] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1783; }","duration":"436.931721ms","start":"2026-02-25T02:17:54.06627Z","end":"2026-02-25T02:17:54.503202Z","steps":["trace[881667929] 'agreement among raft nodes before linearized reading'  (duration: 436.693885ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:54.503269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:54.066236Z","time spent":"437.023733ms","remote":"127.0.0.1:58172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":1266,"request content":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" "}
{"level":"warn","ts":"2026-02-25T02:17:54.503316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:53.987026Z","time spent":"516.128088ms","remote":"127.0.0.1:58208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2798,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/default/test-pvc-pod\" mod_revision:1735 > success:<request_put:<key:\"/registry/pods/default/test-pvc-pod\" value_size:2755 >> failure:<request_range:<key:\"/registry/pods/default/test-pvc-pod\" > >"}
{"level":"warn","ts":"2026-02-25T02:17:54.503313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.093808ms","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-02-25T02:17:54.503382Z","caller":"traceutil/trace.go:171","msg":"trace[354759534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1783; }","duration":"416.16681ms","start":"2026-02-25T02:17:54.0872Z","end":"2026-02-25T02:17:54.503367Z","steps":["trace[354759534] 'agreement among raft nodes before linearized reading'  (duration: 415.981805ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:54.503423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:54.087158Z","time spent":"416.251712ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T02:17:54.503468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.046374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-25T02:17:54.503509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.718101ms","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-02-25T02:17:54.503566Z","caller":"traceutil/trace.go:171","msg":"trace[2059951256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1783; }","duration":"408.790933ms","start":"2026-02-25T02:17:54.094759Z","end":"2026-02-25T02:17:54.50355Z","steps":["trace[2059951256] 'agreement among raft nodes before linearized reading'  (duration: 408.465445ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:17:54.503559Z","caller":"traceutil/trace.go:171","msg":"trace[742268910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1783; }","duration":"408.163858ms","start":"2026-02-25T02:17:54.095371Z","end":"2026-02-25T02:17:54.503535Z","steps":["trace[742268910] 'agreement among raft nodes before linearized reading'  (duration: 407.84034ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:54.503613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:54.095367Z","time spent":"408.23519ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T02:17:54.503626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:54.094752Z","time spent":"408.846644ms","remote":"127.0.0.1:58290","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-02-25T02:17:56.9233Z","caller":"traceutil/trace.go:171","msg":"trace[1782511366] transaction","detail":"{read_only:false; response_revision:1794; number_of_response:1; }","duration":"404.149322ms","start":"2026-02-25T02:17:56.519129Z","end":"2026-02-25T02:17:56.923278Z","steps":["trace[1782511366] 'process raft request'  (duration: 404.010388ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:56.923495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:56.519111Z","time spent":"404.268424ms","remote":"127.0.0.1:58290","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:1784 > 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-02-25T02:17:57.114267Z","caller":"traceutil/trace.go:171","msg":"trace[1812310181] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1876; }","duration":"550.233048ms","start":"2026-02-25T02:17:56.563967Z","end":"2026-02-25T02:17:57.1142Z","steps":["trace[1812310181] 'read index received'  (duration: 359.667579ms)","trace[1812310181] 'applied index is now lower than readState.Index'  (duration: 190.564389ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T02:17:57.11429Z","caller":"traceutil/trace.go:171","msg":"trace[1277574416] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"594.727429ms","start":"2026-02-25T02:17:56.519511Z","end":"2026-02-25T02:17:57.114238Z","steps":["trace[1277574416] 'process raft request'  (duration: 554.85163ms)","trace[1277574416] 'compare'  (duration: 39.667684ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T02:17:57.114617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:56.519469Z","time spent":"595.040387ms","remote":"127.0.0.1:58290","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:1786 > 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-02-25T02:17:57.114724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.609193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T02:17:57.114769Z","caller":"traceutil/trace.go:171","msg":"trace[247708199] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1796; }","duration":"191.697715ms","start":"2026-02-25T02:17:56.923059Z","end":"2026-02-25T02:17:57.114756Z","steps":["trace[247708199] 'agreement among raft nodes before linearized reading'  (duration: 191.599663ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T02:17:57.114433Z","caller":"traceutil/trace.go:171","msg":"trace[1541203794] transaction","detail":"{read_only:false; response_revision:1796; number_of_response:1; }","duration":"592.322991ms","start":"2026-02-25T02:17:56.522089Z","end":"2026-02-25T02:17:57.114412Z","steps":["trace[1541203794] 'process raft request'  (duration: 592.064775ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:57.114823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.226118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"}
{"level":"warn","ts":"2026-02-25T02:17:57.114886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:56.522078Z","time spent":"592.772853ms","remote":"127.0.0.1:58290","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:1785 > 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-02-25T02:17:57.114886Z","caller":"traceutil/trace.go:171","msg":"trace[1890407140] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1796; }","duration":"251.339142ms","start":"2026-02-25T02:17:56.863529Z","end":"2026-02-25T02:17:57.114868Z","steps":["trace[1890407140] 'agreement among raft nodes before linearized reading'  (duration: 251.145207ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:57.114962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.951705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-02-25T02:17:57.115078Z","caller":"traceutil/trace.go:171","msg":"trace[721686304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1796; }","duration":"551.131079ms","start":"2026-02-25T02:17:56.56392Z","end":"2026-02-25T02:17:57.115051Z","steps":["trace[721686304] 'agreement among raft nodes before linearized reading'  (duration: 550.696699ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:57.115144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:56.563905Z","time spent":"551.229003ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T02:17:57.115145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.148142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-02-25T02:17:57.115215Z","caller":"traceutil/trace.go:171","msg":"trace[18338560] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1796; }","duration":"549.240314ms","start":"2026-02-25T02:17:56.565964Z","end":"2026-02-25T02:17:57.115204Z","steps":["trace[18338560] 'agreement among raft nodes before linearized reading'  (duration: 548.622949ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T02:17:57.11533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T02:17:56.565939Z","time spent":"549.343777ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}