{"level":"warn","ts":"2026-02-01T18:49:25.404357Z","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-01T18:49:25.404437Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-01T18:49:25.404499Z","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-01T18:49:25.404507Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]}
{"level":"info","ts":"2026-02-01T18:49:25.404536Z","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-01T18:49:25.406209Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]}
{"level":"info","ts":"2026-02-01T18:49:25.406294Z","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":2,"max-cpu-available":2,"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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-01T18:49:25.411267Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.788329ms"}
{"level":"info","ts":"2026-02-01T18:49:25.450477Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"}
{"level":"info","ts":"2026-02-01T18:49:25.450552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"}
{"level":"info","ts":"2026-02-01T18:49:25.45057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"}
{"level":"info","ts":"2026-02-01T18:49:25.450578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-01T18:49:25.450585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"}
{"level":"info","ts":"2026-02-01T18:49:25.450612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"}
{"level":"warn","ts":"2026-02-01T18:49:25.462558Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-01T18:49:25.470097Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-01T18:49:25.474811Z","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-01T18:49:25.477365Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-01T18:49:25.479108Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-01T18:49:25.479297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"}
{"level":"info","ts":"2026-02-01T18:49:25.479399Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]}
{"level":"info","ts":"2026-02-01T18:49:25.479484Z","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-01T18:49:25.479505Z","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-01T18:49:25.479511Z","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-01T18:49:25.505135Z","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-01T18:49:25.505889Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"}
{"level":"info","ts":"2026-02-01T18:49:25.505907Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"}
{"level":"info","ts":"2026-02-01T18:49:25.506084Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-01T18:49:25.506107Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-01T18:49:25.55091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"}
{"level":"info","ts":"2026-02-01T18:49:25.551026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-01T18:49:25.551049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"}
{"level":"info","ts":"2026-02-01T18:49:25.55106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"}
{"level":"info","ts":"2026-02-01T18:49:25.551098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"}
{"level":"info","ts":"2026-02-01T18:49:25.551107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"}
{"level":"info","ts":"2026-02-01T18:49:25.55116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"}
{"level":"info","ts":"2026-02-01T18:49:25.555075Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-01T18:49:25.556089Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-01T18:49:25.556154Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-01T18:49:25.556751Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-01T18:49:25.556812Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-01T18:49:25.55684Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-01T18:49:25.557929Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-01T18:49:25.558009Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-01T18:49:25.558039Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-01T18:49:25.559884Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"}
{"level":"info","ts":"2026-02-01T18:49:25.569091Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-02-01T18:49:31.491055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.219544425s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-01T18:49:31.491118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135766352s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-02-01T18:49:31.49116Z","caller":"traceutil/trace.go:171","msg":"trace[397023653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:214; }","duration":"1.135846792s","start":"2026-02-01T18:49:30.355304Z","end":"2026-02-01T18:49:31.491151Z","steps":["trace[397023653] 'range keys from in-memory index tree'  (duration: 1.135609891s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:31.491067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.704308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:49:31.491228Z","caller":"traceutil/trace.go:171","msg":"trace[907946767] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:214; }","duration":"836.91467ms","start":"2026-02-01T18:49:30.654281Z","end":"2026-02-01T18:49:31.491195Z","steps":["trace[907946767] 'range keys from in-memory index tree'  (duration: 836.636468ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:49:31.491153Z","caller":"traceutil/trace.go:171","msg":"trace[993830775] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:214; }","duration":"1.219694597s","start":"2026-02-01T18:49:30.271441Z","end":"2026-02-01T18:49:31.491136Z","steps":["trace[993830775] 'range keys from in-memory index tree'  (duration: 1.219474425s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:31.491253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:30.271422Z","time spent":"1.219825688s","remote":"127.0.0.1:49782","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-01T18:49:31.491258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:30.654264Z","time spent":"836.982801ms","remote":"127.0.0.1:50054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-01T18:49:31.491439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.86030209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:service-account-controller\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-01T18:49:31.491462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123519176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-02-01T18:49:31.491471Z","caller":"traceutil/trace.go:171","msg":"trace[189081094] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:service-account-controller; range_end:; response_count:0; response_revision:214; }","duration":"1.860332311s","start":"2026-02-01T18:49:29.631128Z","end":"2026-02-01T18:49:31.49146Z","steps":["trace[189081094] 'range keys from in-memory index tree'  (duration: 1.86027916s)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:49:31.491491Z","caller":"traceutil/trace.go:171","msg":"trace[1287862697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:214; }","duration":"1.123588847s","start":"2026-02-01T18:49:30.367893Z","end":"2026-02-01T18:49:31.491482Z","steps":["trace[1287862697] 'range keys from in-memory index tree'  (duration: 1.123473336s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:31.491499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:29.631114Z","time spent":"1.860377771s","remote":"127.0.0.1:50148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/system:controller:service-account-controller\" "}
{"level":"warn","ts":"2026-02-01T18:49:31.491515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:30.367883Z","time spent":"1.123626297s","remote":"127.0.0.1:50054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-01T18:49:31.491201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:30.355234Z","time spent":"1.135957754s","remote":"127.0.0.1:50054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-01T18:49:31.787064Z","caller":"traceutil/trace.go:171","msg":"trace[768643219] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"638.637533ms","start":"2026-02-01T18:49:31.148401Z","end":"2026-02-01T18:49:31.787039Z","steps":["trace[768643219] 'process raft request'  (duration: 638.495012ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:31.787546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:31.148355Z","time spent":"638.776624ms","remote":"127.0.0.1:49980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2883,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2825 >> failure:<>"}
{"level":"info","ts":"2026-02-01T18:49:31.787544Z","caller":"traceutil/trace.go:171","msg":"trace[613136249] linearizableReadLoop","detail":"{readStateIndex:221; appliedIndex:221; }","duration":"454.791091ms","start":"2026-02-01T18:49:31.332737Z","end":"2026-02-01T18:49:31.787528Z","steps":["trace[613136249] 'read index received'  (duration: 454.78497ms)","trace[613136249] 'applied index is now lower than readState.Index'  (duration: 5.131µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-01T18:49:31.787988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.238094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:49:31.788326Z","caller":"traceutil/trace.go:171","msg":"trace[361725207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:215; }","duration":"455.613546ms","start":"2026-02-01T18:49:31.332698Z","end":"2026-02-01T18:49:31.788312Z","steps":["trace[361725207] 'agreement among raft nodes before linearized reading'  (duration: 455.148903ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:31.788524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:31.332681Z","time spent":"455.828518ms","remote":"127.0.0.1:49782","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-01T18:49:31.791686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.792264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:49:31.792159Z","caller":"traceutil/trace.go:171","msg":"trace[540378891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:219; }","duration":"298.287159ms","start":"2026-02-01T18:49:31.493857Z","end":"2026-02-01T18:49:31.792144Z","steps":["trace[540378891] 'agreement among raft nodes before linearized reading'  (duration: 297.764525ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:49:31.792255Z","caller":"traceutil/trace.go:171","msg":"trace[337417988] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"294.426618ms","start":"2026-02-01T18:49:31.497822Z","end":"2026-02-01T18:49:31.792249Z","steps":["trace[337417988] 'process raft request'  (duration: 293.765894ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:49:31.792185Z","caller":"traceutil/trace.go:171","msg":"trace[883232019] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"295.021783ms","start":"2026-02-01T18:49:31.497152Z","end":"2026-02-01T18:49:31.792174Z","steps":["trace[883232019] 'process raft request'  (duration: 294.407088ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:49:31.792216Z","caller":"traceutil/trace.go:171","msg":"trace[565220696] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"295.739958ms","start":"2026-02-01T18:49:31.496469Z","end":"2026-02-01T18:49:31.792209Z","steps":["trace[565220696] 'process raft request'  (duration: 295.047313ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:49:31.792065Z","caller":"traceutil/trace.go:171","msg":"trace[1687759374] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"297.400992ms","start":"2026-02-01T18:49:31.494648Z","end":"2026-02-01T18:49:31.792049Z","steps":["trace[1687759374] 'process raft request'  (duration: 296.797007ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:58.464494Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334365419038363235,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-01T18:49:58.544204Z","caller":"traceutil/trace.go:171","msg":"trace[245825422] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:530; }","duration":"579.714826ms","start":"2026-02-01T18:49:57.96447Z","end":"2026-02-01T18:49:58.544185Z","steps":["trace[245825422] 'read index received'  (duration: 579.474814ms)","trace[245825422] 'applied index is now lower than readState.Index'  (duration: 239.162µs)"],"step_count":2}
{"level":"info","ts":"2026-02-01T18:49:58.544829Z","caller":"traceutil/trace.go:171","msg":"trace[1592776538] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"614.832658ms","start":"2026-02-01T18:49:57.929986Z","end":"2026-02-01T18:49:58.544819Z","steps":["trace[1592776538] 'process raft request'  (duration: 614.005653ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:58.545849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.372945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-01T18:49:58.545957Z","caller":"traceutil/trace.go:171","msg":"trace[564281523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"561.504536ms","start":"2026-02-01T18:49:57.984443Z","end":"2026-02-01T18:49:58.545948Z","steps":["trace[564281523] 'agreement among raft nodes before linearized reading'  (duration: 561.369965ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:58.546083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:57.984433Z","time spent":"561.640807ms","remote":"127.0.0.1:50054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-01T18:49:58.54628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.81201ms","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-01T18:49:58.546377Z","caller":"traceutil/trace.go:171","msg":"trace[151903869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:509; }","duration":"581.93249ms","start":"2026-02-01T18:49:57.964436Z","end":"2026-02-01T18:49:58.546368Z","steps":["trace[151903869] 'agreement among raft nodes before linearized reading'  (duration: 581.81816ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:58.546461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:57.96442Z","time spent":"582.032681ms","remote":"127.0.0.1:50054","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":"warn","ts":"2026-02-01T18:49:58.546619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.733671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:49:58.546705Z","caller":"traceutil/trace.go:171","msg":"trace[393941870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"527.840752ms","start":"2026-02-01T18:49:58.018857Z","end":"2026-02-01T18:49:58.546698Z","steps":["trace[393941870] 'agreement among raft nodes before linearized reading'  (duration: 527.715691ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:49:58.546814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:58.018846Z","time spent":"527.960022ms","remote":"127.0.0.1:49782","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-01T18:49:58.549649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:49:57.929968Z","time spent":"614.884168ms","remote":"127.0.0.1:50054","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:485 > 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-01T18:50:01.486627Z","caller":"traceutil/trace.go:171","msg":"trace[2006216091] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"112.406474ms","start":"2026-02-01T18:50:01.374204Z","end":"2026-02-01T18:50:01.48661Z","steps":["trace[2006216091] 'process raft request'  (duration: 95.416173ms)","trace[2006216091] 'compare'  (duration: 16.86116ms)"],"step_count":2}
{"level":"info","ts":"2026-02-01T18:50:01.56591Z","caller":"traceutil/trace.go:171","msg":"trace[82153270] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:558; }","duration":"170.118629ms","start":"2026-02-01T18:50:01.395777Z","end":"2026-02-01T18:50:01.565896Z","steps":["trace[82153270] 'read index received'  (duration: 73.796962ms)","trace[82153270] 'applied index is now lower than readState.Index'  (duration: 96.320807ms)"],"step_count":2}
{"level":"info","ts":"2026-02-01T18:50:01.565926Z","caller":"traceutil/trace.go:171","msg":"trace[1903514171] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"188.619739ms","start":"2026-02-01T18:50:01.377278Z","end":"2026-02-01T18:50:01.565898Z","steps":["trace[1903514171] 'process raft request'  (duration: 188.459098ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:01.566355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.563222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"}
{"level":"info","ts":"2026-02-01T18:50:01.566377Z","caller":"traceutil/trace.go:171","msg":"trace[917156155] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:539; }","duration":"170.625803ms","start":"2026-02-01T18:50:01.395743Z","end":"2026-02-01T18:50:01.566369Z","steps":["trace[917156155] 'agreement among raft nodes before linearized reading'  (duration: 170.519212ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:01.566457Z","caller":"traceutil/trace.go:171","msg":"trace[1734844440] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"170.825794ms","start":"2026-02-01T18:50:01.395627Z","end":"2026-02-01T18:50:01.566452Z","steps":["trace[1734844440] 'process raft request'  (duration: 170.1994ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:02.334943Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334365419038363292,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-01T18:50:02.507957Z","caller":"traceutil/trace.go:171","msg":"trace[1873658459] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:561; }","duration":"673.362139ms","start":"2026-02-01T18:50:01.834572Z","end":"2026-02-01T18:50:02.507934Z","steps":["trace[1873658459] 'read index received'  (duration: 673.195687ms)","trace[1873658459] 'applied index is now lower than readState.Index'  (duration: 165.642µs)"],"step_count":2}
{"level":"info","ts":"2026-02-01T18:50:02.508083Z","caller":"traceutil/trace.go:171","msg":"trace[1898182632] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"928.659494ms","start":"2026-02-01T18:50:01.579414Z","end":"2026-02-01T18:50:02.508074Z","steps":["trace[1898182632] 'process raft request'  (duration: 928.389131ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:02.508178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:01.579393Z","time spent":"928.715314ms","remote":"127.0.0.1:50288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3677,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/local-path-storage/local-path-provisioner\" mod_revision:537 > success:<request_put:<key:\"/registry/deployments/local-path-storage/local-path-provisioner\" value_size:3606 >> failure:<request_range:<key:\"/registry/deployments/local-path-storage/local-path-provisioner\" > >"}
{"level":"warn","ts":"2026-02-01T18:50:02.508321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.335421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-01T18:50:02.508384Z","caller":"traceutil/trace.go:171","msg":"trace[1200827045] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:540; }","duration":"535.480772ms","start":"2026-02-01T18:50:01.972888Z","end":"2026-02-01T18:50:02.508368Z","steps":["trace[1200827045] 'agreement among raft nodes before linearized reading'  (duration: 535.368491ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:02.508423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:01.97287Z","time spent":"535.544802ms","remote":"127.0.0.1:49812","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.109\" "}
{"level":"warn","ts":"2026-02-01T18:50:02.508597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.702024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-01T18:50:02.508595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.015906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12727"}
{"level":"info","ts":"2026-02-01T18:50:02.508625Z","caller":"traceutil/trace.go:171","msg":"trace[1610870895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"489.749955ms","start":"2026-02-01T18:50:02.018866Z","end":"2026-02-01T18:50:02.508616Z","steps":["trace[1610870895] 'agreement among raft nodes before linearized reading'  (duration: 489.707224ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:02.508637Z","caller":"traceutil/trace.go:171","msg":"trace[1883403174] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:540; }","duration":"674.081647ms","start":"2026-02-01T18:50:01.834542Z","end":"2026-02-01T18:50:02.508624Z","steps":["trace[1883403174] 'agreement among raft nodes before linearized reading'  (duration: 673.946615ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:02.50865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:02.018856Z","time spent":"489.789175ms","remote":"127.0.0.1:49782","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-01T18:50:02.508673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:01.834512Z","time spent":"674.153987ms","remote":"127.0.0.1:49888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12750,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "}
{"level":"info","ts":"2026-02-01T18:50:06.376479Z","caller":"traceutil/trace.go:171","msg":"trace[1145004689] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"354.546064ms","start":"2026-02-01T18:50:06.021916Z","end":"2026-02-01T18:50:06.376462Z","steps":["trace[1145004689] 'process raft request'  (duration: 354.442249ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:06.376587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:06.021905Z","time spent":"354.626798ms","remote":"127.0.0.1:49980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-n26dc\" mod_revision:505 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-n26dc\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-n26dc\" > >"}
{"level":"warn","ts":"2026-02-01T18:50:07.6498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.260936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:50:07.649854Z","caller":"traceutil/trace.go:171","msg":"trace[2024281240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"633.35344ms","start":"2026-02-01T18:50:07.016487Z","end":"2026-02-01T18:50:07.64984Z","steps":["trace[2024281240] 'range keys from in-memory index tree'  (duration: 633.198682ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:07.649883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:07.016471Z","time spent":"633.402823ms","remote":"127.0.0.1:49782","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-01T18:50:07.650099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067980659s","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-01T18:50:07.650114Z","caller":"traceutil/trace.go:171","msg":"trace[160123695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"1.068029212s","start":"2026-02-01T18:50:06.582079Z","end":"2026-02-01T18:50:07.650108Z","steps":["trace[160123695] 'range keys from in-memory index tree'  (duration: 1.067868184s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:07.650106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.0533984s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-02-01T18:50:07.650145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.832873ms","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-01T18:50:07.650152Z","caller":"traceutil/trace.go:171","msg":"trace[224509530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"1.053464423s","start":"2026-02-01T18:50:06.596675Z","end":"2026-02-01T18:50:07.65014Z","steps":["trace[224509530] 'range keys from in-memory index tree'  (duration: 1.053352458s)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:07.650159Z","caller":"traceutil/trace.go:171","msg":"trace[517660396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:554; }","duration":"792.871954ms","start":"2026-02-01T18:50:06.857283Z","end":"2026-02-01T18:50:07.650155Z","steps":["trace[517660396] 'range keys from in-memory index tree'  (duration: 792.78406ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:07.650174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:06.857249Z","time spent":"792.922657ms","remote":"127.0.0.1:50054","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-01T18:50:07.650176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:06.596669Z","time spent":"1.053502745s","remote":"127.0.0.1:50054","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":"warn","ts":"2026-02-01T18:50:07.650296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.054309975s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-01T18:50:07.650127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:06.58206Z","time spent":"1.068063364s","remote":"127.0.0.1:50054","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-01T18:50:07.650311Z","caller":"traceutil/trace.go:171","msg":"trace[1070365064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"1.054350188s","start":"2026-02-01T18:50:06.595955Z","end":"2026-02-01T18:50:07.650306Z","steps":["trace[1070365064] 'range keys from in-memory index tree'  (duration: 1.054255673s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:07.650323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:06.59594Z","time spent":"1.054380288s","remote":"127.0.0.1:50054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-01T18:50:09.302847Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.331848313s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-01T18:50:09.303292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.332158298s","expected-duration":"100ms","prefix":"","request":"header:<ID:15334365419038363336 > lease_revoke:<id:54ce9c1a89d0ce07>","response":"size:28"}
{"level":"info","ts":"2026-02-01T18:50:09.303394Z","caller":"traceutil/trace.go:171","msg":"trace[216395148] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:577; }","duration":"1.650396358s","start":"2026-02-01T18:50:07.652988Z","end":"2026-02-01T18:50:09.303384Z","steps":["trace[216395148] 'read index received'  (duration: 318.160247ms)","trace[216395148] 'applied index is now lower than readState.Index'  (duration: 1.332235441s)"],"step_count":2}
{"level":"warn","ts":"2026-02-01T18:50:09.303432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.6504369s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:50:09.303444Z","caller":"traceutil/trace.go:171","msg":"trace[270904492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:554; }","duration":"1.650464921s","start":"2026-02-01T18:50:07.652975Z","end":"2026-02-01T18:50:09.303439Z","steps":["trace[270904492] 'agreement among raft nodes before linearized reading'  (duration: 1.65043545s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:09.303461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:07.652965Z","time spent":"1.650492543s","remote":"127.0.0.1:49796","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-01T18:50:09.304443Z","caller":"traceutil/trace.go:171","msg":"trace[312643624] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"1.648079184s","start":"2026-02-01T18:50:07.656357Z","end":"2026-02-01T18:50:09.304436Z","steps":["trace[312643624] 'process raft request'  (duration: 1.646975702s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:09.304495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:07.656348Z","time spent":"1.648113515s","remote":"127.0.0.1:50054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:549 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-01T18:50:09.366594Z","caller":"traceutil/trace.go:171","msg":"trace[1032262733] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"1.710154796s","start":"2026-02-01T18:50:07.656415Z","end":"2026-02-01T18:50:09.36657Z","steps":["trace[1032262733] 'process raft request'  (duration: 1.648015021s)","trace[1032262733] 'compare'  (duration: 61.846312ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-01T18:50:09.366729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:07.656411Z","time spent":"1.71024408s","remote":"127.0.0.1:50054","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:547 > 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-01T18:50:09.367082Z","caller":"traceutil/trace.go:171","msg":"trace[532626491] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.71063584s","start":"2026-02-01T18:50:07.656436Z","end":"2026-02-01T18:50:09.367072Z","steps":["trace[532626491] 'process raft request'  (duration: 1.710076153s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:09.367149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:07.656434Z","time spent":"1.710685652s","remote":"127.0.0.1:50054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:550 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-01T18:50:09.36765Z","caller":"traceutil/trace.go:171","msg":"trace[345163183] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.711156205s","start":"2026-02-01T18:50:07.656482Z","end":"2026-02-01T18:50:09.367638Z","steps":["trace[345163183] 'process raft request'  (duration: 1.710552006s)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:09.367713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:07.656479Z","time spent":"1.711207017s","remote":"127.0.0.1:50054","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:548 > 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-01T18:50:11.485833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.964393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-02-01T18:50:11.485904Z","caller":"traceutil/trace.go:171","msg":"trace[506661094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"175.067878ms","start":"2026-02-01T18:50:11.31082Z","end":"2026-02-01T18:50:11.485888Z","steps":["trace[506661094] 'range keys from in-memory index tree'  (duration: 174.838497ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:11.486185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.129549ms","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-01T18:50:11.486219Z","caller":"traceutil/trace.go:171","msg":"trace[2068287123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"114.199162ms","start":"2026-02-01T18:50:11.372011Z","end":"2026-02-01T18:50:11.486211Z","steps":["trace[2068287123] 'range keys from in-memory index tree'  (duration: 114.039194ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:11.48638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.446686ms","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-01T18:50:11.486412Z","caller":"traceutil/trace.go:171","msg":"trace[547588100] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"113.529651ms","start":"2026-02-01T18:50:11.372875Z","end":"2026-02-01T18:50:11.486404Z","steps":["trace[547588100] 'range keys from in-memory index tree'  (duration: 113.368443ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:11.486557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.119855ms","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-01T18:50:11.486588Z","caller":"traceutil/trace.go:171","msg":"trace[2032182939] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:584; }","duration":"109.188379ms","start":"2026-02-01T18:50:11.377393Z","end":"2026-02-01T18:50:11.486581Z","steps":["trace[2032182939] 'range keys from in-memory index tree'  (duration: 108.98629ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:11.6643Z","caller":"traceutil/trace.go:171","msg":"trace[1298342522] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"273.673095ms","start":"2026-02-01T18:50:11.390612Z","end":"2026-02-01T18:50:11.664285Z","steps":["trace[1298342522] 'process raft request'  (duration: 273.581631ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:11.669302Z","caller":"traceutil/trace.go:171","msg":"trace[2143492042] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"173.20964ms","start":"2026-02-01T18:50:11.496084Z","end":"2026-02-01T18:50:11.669293Z","steps":["trace[2143492042] 'process raft request'  (duration: 172.965929ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:11.669458Z","caller":"traceutil/trace.go:171","msg":"trace[1979116830] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"173.136778ms","start":"2026-02-01T18:50:11.496316Z","end":"2026-02-01T18:50:11.669453Z","steps":["trace[1979116830] 'process raft request'  (duration: 172.793492ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:11.669516Z","caller":"traceutil/trace.go:171","msg":"trace[432720376] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"173.171108ms","start":"2026-02-01T18:50:11.496341Z","end":"2026-02-01T18:50:11.669512Z","steps":["trace[432720376] 'process raft request'  (duration: 172.78556ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:11.669566Z","caller":"traceutil/trace.go:171","msg":"trace[1195259813] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"173.284125ms","start":"2026-02-01T18:50:11.496278Z","end":"2026-02-01T18:50:11.669562Z","steps":["trace[1195259813] 'process raft request'  (duration: 172.862914ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:14.663417Z","caller":"traceutil/trace.go:171","msg":"trace[3545264] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"272.863659ms","start":"2026-02-01T18:50:14.390539Z","end":"2026-02-01T18:50:14.663403Z","steps":["trace[3545264] 'read index received'  (duration: 272.637089ms)","trace[3545264] 'applied index is now lower than readState.Index'  (duration: 226.04µs)"],"step_count":2}
{"level":"info","ts":"2026-02-01T18:50:14.663481Z","caller":"traceutil/trace.go:171","msg":"trace[275341601] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"281.640912ms","start":"2026-02-01T18:50:14.381835Z","end":"2026-02-01T18:50:14.663476Z","steps":["trace[275341601] 'process raft request'  (duration: 281.401421ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:14.663681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.128341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"}
{"level":"info","ts":"2026-02-01T18:50:14.663699Z","caller":"traceutil/trace.go:171","msg":"trace[734849370] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:633; }","duration":"273.156712ms","start":"2026-02-01T18:50:14.390536Z","end":"2026-02-01T18:50:14.663693Z","steps":["trace[734849370] 'agreement among raft nodes before linearized reading'  (duration: 273.081798ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:15.416139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.833306ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334365419038363474 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-n26dc\" mod_revision:629 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-n26dc\" value_size:18011 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-n26dc\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-01T18:50:15.416368Z","caller":"traceutil/trace.go:171","msg":"trace[57257143] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"262.262085ms","start":"2026-02-01T18:50:15.154095Z","end":"2026-02-01T18:50:15.416357Z","steps":["trace[57257143] 'read index received'  (duration: 40.128646ms)","trace[57257143] 'applied index is now lower than readState.Index'  (duration: 222.132519ms)"],"step_count":2}
{"level":"info","ts":"2026-02-01T18:50:15.416446Z","caller":"traceutil/trace.go:171","msg":"trace[141691231] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"351.902593ms","start":"2026-02-01T18:50:15.064537Z","end":"2026-02-01T18:50:15.416439Z","steps":["trace[141691231] 'process raft request'  (duration: 129.721771ms)","trace[141691231] 'compare'  (duration: 221.727502ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-01T18:50:15.416483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:50:15.064521Z","time spent":"351.943884ms","remote":"127.0.0.1:49980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18060,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-n26dc\" mod_revision:629 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-n26dc\" value_size:18011 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-n26dc\" > >"}
{"level":"warn","ts":"2026-02-01T18:50:15.416722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.624832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-02-01T18:50:15.416741Z","caller":"traceutil/trace.go:171","msg":"trace[203091093] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:636; }","duration":"262.665704ms","start":"2026-02-01T18:50:15.15407Z","end":"2026-02-01T18:50:15.416736Z","steps":["trace[203091093] 'agreement among raft nodes before linearized reading'  (duration: 262.59624ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:50:15.416986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.848118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"}
{"level":"info","ts":"2026-02-01T18:50:15.417005Z","caller":"traceutil/trace.go:171","msg":"trace[1106800923] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:636; }","duration":"226.88886ms","start":"2026-02-01T18:50:15.190112Z","end":"2026-02-01T18:50:15.417Z","steps":["trace[1106800923] 'agreement among raft nodes before linearized reading'  (duration: 226.807457ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:50:30.329837Z","caller":"traceutil/trace.go:171","msg":"trace[1538884765] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"135.196051ms","start":"2026-02-01T18:50:30.194626Z","end":"2026-02-01T18:50:30.329822Z","steps":["trace[1538884765] 'process raft request'  (duration: 135.101767ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:51:36.334809Z","caller":"traceutil/trace.go:171","msg":"trace[124162121] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1030; }","duration":"100.272521ms","start":"2026-02-01T18:51:36.234519Z","end":"2026-02-01T18:51:36.334791Z","steps":["trace[124162121] 'read index received'  (duration: 100.134648ms)","trace[124162121] 'applied index is now lower than readState.Index'  (duration: 137.213µs)"],"step_count":2}
{"level":"info","ts":"2026-02-01T18:51:36.335011Z","caller":"traceutil/trace.go:171","msg":"trace[77567075] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"143.93969ms","start":"2026-02-01T18:51:36.191063Z","end":"2026-02-01T18:51:36.335002Z","steps":["trace[77567075] 'process raft request'  (duration: 143.636414ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:36.335204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.674108ms","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-01T18:51:36.335227Z","caller":"traceutil/trace.go:171","msg":"trace[1770887888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:985; }","duration":"100.737629ms","start":"2026-02-01T18:51:36.234482Z","end":"2026-02-01T18:51:36.33522Z","steps":["trace[1770887888] 'agreement among raft nodes before linearized reading'  (duration: 100.648897ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:51:36.45031Z","caller":"traceutil/trace.go:171","msg":"trace[1163998707] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"108.868603ms","start":"2026-02-01T18:51:36.341417Z","end":"2026-02-01T18:51:36.450286Z","steps":["trace[1163998707] 'process raft request'  (duration: 58.406346ms)","trace[1163998707] 'compare'  (duration: 50.060189ms)"],"step_count":2}
{"level":"info","ts":"2026-02-01T18:51:36.450792Z","caller":"traceutil/trace.go:171","msg":"trace[1216551101] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"109.316022ms","start":"2026-02-01T18:51:36.341466Z","end":"2026-02-01T18:51:36.450782Z","steps":["trace[1216551101] 'process raft request'  (duration: 108.775601ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:37.431157Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334365419038364374,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-01T18:51:37.441905Z","caller":"traceutil/trace.go:171","msg":"trace[1502372306] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"645.810395ms","start":"2026-02-01T18:51:36.796076Z","end":"2026-02-01T18:51:37.441886Z","steps":["trace[1502372306] 'process raft request'  (duration: 645.690583ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:37.442211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:36.796056Z","time spent":"646.03573ms","remote":"127.0.0.1:49978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5218,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:777 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5184 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-01T18:51:37.452333Z","caller":"traceutil/trace.go:171","msg":"trace[340188706] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"644.63198ms","start":"2026-02-01T18:51:36.807653Z","end":"2026-02-01T18:51:37.452285Z","steps":["trace[340188706] 'process raft request'  (duration: 644.469267ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:37.452652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:36.807641Z","time spent":"644.766784ms","remote":"127.0.0.1:50054","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:955 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-01T18:51:37.783827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.622552ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334365419038364380 > lease_revoke:<id:54ce9c1a89d0d22a>","response":"size:28"}
{"level":"info","ts":"2026-02-01T18:51:37.784018Z","caller":"traceutil/trace.go:171","msg":"trace[610892914] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1035; }","duration":"853.757314ms","start":"2026-02-01T18:51:36.930205Z","end":"2026-02-01T18:51:37.783963Z","steps":["trace[610892914] 'read index received'  (duration: 515.362387ms)","trace[610892914] 'applied index is now lower than readState.Index'  (duration: 338.392927ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-01T18:51:37.786167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.948178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-01T18:51:37.78626Z","caller":"traceutil/trace.go:171","msg":"trace[82629198] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:990; }","duration":"856.072331ms","start":"2026-02-01T18:51:36.930174Z","end":"2026-02-01T18:51:37.786247Z","steps":["trace[82629198] 'agreement among raft nodes before linearized reading'  (duration: 855.939638ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:37.786357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:36.930165Z","time spent":"856.178063ms","remote":"127.0.0.1:49952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "}
{"level":"warn","ts":"2026-02-01T18:51:37.786696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.832985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:51:37.786824Z","caller":"traceutil/trace.go:171","msg":"trace[1089855287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:990; }","duration":"766.998789ms","start":"2026-02-01T18:51:37.01981Z","end":"2026-02-01T18:51:37.786809Z","steps":["trace[1089855287] 'agreement among raft nodes before linearized reading'  (duration: 766.857146ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:37.786912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:37.019788Z","time spent":"767.112971ms","remote":"127.0.0.1:49782","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-01T18:51:37.787569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.926019ms","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":"info","ts":"2026-02-01T18:51:37.787701Z","caller":"traceutil/trace.go:171","msg":"trace[1946564305] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:990; }","duration":"438.108362ms","start":"2026-02-01T18:51:37.349581Z","end":"2026-02-01T18:51:37.787689Z","steps":["trace[1946564305] 'agreement among raft nodes before linearized reading'  (duration: 437.800386ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:37.787821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:37.349559Z","time spent":"438.249815ms","remote":"127.0.0.1:59170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":118,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"warn","ts":"2026-02-01T18:51:37.788058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.567512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:51:37.788145Z","caller":"traceutil/trace.go:171","msg":"trace[1879162029] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:990; }","duration":"497.697914ms","start":"2026-02-01T18:51:37.29044Z","end":"2026-02-01T18:51:37.788137Z","steps":["trace[1879162029] 'agreement among raft nodes before linearized reading'  (duration: 497.581042ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:37.788199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-01T18:51:37.290422Z","time spent":"497.751316ms","remote":"127.0.0.1:49952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/test-pv\" "}
{"level":"info","ts":"2026-02-01T18:51:42.112266Z","caller":"traceutil/trace.go:171","msg":"trace[1823271168] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"121.183221ms","start":"2026-02-01T18:51:41.991041Z","end":"2026-02-01T18:51:42.112224Z","steps":["trace[1823271168] 'process raft request'  (duration: 115.630554ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:51:42.114744Z","caller":"traceutil/trace.go:171","msg":"trace[1528845941] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"105.852803ms","start":"2026-02-01T18:51:42.008861Z","end":"2026-02-01T18:51:42.114714Z","steps":["trace[1528845941] 'process raft request'  (duration: 102.185152ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:56.707337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.271599ms","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-01T18:51:56.709132Z","caller":"traceutil/trace.go:171","msg":"trace[611758028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1046; }","duration":"147.102882ms","start":"2026-02-01T18:51:56.562017Z","end":"2026-02-01T18:51:56.709119Z","steps":["trace[611758028] 'range keys from in-memory index tree'  (duration: 145.197138ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:56.708108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.889095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"warn","ts":"2026-02-01T18:51:56.708162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.932047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-01T18:51:56.708185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.585332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/default/\" range_end:\"/registry/jobs/default0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-01T18:51:56.710174Z","caller":"traceutil/trace.go:171","msg":"trace[900533934] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1046; }","duration":"116.978021ms","start":"2026-02-01T18:51:56.593187Z","end":"2026-02-01T18:51:56.710165Z","steps":["trace[900533934] 'range keys from in-memory index tree'  (duration: 114.837184ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:51:56.710277Z","caller":"traceutil/trace.go:171","msg":"trace[555090120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1046; }","duration":"108.055883ms","start":"2026-02-01T18:51:56.602214Z","end":"2026-02-01T18:51:56.71027Z","steps":["trace[555090120] 'range keys from in-memory index tree'  (duration: 105.876427ms)"],"step_count":1}
{"level":"info","ts":"2026-02-01T18:51:56.710377Z","caller":"traceutil/trace.go:171","msg":"trace[465892594] range","detail":"{range_begin:/registry/jobs/default/; range_end:/registry/jobs/default0; response_count:0; response_revision:1046; }","duration":"102.792641ms","start":"2026-02-01T18:51:56.607578Z","end":"2026-02-01T18:51:56.71037Z","steps":["trace[465892594] 'range keys from in-memory index tree'  (duration: 100.526441ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-01T18:51:58.71277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.699799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6534"}
{"level":"info","ts":"2026-02-01T18:51:58.712838Z","caller":"traceutil/trace.go:171","msg":"trace[1479022695] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:1052; }","duration":"105.796591ms","start":"2026-02-01T18:51:58.607026Z","end":"2026-02-01T18:51:58.712822Z","steps":["trace[1479022695] 'range keys from in-memory index tree'  (duration: 105.624438ms)"],"step_count":1}