{"level":"warn","ts":"2026-02-19T02:51:31.771336Z","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-19T02:51:31.771421Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.217: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://162.253.55.217:2380","--initial-cluster=instance=https://162.253.55.217:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.217:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.217: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-19T02:51:31.771479Z","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-19T02:51:31.771491Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-02-19T02:51:31.771517Z","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-19T02:51:31.773113Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"]} {"level":"info","ts":"2026-02-19T02:51:31.773213Z","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://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.217: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-19T02:51:31.777693Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.239744ms"} {"level":"info","ts":"2026-02-19T02:51:31.789705Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e368e6818bd6f7","cluster-id":"289e52865b7eaeb1"} {"level":"info","ts":"2026-02-19T02:51:31.789782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T02:51:31.789804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 0"} {"level":"info","ts":"2026-02-19T02:51:31.789863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e368e6818bd6f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T02:51:31.789901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 1"} {"level":"info","ts":"2026-02-19T02:51:31.789954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"warn","ts":"2026-02-19T02:51:31.800698Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T02:51:31.802098Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T02:51:31.803359Z","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-19T02:51:31.806052Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e368e6818bd6f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T02:51:31.806287Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e368e6818bd6f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T02:51:31.806528Z","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-19T02:51:31.806584Z","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-19T02:51:31.806619Z","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-19T02:51:31.809758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"} {"level":"info","ts":"2026-02-19T02:51:31.814126Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","added-peer-id":"f1e368e6818bd6f7","added-peer-peer-urls":["https://162.253.55.217:2380"]} {"level":"info","ts":"2026-02-19T02:51:31.814886Z","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-19T02:51:31.814968Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-02-19T02:51:31.815002Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.217:2380"} {"level":"info","ts":"2026-02-19T02:51:31.815106Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e368e6818bd6f7","initial-advertise-peer-urls":["https://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T02:51:31.815134Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T02:51:32.190795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T02:51:32.190897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T02:51:32.190943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgPreVoteResp from f1e368e6818bd6f7 at term 1"} {"level":"info","ts":"2026-02-19T02:51:32.190959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became candidate at term 2"} {"level":"info","ts":"2026-02-19T02:51:32.190967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgVoteResp from f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-02-19T02:51:32.190978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became leader at term 2"} {"level":"info","ts":"2026-02-19T02:51:32.190988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e368e6818bd6f7 elected leader f1e368e6818bd6f7 at term 2"} {"level":"info","ts":"2026-02-19T02:51:32.196927Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T02:51:32.196914Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T02:51:32.197193Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:51:32.197795Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T02:51:32.197895Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T02:51:32.19668Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e368e6818bd6f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.217:2379]}","request-path":"/0/members/f1e368e6818bd6f7/attributes","cluster-id":"289e52865b7eaeb1","publish-timeout":"7s"} {"level":"info","ts":"2026-02-19T02:51:32.198425Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:51:32.198581Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:51:32.198665Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:51:32.200467Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.217:2379"} {"level":"info","ts":"2026-02-19T02:51:32.200546Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-19T02:51:40.585799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.372447ms","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-19T02:51:40.585928Z","caller":"traceutil/trace.go:171","msg":"trace[1138305281] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:283; }","duration":"232.529129ms","start":"2026-02-19T02:51:40.353352Z","end":"2026-02-19T02:51:40.585881Z","steps":["trace[1138305281] 'range keys from in-memory index tree' (duration: 232.255974ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:51:40.586141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.168515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-19T02:51:40.586247Z","caller":"traceutil/trace.go:171","msg":"trace[642726329] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"402.309599ms","start":"2026-02-19T02:51:40.183914Z","end":"2026-02-19T02:51:40.586224Z","steps":["trace[642726329] 'range keys from in-memory index tree' (duration: 402.083794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:51:40.586297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:51:40.183908Z","time spent":"402.3802ms","remote":"127.0.0.1:38606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-19T02:51:40.586305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.349757ms","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-19T02:51:40.586432Z","caller":"traceutil/trace.go:171","msg":"trace[415431122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:283; }","duration":"316.515241ms","start":"2026-02-19T02:51:40.26989Z","end":"2026-02-19T02:51:40.586405Z","steps":["trace[415431122] 'range keys from in-memory index tree' (duration: 316.176294ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:51:40.586494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:51:40.269877Z","time spent":"316.605003ms","remote":"127.0.0.1:38790","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-19T02:51:46.421161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.89976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:51:46.421324Z","caller":"traceutil/trace.go:171","msg":"trace[683057099] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:371; }","duration":"619.32096ms","start":"2026-02-19T02:51:45.801983Z","end":"2026-02-19T02:51:46.421304Z","steps":["trace[683057099] 'read index received' (duration: 446.588182ms)","trace[683057099] 'applied index is now lower than readState.Index' (duration: 172.730838ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:51:46.421448Z","caller":"traceutil/trace.go:171","msg":"trace[804018642] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"647.753112ms","start":"2026-02-19T02:51:45.773641Z","end":"2026-02-19T02:51:46.421394Z","steps":["trace[804018642] 'process raft request' (duration: 474.878382ms)","trace[804018642] 'compare' (duration: 171.670676ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:51:46.421524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.543574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.217\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-19T02:51:46.421558Z","caller":"traceutil/trace.go:171","msg":"trace[1098567196] range","detail":"{range_begin:/registry/masterleases/162.253.55.217; range_end:; response_count:1; response_revision:362; }","duration":"619.613825ms","start":"2026-02-19T02:51:45.801933Z","end":"2026-02-19T02:51:46.421547Z","steps":["trace[1098567196] 'agreement among raft nodes before linearized reading' (duration: 619.493423ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:51:46.421601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:51:45.801914Z","time spent":"619.677987ms","remote":"127.0.0.1:38554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.217\" "} {"level":"warn","ts":"2026-02-19T02:51:46.421648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.511014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"} {"level":"warn","ts":"2026-02-19T02:51:46.421675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:51:45.773622Z","time spent":"647.935676ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:51:46.421706Z","caller":"traceutil/trace.go:171","msg":"trace[64571060] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:362; }","duration":"618.634096ms","start":"2026-02-19T02:51:45.803058Z","end":"2026-02-19T02:51:46.421692Z","steps":["trace[64571060] 'agreement among raft nodes before linearized reading' (duration: 618.519874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:51:46.421739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:51:45.803034Z","time spent":"618.699538ms","remote":"127.0.0.1:38702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":7260,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-02-19T02:51:57.432941Z","caller":"traceutil/trace.go:171","msg":"trace[645725194] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"484.265548ms","start":"2026-02-19T02:51:56.948638Z","end":"2026-02-19T02:51:57.432903Z","steps":["trace[645725194] 'process raft request' (duration: 484.083194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:51:57.43315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:51:56.948617Z","time spent":"484.432122ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:52:02.793052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.945286ms","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-19T02:52:02.793347Z","caller":"traceutil/trace.go:171","msg":"trace[1916673358] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:468; }","duration":"239.341764ms","start":"2026-02-19T02:52:02.553968Z","end":"2026-02-19T02:52:02.793309Z","steps":["trace[1916673358] 'range keys from in-memory index tree' (duration: 238.845884ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:02.796274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.519581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:52:02.800887Z","caller":"traceutil/trace.go:171","msg":"trace[5137407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:468; }","duration":"224.697114ms","start":"2026-02-19T02:52:02.571686Z","end":"2026-02-19T02:52:02.796383Z","steps":["trace[5137407] 'range keys from in-memory index tree' (duration: 224.412129ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:13.038462Z","caller":"traceutil/trace.go:171","msg":"trace[2121021786] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:513; }","duration":"157.337921ms","start":"2026-02-19T02:52:12.881098Z","end":"2026-02-19T02:52:13.038436Z","steps":["trace[2121021786] 'read index received' (duration: 157.094077ms)","trace[2121021786] 'applied index is now lower than readState.Index' (duration: 242.644µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:52:13.03851Z","caller":"traceutil/trace.go:171","msg":"trace[291179969] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"158.058546ms","start":"2026-02-19T02:52:12.88042Z","end":"2026-02-19T02:52:13.038478Z","steps":["trace[291179969] 'process raft request' (duration: 157.859642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:13.038721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.597656ms","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-19T02:52:13.038761Z","caller":"traceutil/trace.go:171","msg":"trace[2089526665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:497; }","duration":"157.666748ms","start":"2026-02-19T02:52:12.88108Z","end":"2026-02-19T02:52:13.038747Z","steps":["trace[2089526665] 'agreement among raft nodes before linearized reading' (duration: 157.510325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:13.039204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.424044ms","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-19T02:52:13.039312Z","caller":"traceutil/trace.go:171","msg":"trace[118721584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:497; }","duration":"156.939665ms","start":"2026-02-19T02:52:12.882348Z","end":"2026-02-19T02:52:13.039288Z","steps":["trace[118721584] 'agreement among raft nodes before linearized reading' (duration: 156.254311ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:14.041893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:13.312589Z","time spent":"729.294236ms","remote":"127.0.0.1:60104","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-19T02:52:14.042451Z","caller":"traceutil/trace.go:171","msg":"trace[1613700459] linearizableReadLoop","detail":"{readStateIndex:516; appliedIndex:514; }","duration":"515.592769ms","start":"2026-02-19T02:52:13.526834Z","end":"2026-02-19T02:52:14.042427Z","steps":["trace[1613700459] 'read index received' (duration: 459.715184ms)","trace[1613700459] 'applied index is now lower than readState.Index' (duration: 55.876335ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:52:14.042816Z","caller":"traceutil/trace.go:171","msg":"trace[1247363306] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"999.630603ms","start":"2026-02-19T02:52:13.043168Z","end":"2026-02-19T02:52:14.042799Z","steps":["trace[1247363306] 'process raft request' (duration: 943.366231ms)","trace[1247363306] 'compare' (duration: 55.398854ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:52:14.042923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:13.043144Z","time spent":"999.702894ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:52:14.043021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.513067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:52:14.043049Z","caller":"traceutil/trace.go:171","msg":"trace[308565950] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"998.710215ms","start":"2026-02-19T02:52:13.044321Z","end":"2026-02-19T02:52:14.043031Z","steps":["trace[308565950] 'process raft request' (duration: 997.992911ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:14.04309Z","caller":"traceutil/trace.go:171","msg":"trace[1455965209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:499; }","duration":"472.602749ms","start":"2026-02-19T02:52:13.570464Z","end":"2026-02-19T02:52:14.043067Z","steps":["trace[1455965209] 'agreement among raft nodes before linearized reading' (duration: 472.466236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:14.043131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:13.044294Z","time spent":"998.792897ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:52:14.043144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:13.570398Z","time spent":"472.734981ms","remote":"127.0.0.1:38540","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-19T02:52:14.043163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.328913ms","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-19T02:52:14.043215Z","caller":"traceutil/trace.go:171","msg":"trace[1561267898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:499; }","duration":"516.384294ms","start":"2026-02-19T02:52:13.526818Z","end":"2026-02-19T02:52:14.043202Z","steps":["trace[1561267898] 'agreement among raft nodes before linearized reading' (duration: 516.215731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:14.043252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:13.52676Z","time spent":"516.483246ms","remote":"127.0.0.1:38790","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-19T02:52:16.254386Z","caller":"traceutil/trace.go:171","msg":"trace[897857310] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"204.079347ms","start":"2026-02-19T02:52:16.050283Z","end":"2026-02-19T02:52:16.254362Z","steps":["trace[897857310] 'process raft request' (duration: 203.897763ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:16.256601Z","caller":"traceutil/trace.go:171","msg":"trace[1310116031] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:549; }","duration":"150.583298ms","start":"2026-02-19T02:52:16.106003Z","end":"2026-02-19T02:52:16.256586Z","steps":["trace[1310116031] 'read index received' (duration: 148.247972ms)","trace[1310116031] 'applied index is now lower than readState.Index' (duration: 2.334096ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:52:16.256758Z","caller":"traceutil/trace.go:171","msg":"trace[906005740] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"205.203668ms","start":"2026-02-19T02:52:16.051526Z","end":"2026-02-19T02:52:16.25673Z","steps":["trace[906005740] 'process raft request' (duration: 204.963533ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:16.256848Z","caller":"traceutil/trace.go:171","msg":"trace[2127777137] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"175.076093ms","start":"2026-02-19T02:52:16.08174Z","end":"2026-02-19T02:52:16.256816Z","steps":["trace[2127777137] 'process raft request' (duration: 174.809147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:16.256949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.850334ms","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-19T02:52:16.256993Z","caller":"traceutil/trace.go:171","msg":"trace[522751966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:534; }","duration":"151.011147ms","start":"2026-02-19T02:52:16.105962Z","end":"2026-02-19T02:52:16.256973Z","steps":["trace[522751966] 'agreement among raft nodes before linearized reading' (duration: 150.67532ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:19.242581Z","caller":"traceutil/trace.go:171","msg":"trace[1328293210] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"158.275132ms","start":"2026-02-19T02:52:19.084282Z","end":"2026-02-19T02:52:19.242557Z","steps":["trace[1328293210] 'process raft request' (duration: 158.071218ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:19.424577Z","caller":"traceutil/trace.go:171","msg":"trace[683795077] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"168.954382ms","start":"2026-02-19T02:52:19.255513Z","end":"2026-02-19T02:52:19.424467Z","steps":["trace[683795077] 'process raft request' (duration: 104.880754ms)","trace[683795077] 'compare' (duration: 63.919295ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:52:19.449177Z","caller":"traceutil/trace.go:171","msg":"trace[1574004948] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"119.530025ms","start":"2026-02-19T02:52:19.329594Z","end":"2026-02-19T02:52:19.449124Z","steps":["trace[1574004948] 'process raft request' (duration: 119.371592ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:19.862675Z","caller":"traceutil/trace.go:171","msg":"trace[304926624] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"151.231762ms","start":"2026-02-19T02:52:19.711377Z","end":"2026-02-19T02:52:19.862609Z","steps":["trace[304926624] 'process raft request' (duration: 150.962417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:20.091084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.799662ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:52:20.091232Z","caller":"traceutil/trace.go:171","msg":"trace[682080282] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"210.561875ms","start":"2026-02-19T02:52:19.88065Z","end":"2026-02-19T02:52:20.091211Z","steps":["trace[682080282] 'read index received' (duration: 103.600519ms)","trace[682080282] 'applied index is now lower than readState.Index' (duration: 106.959946ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:52:20.091426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.781899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-19T02:52:20.091376Z","caller":"traceutil/trace.go:171","msg":"trace[853675804] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"372.03631ms","start":"2026-02-19T02:52:19.719263Z","end":"2026-02-19T02:52:20.091299Z","steps":["trace[853675804] 'process raft request' (duration: 264.900611ms)","trace[853675804] 'compare' (duration: 106.574988ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:52:20.091469Z","caller":"traceutil/trace.go:171","msg":"trace[539564494] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:575; }","duration":"210.863401ms","start":"2026-02-19T02:52:19.880592Z","end":"2026-02-19T02:52:20.091456Z","steps":["trace[539564494] 'agreement among raft nodes before linearized reading' (duration: 210.704517ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:20.091604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:19.719242Z","time spent":"372.243783ms","remote":"127.0.0.1:38572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:52:20.103056Z","caller":"traceutil/trace.go:171","msg":"trace[295266894] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"157.227279ms","start":"2026-02-19T02:52:19.945798Z","end":"2026-02-19T02:52:20.103025Z","steps":["trace[295266894] 'process raft request' (duration: 156.905843ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:20.103093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.072029ms","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-19T02:52:20.103157Z","caller":"traceutil/trace.go:171","msg":"trace[999260853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:577; }","duration":"194.193201ms","start":"2026-02-19T02:52:19.908949Z","end":"2026-02-19T02:52:20.103142Z","steps":["trace[999260853] 'agreement among raft nodes before linearized reading' (duration: 194.005927ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:20.10332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.473028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bbgvl\" ","response":"range_response_count:1 size:17918"} {"level":"info","ts":"2026-02-19T02:52:20.103429Z","caller":"traceutil/trace.go:171","msg":"trace[1518628848] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bbgvl; range_end:; response_count:1; response_revision:577; }","duration":"144.655981ms","start":"2026-02-19T02:52:19.958749Z","end":"2026-02-19T02:52:20.103405Z","steps":["trace[1518628848] 'agreement among raft nodes before linearized reading' (duration: 144.330654ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:20.103304Z","caller":"traceutil/trace.go:171","msg":"trace[1438926597] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"142.248274ms","start":"2026-02-19T02:52:19.961031Z","end":"2026-02-19T02:52:20.103279Z","steps":["trace[1438926597] 'process raft request' (duration: 141.857607ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:32.401308Z","caller":"traceutil/trace.go:171","msg":"trace[663764106] linearizableReadLoop","detail":"{readStateIndex:712; appliedIndex:711; }","duration":"214.498951ms","start":"2026-02-19T02:52:32.186783Z","end":"2026-02-19T02:52:32.401282Z","steps":["trace[663764106] 'read index received' (duration: 214.233286ms)","trace[663764106] 'applied index is now lower than readState.Index' (duration: 264.255µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:52:32.40145Z","caller":"traceutil/trace.go:171","msg":"trace[688721515] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"216.95142ms","start":"2026-02-19T02:52:32.184487Z","end":"2026-02-19T02:52:32.401439Z","steps":["trace[688721515] 'process raft request' (duration: 216.646594ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:32.401804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.991792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:52:32.401907Z","caller":"traceutil/trace.go:171","msg":"trace[96246475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:690; }","duration":"215.133504ms","start":"2026-02-19T02:52:32.186748Z","end":"2026-02-19T02:52:32.401881Z","steps":["trace[96246475] 'agreement among raft nodes before linearized reading' (duration: 214.94463ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:33.093481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.238593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:52:33.093599Z","caller":"traceutil/trace.go:171","msg":"trace[1615210663] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"681.438108ms","start":"2026-02-19T02:52:32.412142Z","end":"2026-02-19T02:52:33.09358Z","steps":["trace[1615210663] 'read index received' (duration: 386.909059ms)","trace[1615210663] 'applied index is now lower than readState.Index' (duration: 294.527109ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:52:33.093641Z","caller":"traceutil/trace.go:171","msg":"trace[1256567426] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"687.088911ms","start":"2026-02-19T02:52:32.406513Z","end":"2026-02-19T02:52:33.093602Z","steps":["trace[1256567426] 'process raft request' (duration: 392.622183ms)","trace[1256567426] 'compare' (duration: 294.025079ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:52:33.093798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:32.406484Z","time spent":"687.222073ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:52:33.093839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.219014ms","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-19T02:52:33.093873Z","caller":"traceutil/trace.go:171","msg":"trace[363237620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:691; }","duration":"677.262636ms","start":"2026-02-19T02:52:32.4166Z","end":"2026-02-19T02:52:33.093863Z","steps":["trace[363237620] 'agreement among raft nodes before linearized reading' (duration: 677.088742ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:33.093837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.963977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T02:52:33.093924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:32.416593Z","time spent":"677.323437ms","remote":"127.0.0.1:38790","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-19T02:52:33.093954Z","caller":"traceutil/trace.go:171","msg":"trace[537544975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:691; }","duration":"522.12974ms","start":"2026-02-19T02:52:32.571796Z","end":"2026-02-19T02:52:33.093926Z","steps":["trace[537544975] 'agreement among raft nodes before linearized reading' (duration: 521.950296ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:33.094029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:32.571744Z","time spent":"522.263843ms","remote":"127.0.0.1:38530","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-19T02:52:33.093841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.670613ms","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-19T02:52:33.094252Z","caller":"traceutil/trace.go:171","msg":"trace[827366980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:691; }","duration":"682.132593ms","start":"2026-02-19T02:52:32.412101Z","end":"2026-02-19T02:52:33.094233Z","steps":["trace[827366980] 'agreement among raft nodes before linearized reading' (duration: 681.54613ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:33.094302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:52:32.412086Z","time spent":"682.201894ms","remote":"127.0.0.1:38790","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-19T02:52:35.226704Z","caller":"traceutil/trace.go:171","msg":"trace[727241052] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:717; }","duration":"112.459229ms","start":"2026-02-19T02:52:35.114214Z","end":"2026-02-19T02:52:35.226674Z","steps":["trace[727241052] 'read index received' (duration: 112.176984ms)","trace[727241052] 'applied index is now lower than readState.Index' (duration: 280.685µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:52:35.226755Z","caller":"traceutil/trace.go:171","msg":"trace[1716509415] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"122.390376ms","start":"2026-02-19T02:52:35.104332Z","end":"2026-02-19T02:52:35.226722Z","steps":["trace[1716509415] 'process raft request' (duration: 122.169392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:35.227153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.905578ms","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-19T02:52:35.227194Z","caller":"traceutil/trace.go:171","msg":"trace[1810258184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:696; }","duration":"112.98844ms","start":"2026-02-19T02:52:35.114192Z","end":"2026-02-19T02:52:35.22718Z","steps":["trace[1810258184] 'agreement among raft nodes before linearized reading' (duration: 112.828147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:52:35.227196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.953009ms","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-19T02:52:35.227286Z","caller":"traceutil/trace.go:171","msg":"trace[1488744286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:696; }","duration":"113.106672ms","start":"2026-02-19T02:52:35.114154Z","end":"2026-02-19T02:52:35.227261Z","steps":["trace[1488744286] 'agreement among raft nodes before linearized reading' (duration: 112.633023ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:39.364757Z","caller":"traceutil/trace.go:171","msg":"trace[1995110690] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"100.505422ms","start":"2026-02-19T02:52:39.264233Z","end":"2026-02-19T02:52:39.364738Z","steps":["trace[1995110690] 'process raft request' (duration: 100.39106ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:40.65546Z","caller":"traceutil/trace.go:171","msg":"trace[1278455753] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"205.874652ms","start":"2026-02-19T02:52:40.449557Z","end":"2026-02-19T02:52:40.655432Z","steps":["trace[1278455753] 'process raft request' (duration: 205.714399ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:52:57.739413Z","caller":"traceutil/trace.go:171","msg":"trace[2060495110] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"157.655975ms","start":"2026-02-19T02:52:57.581724Z","end":"2026-02-19T02:52:57.73938Z","steps":["trace[2060495110] 'process raft request' (duration: 98.87361ms)","trace[2060495110] 'compare' (duration: 58.577451ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:52:59.897523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.311378ms","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-19T02:52:59.897627Z","caller":"traceutil/trace.go:171","msg":"trace[1529487598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:773; }","duration":"153.489351ms","start":"2026-02-19T02:52:59.744114Z","end":"2026-02-19T02:52:59.897604Z","steps":["trace[1529487598] 'range keys from in-memory index tree' (duration: 153.039793ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:01.168003Z","caller":"traceutil/trace.go:171","msg":"trace[2000535425] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"404.160771ms","start":"2026-02-19T02:53:00.763822Z","end":"2026-02-19T02:53:01.167983Z","steps":["trace[2000535425] 'process raft request' (duration: 403.998208ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:01.168137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:00.763801Z","time spent":"404.262163ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:53:01.542993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.559555ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-19T02:53:01.543147Z","caller":"traceutil/trace.go:171","msg":"trace[8607602] linearizableReadLoop","detail":"{readStateIndex:804; appliedIndex:802; }","duration":"466.675612ms","start":"2026-02-19T02:53:01.076444Z","end":"2026-02-19T02:53:01.543119Z","steps":["trace[8607602] 'read index received' (duration: 91.437413ms)","trace[8607602] 'applied index is now lower than readState.Index' (duration: 375.236859ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:53:01.543362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.903506ms","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":"info","ts":"2026-02-19T02:53:01.543398Z","caller":"traceutil/trace.go:171","msg":"trace[1767198623] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:775; }","duration":"467.000808ms","start":"2026-02-19T02:53:01.076387Z","end":"2026-02-19T02:53:01.543388Z","steps":["trace[1767198623] 'agreement among raft nodes before linearized reading' (duration: 466.888096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:01.543425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:01.076363Z","time spent":"467.055269ms","remote":"127.0.0.1:38854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":13,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-02-19T02:53:01.543908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.471538ms","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-19T02:53:01.544009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.396039ms","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-19T02:53:01.544031Z","caller":"traceutil/trace.go:171","msg":"trace[1541798382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"107.45642ms","start":"2026-02-19T02:53:01.436569Z","end":"2026-02-19T02:53:01.544026Z","steps":["trace[1541798382] 'agreement among raft nodes before linearized reading' (duration: 107.391088ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:01.543938Z","caller":"traceutil/trace.go:171","msg":"trace[414210407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:775; }","duration":"177.54667ms","start":"2026-02-19T02:53:01.366383Z","end":"2026-02-19T02:53:01.543929Z","steps":["trace[414210407] 'agreement among raft nodes before linearized reading' (duration: 177.413637ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:03.473276Z","caller":"traceutil/trace.go:171","msg":"trace[124423793] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"169.307007ms","start":"2026-02-19T02:53:03.303946Z","end":"2026-02-19T02:53:03.473253Z","steps":["trace[124423793] 'read index received' (duration: 169.093803ms)","trace[124423793] 'applied index is now lower than readState.Index' (duration: 212.414µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:53:03.473434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.45857ms","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-19T02:53:03.473468Z","caller":"traceutil/trace.go:171","msg":"trace[1958684999] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:780; }","duration":"169.560412ms","start":"2026-02-19T02:53:03.303898Z","end":"2026-02-19T02:53:03.473459Z","steps":["trace[1958684999] 'agreement among raft nodes before linearized reading' (duration: 169.44884ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:03.473828Z","caller":"traceutil/trace.go:171","msg":"trace[903937923] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"295.573749ms","start":"2026-02-19T02:53:03.178239Z","end":"2026-02-19T02:53:03.473813Z","steps":["trace[903937923] 'process raft request' (duration: 294.869145ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:04.05629Z","caller":"traceutil/trace.go:171","msg":"trace[997979014] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"478.907194ms","start":"2026-02-19T02:53:03.577359Z","end":"2026-02-19T02:53:04.056266Z","steps":["trace[997979014] 'process raft request' (duration: 478.743611ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:04.0565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:03.577343Z","time spent":"479.054477ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:53:04.056738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.487809ms","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-19T02:53:04.056823Z","caller":"traceutil/trace.go:171","msg":"trace[963139175] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"458.630392ms","start":"2026-02-19T02:53:03.598173Z","end":"2026-02-19T02:53:04.056804Z","steps":["trace[963139175] 'agreement among raft nodes before linearized reading' (duration: 458.205844ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:04.056963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:03.598144Z","time spent":"458.806096ms","remote":"127.0.0.1:38790","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-19T02:53:04.056842Z","caller":"traceutil/trace.go:171","msg":"trace[1865565939] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"458.54735ms","start":"2026-02-19T02:53:03.598235Z","end":"2026-02-19T02:53:04.056782Z","steps":["trace[1865565939] 'read index received' (duration: 457.784385ms)","trace[1865565939] 'applied index is now lower than readState.Index' (duration: 757.565µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:53:04.057316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.50058ms","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-19T02:53:04.057362Z","caller":"traceutil/trace.go:171","msg":"trace[1778945124] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"448.589763ms","start":"2026-02-19T02:53:03.608761Z","end":"2026-02-19T02:53:04.057351Z","steps":["trace[1778945124] 'agreement among raft nodes before linearized reading' (duration: 448.386469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:04.057405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:03.608748Z","time spent":"448.646203ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:53:04.269462Z","caller":"traceutil/trace.go:171","msg":"trace[74253685] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"207.631155ms","start":"2026-02-19T02:53:04.061468Z","end":"2026-02-19T02:53:04.269099Z","steps":["trace[74253685] 'process raft request' (duration: 167.696384ms)","trace[74253685] 'compare' (duration: 39.798139ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:53:04.31693Z","caller":"traceutil/trace.go:171","msg":"trace[1352396938] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"254.302631ms","start":"2026-02-19T02:53:04.062604Z","end":"2026-02-19T02:53:04.316906Z","steps":["trace[1352396938] 'process raft request' (duration: 254.24381ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:04.316991Z","caller":"traceutil/trace.go:171","msg":"trace[790287953] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"254.406453ms","start":"2026-02-19T02:53:04.062558Z","end":"2026-02-19T02:53:04.316964Z","steps":["trace[790287953] 'process raft request' (duration: 254.148618ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:12.540237Z","caller":"traceutil/trace.go:171","msg":"trace[1276077128] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"133.803832ms","start":"2026-02-19T02:53:12.406397Z","end":"2026-02-19T02:53:12.540201Z","steps":["trace[1276077128] 'read index received' (duration: 89.469634ms)","trace[1276077128] 'applied index is now lower than readState.Index' (duration: 44.332418ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:53:12.540526Z","caller":"traceutil/trace.go:171","msg":"trace[755439623] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"135.978076ms","start":"2026-02-19T02:53:12.404463Z","end":"2026-02-19T02:53:12.540441Z","steps":["trace[755439623] 'process raft request' (duration: 91.362932ms)","trace[755439623] 'compare' (duration: 43.970391ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:53:12.540854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.421595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329932"} {"level":"info","ts":"2026-02-19T02:53:12.54091Z","caller":"traceutil/trace.go:171","msg":"trace[1732269419] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:807; }","duration":"134.515156ms","start":"2026-02-19T02:53:12.406379Z","end":"2026-02-19T02:53:12.540894Z","steps":["trace[1732269419] 'agreement among raft nodes before linearized reading' (duration: 133.947605ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:16.101261Z","caller":"traceutil/trace.go:171","msg":"trace[1754702027] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:898; }","duration":"249.70941ms","start":"2026-02-19T02:53:15.851525Z","end":"2026-02-19T02:53:16.101234Z","steps":["trace[1754702027] 'read index received' (duration: 249.442475ms)","trace[1754702027] 'applied index is now lower than readState.Index' (duration: 265.665µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:53:16.101448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.883083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:53:16.101478Z","caller":"traceutil/trace.go:171","msg":"trace[1544514728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:865; }","duration":"249.956804ms","start":"2026-02-19T02:53:15.85151Z","end":"2026-02-19T02:53:16.101467Z","steps":["trace[1544514728] 'agreement among raft nodes before linearized reading' (duration: 249.849542ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:16.298663Z","caller":"traceutil/trace.go:171","msg":"trace[495081470] transaction","detail":"{read_only:false; response_revision:867; number_of_response:1; }","duration":"120.159402ms","start":"2026-02-19T02:53:16.17847Z","end":"2026-02-19T02:53:16.298629Z","steps":["trace[495081470] 'process raft request' (duration: 76.909775ms)","trace[495081470] 'compare' (duration: 43.088974ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:53:18.026791Z","caller":"traceutil/trace.go:171","msg":"trace[611601568] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"452.702545ms","start":"2026-02-19T02:53:17.574057Z","end":"2026-02-19T02:53:18.026759Z","steps":["trace[611601568] 'process raft request' (duration: 452.48378ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:18.026983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:17.57402Z","time spent":"452.861728ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:53:18.464076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.21252ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:53:18.464258Z","caller":"traceutil/trace.go:171","msg":"trace[2069008993] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:872; }","duration":"306.418584ms","start":"2026-02-19T02:53:18.157815Z","end":"2026-02-19T02:53:18.464233Z","steps":["trace[2069008993] 'range keys from in-memory index tree' (duration: 306.186529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:18.464339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.159405ms","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-19T02:53:18.464463Z","caller":"traceutil/trace.go:171","msg":"trace[901857741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:872; }","duration":"160.370999ms","start":"2026-02-19T02:53:18.304063Z","end":"2026-02-19T02:53:18.464434Z","steps":["trace[901857741] 'range keys from in-memory index tree' (duration: 159.91034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:18.465278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.740737ms","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-19T02:53:18.465378Z","caller":"traceutil/trace.go:171","msg":"trace[254803642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:872; }","duration":"104.88946ms","start":"2026-02-19T02:53:18.360469Z","end":"2026-02-19T02:53:18.465358Z","steps":["trace[254803642] 'range keys from in-memory index tree' (duration: 104.380759ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:18.574872Z","caller":"traceutil/trace.go:171","msg":"trace[1719588817] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"104.803568ms","start":"2026-02-19T02:53:18.470034Z","end":"2026-02-19T02:53:18.574837Z","steps":["trace[1719588817] 'process raft request' (duration: 104.746407ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:18.574891Z","caller":"traceutil/trace.go:171","msg":"trace[1614485624] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"105.39884ms","start":"2026-02-19T02:53:18.469451Z","end":"2026-02-19T02:53:18.574849Z","steps":["trace[1614485624] 'process raft request' (duration: 105.166255ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:31.793403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.861982ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-19T02:53:34.744711Z","caller":"traceutil/trace.go:171","msg":"trace[1076888043] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"100.40963ms","start":"2026-02-19T02:53:34.644258Z","end":"2026-02-19T02:53:34.744668Z","steps":["trace[1076888043] 'process raft request' (duration: 100.057953ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:35.653661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.495755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T02:53:35.653731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.866745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T02:53:35.653802Z","caller":"traceutil/trace.go:171","msg":"trace[824827396] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:940; }","duration":"201.730159ms","start":"2026-02-19T02:53:35.45204Z","end":"2026-02-19T02:53:35.65377Z","steps":["trace[824827396] 'count revisions from in-memory index tree' (duration: 201.349371ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:35.653845Z","caller":"traceutil/trace.go:171","msg":"trace[1680638896] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:940; }","duration":"412.060138ms","start":"2026-02-19T02:53:35.24175Z","end":"2026-02-19T02:53:35.653811Z","steps":["trace[1680638896] 'count revisions from in-memory index tree' (duration: 411.698151ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:35.653909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:35.241713Z","time spent":"412.184341ms","remote":"127.0.0.1:38930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-02-19T02:53:37.003025Z","caller":"traceutil/trace.go:171","msg":"trace[37609914] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"248.943678ms","start":"2026-02-19T02:53:36.75406Z","end":"2026-02-19T02:53:37.003004Z","steps":["trace[37609914] 'process raft request' (duration: 248.804545ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:37.003019Z","caller":"traceutil/trace.go:171","msg":"trace[1154261162] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:980; }","duration":"231.562834ms","start":"2026-02-19T02:53:36.771429Z","end":"2026-02-19T02:53:37.002992Z","steps":["trace[1154261162] 'read index received' (duration: 231.549003ms)","trace[1154261162] 'applied index is now lower than readState.Index' (duration: 11.911µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:53:37.003337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.85819ms","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-19T02:53:37.003377Z","caller":"traceutil/trace.go:171","msg":"trace[1525474581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:943; }","duration":"231.982612ms","start":"2026-02-19T02:53:36.771382Z","end":"2026-02-19T02:53:37.003365Z","steps":["trace[1525474581] 'agreement among raft nodes before linearized reading' (duration: 231.751687ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:37.409016Z","caller":"traceutil/trace.go:171","msg":"trace[876166156] linearizableReadLoop","detail":"{readStateIndex:982; appliedIndex:981; }","duration":"405.872274ms","start":"2026-02-19T02:53:37.003109Z","end":"2026-02-19T02:53:37.408981Z","steps":["trace[876166156] 'read index received' (duration: 320.36787ms)","trace[876166156] 'applied index is now lower than readState.Index' (duration: 85.502313ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:53:37.409406Z","caller":"traceutil/trace.go:171","msg":"trace[782702084] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"424.167187ms","start":"2026-02-19T02:53:36.985204Z","end":"2026-02-19T02:53:37.409371Z","steps":["trace[782702084] 'process raft request' (duration: 338.264606ms)","trace[782702084] 'compare' (duration: 85.222788ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:53:37.410029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:36.985166Z","time spent":"424.769169ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:53:37.410162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.041141ms","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-19T02:53:37.410206Z","caller":"traceutil/trace.go:171","msg":"trace[1566443679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:944; }","duration":"623.137913ms","start":"2026-02-19T02:53:36.787056Z","end":"2026-02-19T02:53:37.410193Z","steps":["trace[1566443679] 'agreement among raft nodes before linearized reading' (duration: 622.435159ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:37.410242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:36.787026Z","time spent":"623.208755ms","remote":"127.0.0.1:38790","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-19T02:53:37.410033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.863548ms","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-19T02:53:37.410413Z","caller":"traceutil/trace.go:171","msg":"trace[788639928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:944; }","duration":"622.292827ms","start":"2026-02-19T02:53:36.788104Z","end":"2026-02-19T02:53:37.410397Z","steps":["trace[788639928] 'agreement among raft nodes before linearized reading' (duration: 621.751477ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:37.410499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:36.78809Z","time spent":"622.393669ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:53:37.667919Z","caller":"traceutil/trace.go:171","msg":"trace[76844118] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"659.446684ms","start":"2026-02-19T02:53:37.008443Z","end":"2026-02-19T02:53:37.66789Z","steps":["trace[76844118] 'process raft request' (duration: 588.155074ms)","trace[76844118] 'compare' (duration: 71.037165ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:53:37.668289Z","caller":"traceutil/trace.go:171","msg":"trace[1186012911] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"251.878846ms","start":"2026-02-19T02:53:37.416388Z","end":"2026-02-19T02:53:37.668266Z","steps":["trace[1186012911] 'process raft request' (duration: 251.459028ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:37.668576Z","caller":"traceutil/trace.go:171","msg":"trace[1917495933] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"252.101631ms","start":"2026-02-19T02:53:37.416468Z","end":"2026-02-19T02:53:37.66857Z","steps":["trace[1917495933] 'process raft request' (duration: 251.60937ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:37.67085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:37.008405Z","time spent":"662.364062ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:53:38.199641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.456901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T02:53:38.199773Z","caller":"traceutil/trace.go:171","msg":"trace[1999372934] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:948; }","duration":"106.252846ms","start":"2026-02-19T02:53:38.093471Z","end":"2026-02-19T02:53:38.199723Z","steps":["trace[1999372934] 'count revisions from in-memory index tree' (duration: 105.361369ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:38.522073Z","caller":"traceutil/trace.go:171","msg":"trace[1426929443] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"317.534784ms","start":"2026-02-19T02:53:38.2045Z","end":"2026-02-19T02:53:38.522034Z","steps":["trace[1426929443] 'process raft request' (duration: 317.362541ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:38.522276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:38.204468Z","time spent":"317.710137ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:53:39.043498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.642146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T02:53:39.043619Z","caller":"traceutil/trace.go:171","msg":"trace[617077433] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:949; }","duration":"197.83847ms","start":"2026-02-19T02:53:38.845737Z","end":"2026-02-19T02:53:39.043576Z","steps":["trace[617077433] 'count revisions from in-memory index tree' (duration: 197.512214ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:39.325648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.863467ms","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-19T02:53:39.32573Z","caller":"traceutil/trace.go:171","msg":"trace[1354540456] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:950; }","duration":"126.005ms","start":"2026-02-19T02:53:39.199707Z","end":"2026-02-19T02:53:39.325712Z","steps":["trace[1354540456] 'count revisions from in-memory index tree' (duration: 125.634502ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:39.612529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.904054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:53:39.612641Z","caller":"traceutil/trace.go:171","msg":"trace[1403821041] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:951; }","duration":"154.085349ms","start":"2026-02-19T02:53:39.458531Z","end":"2026-02-19T02:53:39.612616Z","steps":["trace[1403821041] 'range keys from in-memory index tree' (duration: 153.812562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:49.167993Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15490021464577300188,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T02:53:49.180274Z","caller":"traceutil/trace.go:171","msg":"trace[322501196] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1058; }","duration":"512.798663ms","start":"2026-02-19T02:53:48.667444Z","end":"2026-02-19T02:53:49.180242Z","steps":["trace[322501196] 'read index received' (duration: 512.469766ms)","trace[322501196] 'applied index is now lower than readState.Index' (duration: 327.487µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:53:49.180389Z","caller":"traceutil/trace.go:171","msg":"trace[1282497987] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"599.599342ms","start":"2026-02-19T02:53:48.580748Z","end":"2026-02-19T02:53:49.180347Z","steps":["trace[1282497987] 'process raft request' (duration: 599.282726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:49.180599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.133939ms","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-19T02:53:49.180651Z","caller":"traceutil/trace.go:171","msg":"trace[1900103583] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1019; }","duration":"513.270713ms","start":"2026-02-19T02:53:48.667361Z","end":"2026-02-19T02:53:49.180632Z","steps":["trace[1900103583] 'agreement among raft nodes before linearized reading' (duration: 513.056918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:53:49.18064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:48.580724Z","time spent":"599.776435ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:53:49.180697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:53:48.66733Z","time spent":"513.356894ms","remote":"127.0.0.1:38790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-02-19T02:53:49.328744Z","caller":"traceutil/trace.go:171","msg":"trace[1979845915] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"140.759595ms","start":"2026-02-19T02:53:49.18768Z","end":"2026-02-19T02:53:49.328439Z","steps":["trace[1979845915] 'process raft request' (duration: 140.448989ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:53:49.331438Z","caller":"traceutil/trace.go:171","msg":"trace[2063556315] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"142.479458ms","start":"2026-02-19T02:53:49.188916Z","end":"2026-02-19T02:53:49.331396Z","steps":["trace[2063556315] 'process raft request' (duration: 142.217703ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:54:42.435413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.103784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:54:42.435913Z","caller":"traceutil/trace.go:171","msg":"trace[94992055] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"167.750654ms","start":"2026-02-19T02:54:42.268123Z","end":"2026-02-19T02:54:42.435874Z","steps":["trace[94992055] 'process raft request' (duration: 45.047928ms)","trace[94992055] 'compare' (duration: 121.820728ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:54:42.435955Z","caller":"traceutil/trace.go:171","msg":"trace[1983267899] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"160.186114ms","start":"2026-02-19T02:54:42.275741Z","end":"2026-02-19T02:54:42.435927Z","steps":["trace[1983267899] 'process raft request' (duration: 160.00661ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:55:04.136053Z","caller":"traceutil/trace.go:171","msg":"trace[1590129408] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"110.042554ms","start":"2026-02-19T02:55:04.02598Z","end":"2026-02-19T02:55:04.136023Z","steps":["trace[1590129408] 'process raft request' (duration: 54.616249ms)","trace[1590129408] 'compare' (duration: 55.290223ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:57:05.537897Z","caller":"traceutil/trace.go:171","msg":"trace[1297529812] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"127.219187ms","start":"2026-02-19T02:57:05.410638Z","end":"2026-02-19T02:57:05.537857Z","steps":["trace[1297529812] 'process raft request' (duration: 40.2727ms)","trace[1297529812] 'compare' (duration: 86.55759ms)"],"step_count":2}