{"level":"warn","ts":"2026-02-25T01:32:20.48981Z","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-25T01:32:20.489913Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95: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.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-25T01:32:20.489997Z","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-25T01:32:20.49001Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-02-25T01:32:20.490029Z","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-25T01:32:20.4908Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-02-25T01:32:20.491021Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-25T01:32:20.497736Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.835818ms"} {"level":"info","ts":"2026-02-25T01:32:20.511247Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-02-25T01:32:20.511323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T01:32:20.511434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-02-25T01:32:20.511476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T01:32:20.511487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-02-25T01:32:20.511591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-02-25T01:32:20.518084Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T01:32:20.519881Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T01:32:20.520756Z","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-25T01:32:20.52314Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T01:32:20.523281Z","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-25T01:32:20.523367Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T01:32:20.523396Z","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-25T01:32:20.523449Z","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-25T01:32:20.525049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-02-25T01:32:20.525187Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-02-25T01:32:20.529099Z","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-25T01:32:20.529248Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-02-25T01:32:20.529332Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-02-25T01:32:20.531763Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T01:32:20.531827Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T01:32:20.713452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T01:32:20.713503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T01:32:20.71353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-02-25T01:32:20.713542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-02-25T01:32:20.713549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-02-25T01:32:20.713559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-02-25T01:32:20.713567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-02-25T01:32:20.718342Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T01:32:20.718414Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T01:32:20.718617Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T01:32:20.718742Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:32:20.718953Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T01:32:20.718976Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T01:32:20.719987Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:32:20.720169Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:32:20.720204Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T01:32:20.72529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T01:32:20.725776Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"warn","ts":"2026-02-25T01:32:30.770523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.565899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:32:30.77065Z","caller":"traceutil/trace.go:171","msg":"trace[915845863] linearizableReadLoop","detail":"{readStateIndex:350; appliedIndex:349; }","duration":"420.206051ms","start":"2026-02-25T01:32:30.350428Z","end":"2026-02-25T01:32:30.770634Z","steps":["trace[915845863] 'read index received' (duration: 65.946453ms)","trace[915845863] 'applied index is now lower than readState.Index' (duration: 354.258288ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:32:30.771055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.588852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4256"} {"level":"warn","ts":"2026-02-25T01:32:30.771066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.218568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-25T01:32:30.771077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.284218ms","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-25T01:32:30.771104Z","caller":"traceutil/trace.go:171","msg":"trace[1456450395] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:338; }","duration":"175.68512ms","start":"2026-02-25T01:32:30.595405Z","end":"2026-02-25T01:32:30.77109Z","steps":["trace[1456450395] 'agreement among raft nodes before linearized reading' (duration: 175.586891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:30.771161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.83298ms","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-25T01:32:30.771192Z","caller":"traceutil/trace.go:171","msg":"trace[192352288] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:338; }","duration":"298.376742ms","start":"2026-02-25T01:32:30.472787Z","end":"2026-02-25T01:32:30.771164Z","steps":["trace[192352288] 'agreement among raft nodes before linearized reading' (duration: 298.176095ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:32:30.771196Z","caller":"traceutil/trace.go:171","msg":"trace[1349282196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:338; }","duration":"336.444852ms","start":"2026-02-25T01:32:30.434721Z","end":"2026-02-25T01:32:30.771166Z","steps":["trace[1349282196] 'agreement among raft nodes before linearized reading' (duration: 336.206662ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:32:30.771252Z","caller":"traceutil/trace.go:171","msg":"trace[1377339828] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:338; }","duration":"335.963101ms","start":"2026-02-25T01:32:30.435267Z","end":"2026-02-25T01:32:30.77123Z","steps":["trace[1377339828] 'agreement among raft nodes before linearized reading' (duration: 335.733421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:30.771064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.597054ms","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-25T01:32:30.771309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.43526Z","time spent":"336.040748ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T01:32:30.771265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.43471Z","time spent":"336.539379ms","remote":"127.0.0.1:59530","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-25T01:32:30.771421Z","caller":"traceutil/trace.go:171","msg":"trace[234913022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:338; }","duration":"420.952354ms","start":"2026-02-25T01:32:30.350389Z","end":"2026-02-25T01:32:30.771342Z","steps":["trace[234913022] 'agreement among raft nodes before linearized reading' (duration: 420.496295ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:30.771554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.350373Z","time spent":"421.162342ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T01:32:30.771844Z","caller":"traceutil/trace.go:171","msg":"trace[1349687343] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"641.991356ms","start":"2026-02-25T01:32:30.129826Z","end":"2026-02-25T01:32:30.771818Z","steps":["trace[1349687343] 'process raft request' (duration: 286.5875ms)","trace[1349687343] 'compare' (duration: 353.418237ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:32:30.771964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.12981Z","time spent":"642.089704ms","remote":"127.0.0.1:59468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T01:32:31.130853Z","caller":"traceutil/trace.go:171","msg":"trace[970151742] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"354.866276ms","start":"2026-02-25T01:32:30.775958Z","end":"2026-02-25T01:32:31.130824Z","steps":["trace[970151742] 'process raft request' (duration: 322.987705ms)","trace[970151742] 'compare' (duration: 31.755441ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:32:31.131204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.775934Z","time spent":"354.982686ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:32:31.606945Z","caller":"traceutil/trace.go:171","msg":"trace[1616295546] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"830.581981ms","start":"2026-02-25T01:32:30.776336Z","end":"2026-02-25T01:32:31.606918Z","steps":["trace[1616295546] 'process raft request' (duration: 830.409136ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:32:31.607243Z","caller":"traceutil/trace.go:171","msg":"trace[1610004258] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"830.746165ms","start":"2026-02-25T01:32:30.776442Z","end":"2026-02-25T01:32:31.607188Z","steps":["trace[1610004258] 'process raft request' (duration: 830.439378ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:32:31.60729Z","caller":"traceutil/trace.go:171","msg":"trace[390042135] linearizableReadLoop","detail":"{readStateIndex:354; appliedIndex:350; }","duration":"828.951252ms","start":"2026-02-25T01:32:30.778322Z","end":"2026-02-25T01:32:31.607273Z","steps":["trace[390042135] 'read index received' (duration: 320.602162ms)","trace[390042135] 'applied index is now lower than readState.Index' (duration: 508.34808ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:32:31.607305Z","caller":"traceutil/trace.go:171","msg":"trace[428734584] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"830.310178ms","start":"2026-02-25T01:32:30.776972Z","end":"2026-02-25T01:32:31.607282Z","steps":["trace[428734584] 'process raft request' (duration: 830.117501ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:32:31.60738Z","caller":"traceutil/trace.go:171","msg":"trace[1696989860] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"826.512094ms","start":"2026-02-25T01:32:30.780837Z","end":"2026-02-25T01:32:31.607349Z","steps":["trace[1696989860] 'process raft request' (duration: 826.318658ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:31.60741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.776961Z","time spent":"830.391245ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:32:31.607409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.776435Z","time spent":"830.884386ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:32:31.607486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.776322Z","time spent":"830.6975ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:32:31.607522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.780828Z","time spent":"826.620483ms","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4241,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:32:31.607607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.27261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-25T01:32:31.608837Z","caller":"traceutil/trace.go:171","msg":"trace[1034888247] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:343; }","duration":"830.520665ms","start":"2026-02-25T01:32:30.778291Z","end":"2026-02-25T01:32:31.608812Z","steps":["trace[1034888247] 'agreement among raft nodes before linearized reading' (duration: 829.078882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:31.608903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:30.778282Z","time spent":"830.601013ms","remote":"127.0.0.1:59468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"warn","ts":"2026-02-25T01:32:31.607705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.32182ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:32:31.608954Z","caller":"traceutil/trace.go:171","msg":"trace[1797443702] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:343; }","duration":"661.564616ms","start":"2026-02-25T01:32:30.947375Z","end":"2026-02-25T01:32:31.60894Z","steps":["trace[1797443702] 'agreement among raft nodes before linearized reading' (duration: 660.310479ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:32:31.848987Z","caller":"traceutil/trace.go:171","msg":"trace[881472866] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"229.472702ms","start":"2026-02-25T01:32:31.619473Z","end":"2026-02-25T01:32:31.848945Z","steps":["trace[881472866] 'process raft request' (duration: 177.426008ms)","trace[881472866] 'compare' (duration: 51.871779ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:32:31.856727Z","caller":"traceutil/trace.go:171","msg":"trace[864141627] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"235.631398ms","start":"2026-02-25T01:32:31.621075Z","end":"2026-02-25T01:32:31.856706Z","steps":["trace[864141627] 'process raft request' (duration: 235.488335ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:32:51.009978Z","caller":"traceutil/trace.go:171","msg":"trace[221283784] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"255.687671ms","start":"2026-02-25T01:32:50.754265Z","end":"2026-02-25T01:32:51.009953Z","steps":["trace[221283784] 'read index received' (duration: 255.424018ms)","trace[221283784] 'applied index is now lower than readState.Index' (duration: 262.373µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:32:51.010109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.824894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:32:51.010142Z","caller":"traceutil/trace.go:171","msg":"trace[404048080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"255.937564ms","start":"2026-02-25T01:32:50.754193Z","end":"2026-02-25T01:32:51.010131Z","steps":["trace[404048080] 'agreement among raft nodes before linearized reading' (duration: 255.859107ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:32:51.010161Z","caller":"traceutil/trace.go:171","msg":"trace[1682548657] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"436.834425ms","start":"2026-02-25T01:32:50.573285Z","end":"2026-02-25T01:32:51.01012Z","steps":["trace[1682548657] 'process raft request' (duration: 436.472683ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:51.010344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:50.573273Z","time spent":"436.985819ms","remote":"127.0.0.1:59434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4212,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:32:57.244945Z","caller":"traceutil/trace.go:171","msg":"trace[1216358855] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:577; }","duration":"491.340756ms","start":"2026-02-25T01:32:56.753584Z","end":"2026-02-25T01:32:57.244925Z","steps":["trace[1216358855] 'read index received' (duration: 491.16257ms)","trace[1216358855] 'applied index is now lower than readState.Index' (duration: 176.826µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:32:57.245071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.472108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:32:57.245101Z","caller":"traceutil/trace.go:171","msg":"trace[633374618] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:559; }","duration":"491.543914ms","start":"2026-02-25T01:32:56.753548Z","end":"2026-02-25T01:32:57.245092Z","steps":["trace[633374618] 'agreement among raft nodes before linearized reading' (duration: 491.463197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:57.245131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:56.753514Z","time spent":"491.60987ms","remote":"127.0.0.1:59278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T01:32:57.245383Z","caller":"traceutil/trace.go:171","msg":"trace[1949090301] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"527.832079ms","start":"2026-02-25T01:32:56.71754Z","end":"2026-02-25T01:32:57.245373Z","steps":["trace[1949090301] 'process raft request' (duration: 527.274399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:57.245505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:56.717523Z","time spent":"527.918497ms","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:32:57.461989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.566655ms","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-25T01:32:57.46206Z","caller":"traceutil/trace.go:171","msg":"trace[59204717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"157.676675ms","start":"2026-02-25T01:32:57.304366Z","end":"2026-02-25T01:32:57.462043Z","steps":["trace[59204717] 'range keys from in-memory index tree' (duration: 157.429903ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:58.630651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.224833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T01:32:58.630717Z","caller":"traceutil/trace.go:171","msg":"trace[1840869242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:560; }","duration":"876.353654ms","start":"2026-02-25T01:32:57.75435Z","end":"2026-02-25T01:32:58.630704Z","steps":["trace[1840869242] 'range keys from in-memory index tree' (duration: 876.119483ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:58.630744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:57.754327Z","time spent":"876.411099ms","remote":"127.0.0.1:59264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T01:32:58.630775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.679134ms","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-25T01:32:58.63135Z","caller":"traceutil/trace.go:171","msg":"trace[1935998216] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:560; }","duration":"889.790025ms","start":"2026-02-25T01:32:57.741029Z","end":"2026-02-25T01:32:58.630819Z","steps":["trace[1935998216] 'range keys from in-memory index tree' (duration: 889.523401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:58.631471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:57.741009Z","time spent":"890.451384ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-25T01:32:58.630833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.161648ms","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-25T01:32:58.631667Z","caller":"traceutil/trace.go:171","msg":"trace[622924724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:560; }","duration":"897.045169ms","start":"2026-02-25T01:32:57.734594Z","end":"2026-02-25T01:32:58.631639Z","steps":["trace[622924724] 'range keys from in-memory index tree' (duration: 895.888464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:58.631744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:57.734572Z","time spent":"897.130746ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T01:32:58.630775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.261367ms","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-25T01:32:58.632525Z","caller":"traceutil/trace.go:171","msg":"trace[1112146248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:560; }","duration":"892.041857ms","start":"2026-02-25T01:32:57.740447Z","end":"2026-02-25T01:32:58.632489Z","steps":["trace[1112146248] 'range keys from in-memory index tree' (duration: 890.102593ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:32:58.632659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:32:57.740424Z","time spent":"892.223535ms","remote":"127.0.0.1:59530","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-25T01:33:45.064165Z","caller":"traceutil/trace.go:171","msg":"trace[2029825564] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:869; }","duration":"201.843101ms","start":"2026-02-25T01:33:44.86229Z","end":"2026-02-25T01:33:45.064133Z","steps":["trace[2029825564] 'read index received' (duration: 201.66706ms)","trace[2029825564] 'applied index is now lower than readState.Index' (duration: 174.011µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:33:45.064748Z","caller":"traceutil/trace.go:171","msg":"trace[1114838936] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"205.818068ms","start":"2026-02-25T01:33:44.858362Z","end":"2026-02-25T01:33:45.06418Z","steps":["trace[1114838936] 'process raft request' (duration: 205.582637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:33:45.065726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.370985ms","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-25T01:33:45.065803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.741922ms","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-25T01:33:45.065888Z","caller":"traceutil/trace.go:171","msg":"trace[1886294755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:839; }","duration":"201.868153ms","start":"2026-02-25T01:33:44.863998Z","end":"2026-02-25T01:33:45.065866Z","steps":["trace[1886294755] 'agreement among raft nodes before linearized reading' (duration: 201.254251ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:33:45.065935Z","caller":"traceutil/trace.go:171","msg":"trace[869838254] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:839; }","duration":"203.628016ms","start":"2026-02-25T01:33:44.862234Z","end":"2026-02-25T01:33:45.065862Z","steps":["trace[869838254] 'agreement among raft nodes before linearized reading' (duration: 201.977381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:33:47.758096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.163652ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:33:47.758557Z","caller":"traceutil/trace.go:171","msg":"trace[1515266423] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"623.961872ms","start":"2026-02-25T01:33:47.134556Z","end":"2026-02-25T01:33:47.758518Z","steps":["trace[1515266423] 'process raft request' (duration: 504.278827ms)","trace[1515266423] 'compare' (duration: 118.994111ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:33:47.758721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:33:47.13454Z","time spent":"624.078523ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T01:33:47.757987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.441561ms","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-25T01:33:47.758788Z","caller":"traceutil/trace.go:171","msg":"trace[361815976] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:844; }","duration":"355.256135ms","start":"2026-02-25T01:33:47.403514Z","end":"2026-02-25T01:33:47.758771Z","steps":["trace[361815976] 'range keys from in-memory index tree' (duration: 354.425801ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:33:47.758601Z","caller":"traceutil/trace.go:171","msg":"trace[1579012397] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"623.978591ms","start":"2026-02-25T01:33:47.134603Z","end":"2026-02-25T01:33:47.758581Z","steps":["trace[1579012397] 'process raft request' (duration: 623.71113ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:33:47.75893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:33:47.134594Z","time spent":"624.290963ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:33:47.778606Z","caller":"traceutil/trace.go:171","msg":"trace[1286544830] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"131.866161ms","start":"2026-02-25T01:33:47.646713Z","end":"2026-02-25T01:33:47.778579Z","steps":["trace[1286544830] 'process raft request' (duration: 131.548409ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:10.947667Z","caller":"traceutil/trace.go:171","msg":"trace[1593917312] linearizableReadLoop","detail":"{readStateIndex:946; appliedIndex:945; }","duration":"119.825404ms","start":"2026-02-25T01:34:10.827828Z","end":"2026-02-25T01:34:10.947654Z","steps":["trace[1593917312] 'read index received' (duration: 119.64926ms)","trace[1593917312] 'applied index is now lower than readState.Index' (duration: 175.544µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:34:10.947764Z","caller":"traceutil/trace.go:171","msg":"trace[848037207] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"143.240569ms","start":"2026-02-25T01:34:10.804493Z","end":"2026-02-25T01:34:10.947734Z","steps":["trace[848037207] 'process raft request' (duration: 143.073074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:10.947848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.01174ms","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-25T01:34:10.947893Z","caller":"traceutil/trace.go:171","msg":"trace[1978166992] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:910; }","duration":"120.101513ms","start":"2026-02-25T01:34:10.82778Z","end":"2026-02-25T01:34:10.947881Z","steps":["trace[1978166992] 'agreement among raft nodes before linearized reading' (duration: 119.940598ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:23.610972Z","caller":"traceutil/trace.go:171","msg":"trace[1030484975] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"120.108492ms","start":"2026-02-25T01:34:23.490838Z","end":"2026-02-25T01:34:23.610946Z","steps":["trace[1030484975] 'process raft request' (duration: 119.948266ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:24.390382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.256021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T01:34:24.39062Z","caller":"traceutil/trace.go:171","msg":"trace[175565248] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1018; }","duration":"280.548376ms","start":"2026-02-25T01:34:24.110049Z","end":"2026-02-25T01:34:24.390597Z","steps":["trace[175565248] 'read index received' (duration: 37.902351ms)","trace[175565248] 'applied index is now lower than readState.Index' (duration: 242.644785ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:34:24.390779Z","caller":"traceutil/trace.go:171","msg":"trace[647366592] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"289.698204ms","start":"2026-02-25T01:34:24.101047Z","end":"2026-02-25T01:34:24.390745Z","steps":["trace[647366592] 'process raft request' (duration: 289.477146ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:24.390801Z","caller":"traceutil/trace.go:171","msg":"trace[475402182] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"292.764828ms","start":"2026-02-25T01:34:24.098006Z","end":"2026-02-25T01:34:24.39077Z","steps":["trace[475402182] 'process raft request' (duration: 49.995408ms)","trace[475402182] 'compare' (duration: 242.130116ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:34:24.390901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.848267ms","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-25T01:34:24.390937Z","caller":"traceutil/trace.go:171","msg":"trace[781441816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:979; }","duration":"280.920549ms","start":"2026-02-25T01:34:24.110004Z","end":"2026-02-25T01:34:24.390925Z","steps":["trace[781441816] 'agreement among raft nodes before linearized reading' (duration: 280.748073ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:25.213844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.395178ms","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-25T01:34:25.213913Z","caller":"traceutil/trace.go:171","msg":"trace[1617856679] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:981; }","duration":"114.520463ms","start":"2026-02-25T01:34:25.099379Z","end":"2026-02-25T01:34:25.2139Z","steps":["trace[1617856679] 'range keys from in-memory index tree' (duration: 114.062426ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:25.574648Z","caller":"traceutil/trace.go:171","msg":"trace[1844496778] linearizableReadLoop","detail":"{readStateIndex:1023; appliedIndex:1022; }","duration":"241.783604ms","start":"2026-02-25T01:34:25.33284Z","end":"2026-02-25T01:34:25.574624Z","steps":["trace[1844496778] 'read index received' (duration: 241.609048ms)","trace[1844496778] 'applied index is now lower than readState.Index' (duration: 173.546µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:34:25.574692Z","caller":"traceutil/trace.go:171","msg":"trace[38649177] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"357.563674ms","start":"2026-02-25T01:34:25.217105Z","end":"2026-02-25T01:34:25.574668Z","steps":["trace[38649177] 'process raft request' (duration: 357.381747ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:25.574795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.91452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-25T01:34:25.57498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:34:25.217092Z","time spent":"357.763371ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:34:25.575086Z","caller":"traceutil/trace.go:171","msg":"trace[1031892866] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:982; }","duration":"242.213691ms","start":"2026-02-25T01:34:25.332809Z","end":"2026-02-25T01:34:25.575023Z","steps":["trace[1031892866] 'agreement among raft nodes before linearized reading' (duration: 241.902879ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:27.886102Z","caller":"traceutil/trace.go:171","msg":"trace[1811769704] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"113.802225ms","start":"2026-02-25T01:34:27.772276Z","end":"2026-02-25T01:34:27.886079Z","steps":["trace[1811769704] 'process raft request' (duration: 113.67258ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:28.811823Z","caller":"traceutil/trace.go:171","msg":"trace[171267812] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1030; }","duration":"357.329466ms","start":"2026-02-25T01:34:28.454467Z","end":"2026-02-25T01:34:28.811797Z","steps":["trace[171267812] 'read index received' (duration: 357.17794ms)","trace[171267812] 'applied index is now lower than readState.Index' (duration: 149.406µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:34:28.812214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.714422ms","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-25T01:34:28.811928Z","caller":"traceutil/trace.go:171","msg":"trace[1953266811] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"388.703112ms","start":"2026-02-25T01:34:28.423183Z","end":"2026-02-25T01:34:28.811886Z","steps":["trace[1953266811] 'process raft request' (duration: 388.431151ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:28.812332Z","caller":"traceutil/trace.go:171","msg":"trace[710684785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:990; }","duration":"357.858867ms","start":"2026-02-25T01:34:28.454448Z","end":"2026-02-25T01:34:28.812307Z","steps":["trace[710684785] 'agreement among raft nodes before linearized reading' (duration: 357.468702ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:28.812531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:34:28.454371Z","time spent":"358.146098ms","remote":"127.0.0.1:59530","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-25T01:34:28.812848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:34:28.423137Z","time spent":"389.304005ms","remote":"127.0.0.1:59434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5040,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:34:28.822577Z","caller":"traceutil/trace.go:171","msg":"trace[1114344791] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"317.042919ms","start":"2026-02-25T01:34:28.505499Z","end":"2026-02-25T01:34:28.822542Z","steps":["trace[1114344791] 'process raft request' (duration: 316.786209ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:28.822702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.337749ms","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-25T01:34:28.822767Z","caller":"traceutil/trace.go:171","msg":"trace[517473069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:991; }","duration":"287.440542ms","start":"2026-02-25T01:34:28.535307Z","end":"2026-02-25T01:34:28.822747Z","steps":["trace[517473069] 'agreement among raft nodes before linearized reading' (duration: 287.174622ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:28.822796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:34:28.505463Z","time spent":"317.196695ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:34:31.849093Z","caller":"traceutil/trace.go:171","msg":"trace[349979933] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"178.079654ms","start":"2026-02-25T01:34:31.670987Z","end":"2026-02-25T01:34:31.849067Z","steps":["trace[349979933] 'process raft request' (duration: 177.864705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:32.255393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.309733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-25T01:34:32.255559Z","caller":"traceutil/trace.go:171","msg":"trace[1083673472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1000; }","duration":"101.558393ms","start":"2026-02-25T01:34:32.15398Z","end":"2026-02-25T01:34:32.255539Z","steps":["trace[1083673472] 'range keys from in-memory index tree' (duration: 101.059153ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:34.292204Z","caller":"traceutil/trace.go:171","msg":"trace[1721888842] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1048; }","duration":"206.290875ms","start":"2026-02-25T01:34:34.085879Z","end":"2026-02-25T01:34:34.29217Z","steps":["trace[1721888842] 'read index received' (duration: 188.277444ms)","trace[1721888842] 'applied index is now lower than readState.Index' (duration: 18.012681ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:34:34.292378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.486703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-25T01:34:34.292506Z","caller":"traceutil/trace.go:171","msg":"trace[2089840319] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"207.746187ms","start":"2026-02-25T01:34:34.084734Z","end":"2026-02-25T01:34:34.29248Z","steps":["trace[2089840319] 'process raft request' (duration: 189.410782ms)","trace[2089840319] 'compare' (duration: 17.946808ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:34:34.292585Z","caller":"traceutil/trace.go:171","msg":"trace[1577576826] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1006; }","duration":"206.536915ms","start":"2026-02-25T01:34:34.085864Z","end":"2026-02-25T01:34:34.292401Z","steps":["trace[1577576826] 'agreement among raft nodes before linearized reading' (duration: 206.390798ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:35.592332Z","caller":"traceutil/trace.go:171","msg":"trace[438311534] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"311.484872ms","start":"2026-02-25T01:34:35.280822Z","end":"2026-02-25T01:34:35.592307Z","steps":["trace[438311534] 'process raft request' (duration: 311.335965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:35.592501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T01:34:35.280803Z","time spent":"311.603016ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T01:34:35.634931Z","caller":"traceutil/trace.go:171","msg":"trace[1747876069] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"196.23582ms","start":"2026-02-25T01:34:35.438669Z","end":"2026-02-25T01:34:35.634905Z","steps":["trace[1747876069] 'process raft request' (duration: 196.111115ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:35.831318Z","caller":"traceutil/trace.go:171","msg":"trace[1755541227] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"108.920128ms","start":"2026-02-25T01:34:35.722374Z","end":"2026-02-25T01:34:35.831294Z","steps":["trace[1755541227] 'process raft request' (duration: 29.579012ms)","trace[1755541227] 'compare' (duration: 79.232921ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T01:34:36.203499Z","caller":"traceutil/trace.go:171","msg":"trace[1857798814] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"103.12112ms","start":"2026-02-25T01:34:36.100354Z","end":"2026-02-25T01:34:36.203475Z","steps":["trace[1857798814] 'process raft request' (duration: 102.957483ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:39.226931Z","caller":"traceutil/trace.go:171","msg":"trace[564894944] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"213.107237ms","start":"2026-02-25T01:34:39.013798Z","end":"2026-02-25T01:34:39.226906Z","steps":["trace[564894944] 'process raft request' (duration: 212.980931ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:34:39.227049Z","caller":"traceutil/trace.go:171","msg":"trace[1998322628] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1068; }","duration":"156.009977ms","start":"2026-02-25T01:34:39.071005Z","end":"2026-02-25T01:34:39.227015Z","steps":["trace[1998322628] 'read index received' (duration: 155.995376ms)","trace[1998322628] 'applied index is now lower than readState.Index' (duration: 12.091µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:34:39.227247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.206906ms","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-25T01:34:39.227956Z","caller":"traceutil/trace.go:171","msg":"trace[137296397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1025; }","duration":"156.95585ms","start":"2026-02-25T01:34:39.07098Z","end":"2026-02-25T01:34:39.227935Z","steps":["trace[137296397] 'agreement among raft nodes before linearized reading' (duration: 156.07657ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:34:39.277613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.185509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-25T01:34:39.277847Z","caller":"traceutil/trace.go:171","msg":"trace[698250404] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1026; }","duration":"138.394188ms","start":"2026-02-25T01:34:39.139349Z","end":"2026-02-25T01:34:39.277743Z","steps":["trace[698250404] 'agreement among raft nodes before linearized reading' (duration: 138.168638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:06.916202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.595687ms","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-25T01:35:06.916282Z","caller":"traceutil/trace.go:171","msg":"trace[695615464] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1107; }","duration":"294.690823ms","start":"2026-02-25T01:35:06.621571Z","end":"2026-02-25T01:35:06.916262Z","steps":["trace[695615464] 'range keys from in-memory index tree' (duration: 294.401657ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:07.584434Z","caller":"traceutil/trace.go:171","msg":"trace[853064442] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"148.386624ms","start":"2026-02-25T01:35:07.436021Z","end":"2026-02-25T01:35:07.584408Z","steps":["trace[853064442] 'process raft request' (duration: 141.870695ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:07.584424Z","caller":"traceutil/trace.go:171","msg":"trace[107045108] linearizableReadLoop","detail":"{readStateIndex:1160; appliedIndex:1159; }","duration":"108.75952ms","start":"2026-02-25T01:35:07.475631Z","end":"2026-02-25T01:35:07.584391Z","steps":["trace[107045108] 'read index received' (duration: 102.202218ms)","trace[107045108] 'applied index is now lower than readState.Index' (duration: 6.555832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T01:35:07.584692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.012494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-bz7bm\" ","response":"range_response_count:1 size:4624"} {"level":"info","ts":"2026-02-25T01:35:07.584959Z","caller":"traceutil/trace.go:171","msg":"trace[1856883017] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-bz7bm; range_end:; response_count:1; response_revision:1110; }","duration":"109.315141ms","start":"2026-02-25T01:35:07.475623Z","end":"2026-02-25T01:35:07.584938Z","steps":["trace[1856883017] 'agreement among raft nodes before linearized reading' (duration: 108.829533ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T01:35:09.734649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.131704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-6djpw\" ","response":"range_response_count:1 size:4847"} {"level":"info","ts":"2026-02-25T01:35:09.734674Z","caller":"traceutil/trace.go:171","msg":"trace[93044593] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"143.260233ms","start":"2026-02-25T01:35:09.591366Z","end":"2026-02-25T01:35:09.734626Z","steps":["trace[93044593] 'process raft request' (duration: 142.967436ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T01:35:09.734736Z","caller":"traceutil/trace.go:171","msg":"trace[371077710] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-6djpw; range_end:; response_count:1; response_revision:1115; }","duration":"100.259951ms","start":"2026-02-25T01:35:09.634456Z","end":"2026-02-25T01:35:09.734716Z","steps":["trace[371077710] 'agreement among raft nodes before linearized reading' (duration: 100.040309ms)"],"step_count":1}