{"level":"warn","ts":"2026-02-25T22:00:55.823966Z","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-25T22:00:55.824041Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25: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.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-25T22:00:55.824115Z","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-25T22:00:55.824124Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-02-25T22:00:55.824139Z","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-25T22:00:55.824765Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-02-25T22:00:55.824836Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-25T22:00:55.830303Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.293352ms"} {"level":"info","ts":"2026-02-25T22:00:55.835595Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-02-25T22:00:55.835662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T22:00:55.835685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-02-25T22:00:55.835699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T22:00:55.835712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-02-25T22:00:55.835746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-02-25T22:00:55.843806Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T22:00:55.844965Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T22:00:55.846199Z","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-25T22:00:55.848013Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T22:00:55.85344Z","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-25T22:00:55.85355Z","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-25T22:00:55.853608Z","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-25T22:00:55.853649Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T22:00:55.85935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-02-25T22:00:55.859471Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-02-25T22:00:55.859905Z","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-25T22:00:55.860107Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-02-25T22:00:55.860134Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-02-25T22:00:55.860705Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T22:00:55.860773Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T22:00:56.136956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T22:00:56.137014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T22:00:56.13705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-02-25T22:00:56.137069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-02-25T22:00:56.137085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-02-25T22:00:56.137111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-02-25T22:00:56.137129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-02-25T22:00:56.138214Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T22:00:56.138229Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T22:00:56.138361Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T22:00:56.138411Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T22:00:56.13926Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T22:00:56.13944Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T22:00:56.139528Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T22:00:56.141102Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-25T22:00:56.141428Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-02-25T22:00:56.141882Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T22:00:56.142364Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T22:00:57.763328Z","caller":"traceutil/trace.go:171","msg":"trace[200458805] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"161.277099ms","start":"2026-02-25T22:00:57.602021Z","end":"2026-02-25T22:00:57.763299Z","steps":["trace[200458805] 'process raft request' (duration: 160.93645ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.564241Z","caller":"traceutil/trace.go:171","msg":"trace[1020649003] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"962.067027ms","start":"2026-02-25T22:00:57.602125Z","end":"2026-02-25T22:00:58.564192Z","steps":["trace[1020649003] 'process raft request' (duration: 961.608382ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.564224Z","caller":"traceutil/trace.go:171","msg":"trace[979033983] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"949.1873ms","start":"2026-02-25T22:00:57.614984Z","end":"2026-02-25T22:00:58.564171Z","steps":["trace[979033983] 'read index received' (duration: 148.040692ms)","trace[979033983] 'applied index is now lower than readState.Index' (duration: 801.145528ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T22:00:58.564413Z","caller":"traceutil/trace.go:171","msg":"trace[64332204] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"881.215131ms","start":"2026-02-25T22:00:57.683186Z","end":"2026-02-25T22:00:58.564401Z","steps":["trace[64332204] 'process raft request' (duration: 880.840481ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.564407Z","caller":"traceutil/trace.go:171","msg":"trace[388900408] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"881.214691ms","start":"2026-02-25T22:00:57.683139Z","end":"2026-02-25T22:00:58.564354Z","steps":["trace[388900408] 'process raft request' (duration: 880.864252ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.564487Z","caller":"traceutil/trace.go:171","msg":"trace[784400244] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"881.069823ms","start":"2026-02-25T22:00:57.68341Z","end":"2026-02-25T22:00:58.56448Z","steps":["trace[784400244] 'process raft request' (duration: 880.64302ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.564571Z","caller":"traceutil/trace.go:171","msg":"trace[2118901925] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"881.604042ms","start":"2026-02-25T22:00:57.682954Z","end":"2026-02-25T22:00:58.564558Z","steps":["trace[2118901925] 'process raft request' (duration: 881.01511ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.564627Z","caller":"traceutil/trace.go:171","msg":"trace[954519944] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"881.890947ms","start":"2026-02-25T22:00:57.682699Z","end":"2026-02-25T22:00:58.56459Z","steps":["trace[954519944] 'process raft request' (duration: 881.212301ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.56462Z","caller":"traceutil/trace.go:171","msg":"trace[1425530733] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"881.683357ms","start":"2026-02-25T22:00:57.682909Z","end":"2026-02-25T22:00:58.564592Z","steps":["trace[1425530733] 'process raft request' (duration: 881.036902ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:58.564774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.778703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T22:00:58.564828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.827879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T22:00:58.564844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.339661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T22:00:58.56485Z","caller":"traceutil/trace.go:171","msg":"trace[1263009765] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"949.88957ms","start":"2026-02-25T22:00:57.614945Z","end":"2026-02-25T22:00:58.564835Z","steps":["trace[1263009765] 'agreement among raft nodes before linearized reading' (duration: 949.677247ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.564867Z","caller":"traceutil/trace.go:171","msg":"trace[1285094310] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"831.905013ms","start":"2026-02-25T22:00:57.73295Z","end":"2026-02-25T22:00:58.564855Z","steps":["trace[1285094310] 'agreement among raft nodes before linearized reading' (duration: 831.820078ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:58.564876Z","caller":"traceutil/trace.go:171","msg":"trace[192574300] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:0; response_revision:11; }","duration":"884.388074ms","start":"2026-02-25T22:00:57.680477Z","end":"2026-02-25T22:00:58.564865Z","steps":["trace[192574300] 'agreement among raft nodes before linearized reading' (duration: 884.350822ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:58.564855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.488425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T22:00:58.564884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.614936Z","time spent":"949.939853ms","remote":"127.0.0.1:41430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-02-25T22:00:58.564922Z","caller":"traceutil/trace.go:171","msg":"trace[954523214] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"883.57092ms","start":"2026-02-25T22:00:57.68134Z","end":"2026-02-25T22:00:58.564911Z","steps":["trace[954523214] 'agreement among raft nodes before linearized reading' (duration: 883.475825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:58.564918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.680466Z","time spent":"884.445147ms","remote":"127.0.0.1:41504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.25\" "} {"level":"warn","ts":"2026-02-25T22:00:58.564942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.602117Z","time spent":"962.219266ms","remote":"127.0.0.1:41544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T22:00:58.565076Z","caller":"traceutil/trace.go:171","msg":"trace[1307737372] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"873.268572ms","start":"2026-02-25T22:00:57.691794Z","end":"2026-02-25T22:00:58.565063Z","steps":["trace[1307737372] 'process raft request' (duration: 872.284778ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:58.565136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.691786Z","time spent":"873.320764ms","remote":"127.0.0.1:41686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:58.565192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.683178Z","time spent":"881.283745ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:58.565227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.783032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T22:00:58.56528Z","caller":"traceutil/trace.go:171","msg":"trace[1304359738] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"881.849756ms","start":"2026-02-25T22:00:57.683418Z","end":"2026-02-25T22:00:58.565268Z","steps":["trace[1304359738] 'agreement among raft nodes before linearized reading' (duration: 881.776582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:58.565313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.683411Z","time spent":"881.895139ms","remote":"127.0.0.1:41574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-02-25T22:00:58.565315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.682684Z","time spent":"882.011865ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T22:00:58.565323Z","caller":"traceutil/trace.go:171","msg":"trace[294433121] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"873.386429ms","start":"2026-02-25T22:00:57.691927Z","end":"2026-02-25T22:00:58.565313Z","steps":["trace[294433121] 'process raft request' (duration: 872.211024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:58.565372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.691922Z","time spent":"873.427261ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:58.565445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.683126Z","time spent":"881.347168ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:58.564787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.117084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T22:00:58.565503Z","caller":"traceutil/trace.go:171","msg":"trace[209975202] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"907.884955ms","start":"2026-02-25T22:00:57.657609Z","end":"2026-02-25T22:00:58.565494Z","steps":["trace[209975202] 'agreement among raft nodes before linearized reading' (duration: 907.129665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:58.565541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.657583Z","time spent":"907.948939ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-25T22:00:58.565575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.682896Z","time spent":"881.804143ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:58.565921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.683392Z","time spent":"881.126997ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:58.566354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.682919Z","time spent":"881.683856ms","remote":"127.0.0.1:41472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:58.56778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.681332Z","time spent":"886.432606ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-25T22:00:58.564912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:57.732931Z","time spent":"831.974657ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-25T22:00:59.173978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.412646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-25T22:00:59.174074Z","caller":"traceutil/trace.go:171","msg":"trace[607898315] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"603.961039ms","start":"2026-02-25T22:00:58.570101Z","end":"2026-02-25T22:00:59.174062Z","steps":["trace[607898315] 'read index received' (duration: 84.417586ms)","trace[607898315] 'applied index is now lower than readState.Index' (duration: 519.542633ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T22:00:59.174125Z","caller":"traceutil/trace.go:171","msg":"trace[796188189] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"605.143793ms","start":"2026-02-25T22:00:58.568974Z","end":"2026-02-25T22:00:59.174118Z","steps":["trace[796188189] 'process raft request' (duration: 85.430021ms)","trace[796188189] 'compare' (duration: 519.285798ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T22:00:59.17416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.568955Z","time spent":"605.190555ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:59.174458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.304107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-cjmzx\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-02-25T22:00:59.17453Z","caller":"traceutil/trace.go:171","msg":"trace[685573050] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-cjmzx; range_end:; response_count:1; response_revision:12; }","duration":"604.442175ms","start":"2026-02-25T22:00:58.570071Z","end":"2026-02-25T22:00:59.174513Z","steps":["trace[685573050] 'agreement among raft nodes before linearized reading' (duration: 604.118618ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.174574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.57006Z","time spent":"604.505008ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":880,"request content":"key:\"/registry/certificatesigningrequests/csr-cjmzx\" "} {"level":"info","ts":"2026-02-25T22:00:59.175811Z","caller":"traceutil/trace.go:171","msg":"trace[2053239153] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"603.339056ms","start":"2026-02-25T22:00:58.572442Z","end":"2026-02-25T22:00:59.175781Z","steps":["trace[2053239153] 'process raft request' (duration: 602.850859ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:59.175901Z","caller":"traceutil/trace.go:171","msg":"trace[1675318960] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"602.787065ms","start":"2026-02-25T22:00:58.573097Z","end":"2026-02-25T22:00:59.175884Z","steps":["trace[1675318960] 'process raft request' (duration: 602.485278ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.175949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.572431Z","time spent":"603.458242ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:59.175981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.57309Z","time spent":"602.845808ms","remote":"127.0.0.1:41472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T22:00:59.176083Z","caller":"traceutil/trace.go:171","msg":"trace[156664086] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"602.370893ms","start":"2026-02-25T22:00:58.573697Z","end":"2026-02-25T22:00:59.176067Z","steps":["trace[156664086] 'process raft request' (duration: 602.065226ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.176173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.573691Z","time spent":"602.450747ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:59.176259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.723805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-02-25T22:00:59.176335Z","caller":"traceutil/trace.go:171","msg":"trace[891861510] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"603.177206ms","start":"2026-02-25T22:00:58.573151Z","end":"2026-02-25T22:00:59.176329Z","steps":["trace[891861510] 'process raft request' (duration: 602.505109ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.176391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.573135Z","time spent":"603.231829ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T22:00:59.176376Z","caller":"traceutil/trace.go:171","msg":"trace[2068655778] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"602.408765ms","start":"2026-02-25T22:00:58.573958Z","end":"2026-02-25T22:00:59.176367Z","steps":["trace[2068655778] 'process raft request' (duration: 601.927949ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:59.176341Z","caller":"traceutil/trace.go:171","msg":"trace[1046454421] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"605.81881ms","start":"2026-02-25T22:00:58.57051Z","end":"2026-02-25T22:00:59.176329Z","steps":["trace[1046454421] 'agreement among raft nodes before linearized reading' (duration: 605.554425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.176482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.570506Z","time spent":"605.964898ms","remote":"127.0.0.1:41686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-25T22:00:59.176533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.573951Z","time spent":"602.50153ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T22:00:59.176304Z","caller":"traceutil/trace.go:171","msg":"trace[1095201690] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"602.88505ms","start":"2026-02-25T22:00:58.573408Z","end":"2026-02-25T22:00:59.176293Z","steps":["trace[1095201690] 'process raft request' (duration: 602.310529ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:00:59.1766Z","caller":"traceutil/trace.go:171","msg":"trace[686686923] transaction","detail":"{read_only:false; number_of_response:0; response_revision:16; }","duration":"603.05678ms","start":"2026-02-25T22:00:58.573531Z","end":"2026-02-25T22:00:59.176588Z","steps":["trace[686686923] 'process raft request' (duration: 602.212684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.176627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.573399Z","time spent":"603.209188ms","remote":"127.0.0.1:41554","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-25T22:00:59.176692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.573526Z","time spent":"603.106432ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-25T22:00:59.176939Z","caller":"traceutil/trace.go:171","msg":"trace[1795041865] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"600.126761ms","start":"2026-02-25T22:00:58.576773Z","end":"2026-02-25T22:00:59.1769Z","steps":["trace[1795041865] 'process raft request' (duration: 599.19591ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.177054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.034308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T22:00:59.177088Z","caller":"traceutil/trace.go:171","msg":"trace[1849173486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"569.080861ms","start":"2026-02-25T22:00:58.607997Z","end":"2026-02-25T22:00:59.177078Z","steps":["trace[1849173486] 'agreement among raft nodes before linearized reading' (duration: 569.027798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.177068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.576766Z","time spent":"600.208945ms","remote":"127.0.0.1:41686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T22:00:59.177154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.953155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-02-25T22:00:59.177177Z","caller":"traceutil/trace.go:171","msg":"trace[1676917510] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"547.000469ms","start":"2026-02-25T22:00:58.63017Z","end":"2026-02-25T22:00:59.17717Z","steps":["trace[1676917510] 'agreement among raft nodes before linearized reading' (duration: 546.958886ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.177209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.630155Z","time spent":"547.049081ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-25T22:00:59.177207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.005945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T22:00:59.177113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.607987Z","time spent":"569.120582ms","remote":"127.0.0.1:41458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T22:00:59.17733Z","caller":"traceutil/trace.go:171","msg":"trace[1214336679] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:19; }","duration":"404.160523ms","start":"2026-02-25T22:00:58.773077Z","end":"2026-02-25T22:00:59.177238Z","steps":["trace[1214336679] 'agreement among raft nodes before linearized reading' (duration: 404.025096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.177385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.032182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-25T22:00:59.177412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.77305Z","time spent":"404.350313ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-02-25T22:00:59.177438Z","caller":"traceutil/trace.go:171","msg":"trace[546876514] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:19; }","duration":"597.319198ms","start":"2026-02-25T22:00:58.580102Z","end":"2026-02-25T22:00:59.177421Z","steps":["trace[546876514] 'agreement among raft nodes before linearized reading' (duration: 597.264245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.177488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.580078Z","time spent":"597.401582ms","remote":"127.0.0.1:41850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-02-25T22:00:59.17749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.563921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T22:00:59.177528Z","caller":"traceutil/trace.go:171","msg":"trace[2097684772] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:19; }","duration":"597.618784ms","start":"2026-02-25T22:00:58.579901Z","end":"2026-02-25T22:00:59.17752Z","steps":["trace[2097684772] 'agreement among raft nodes before linearized reading' (duration: 597.55837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.177567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.579893Z","time spent":"597.668337ms","remote":"127.0.0.1:41878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-02-25T22:00:59.177323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.311557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-25T22:00:59.177721Z","caller":"traceutil/trace.go:171","msg":"trace[2091197302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"606.73221ms","start":"2026-02-25T22:00:58.570977Z","end":"2026-02-25T22:00:59.177709Z","steps":["trace[2091197302] 'agreement among raft nodes before linearized reading' (duration: 606.284886ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:00:59.177832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:00:58.570972Z","time spent":"606.847576ms","remote":"127.0.0.1:41460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T22:01:02.506382Z","caller":"traceutil/trace.go:171","msg":"trace[847625654] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"156.299387ms","start":"2026-02-25T22:01:02.350057Z","end":"2026-02-25T22:01:02.506356Z","steps":["trace[847625654] 'process raft request' (duration: 156.130906ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:01:32.161983Z","caller":"traceutil/trace.go:171","msg":"trace[145555696] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"179.110148ms","start":"2026-02-25T22:01:31.982858Z","end":"2026-02-25T22:01:32.161968Z","steps":["trace[145555696] 'read index received' (duration: 179.029563ms)","trace[145555696] 'applied index is now lower than readState.Index' (duration: 79.775µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T22:01:32.162067Z","caller":"traceutil/trace.go:171","msg":"trace[224467018] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"474.282967ms","start":"2026-02-25T22:01:31.687744Z","end":"2026-02-25T22:01:32.162027Z","steps":["trace[224467018] 'process raft request' (duration: 474.123808ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:01:32.162198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:31.687712Z","time spent":"474.420706ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T22:01:32.162201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.324081ms","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-25T22:01:32.162264Z","caller":"traceutil/trace.go:171","msg":"trace[1588707854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:545; }","duration":"179.443719ms","start":"2026-02-25T22:01:31.982803Z","end":"2026-02-25T22:01:32.162247Z","steps":["trace[1588707854] 'agreement among raft nodes before linearized reading' (duration: 179.232766ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:01:32.48288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.845615ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T22:01:32.482995Z","caller":"traceutil/trace.go:171","msg":"trace[1831990264] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:564; }","duration":"320.946876ms","start":"2026-02-25T22:01:32.162032Z","end":"2026-02-25T22:01:32.482979Z","steps":["trace[1831990264] 'read index received' (duration: 100.934551ms)","trace[1831990264] 'applied index is now lower than readState.Index' (duration: 220.011015ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T22:01:32.483212Z","caller":"traceutil/trace.go:171","msg":"trace[436151171] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"385.481686ms","start":"2026-02-25T22:01:32.097718Z","end":"2026-02-25T22:01:32.483199Z","steps":["trace[436151171] 'process raft request' (duration: 165.222406ms)","trace[436151171] 'compare' (duration: 219.694226ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T22:01:32.483292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.097695Z","time spent":"385.565512ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T22:01:32.48353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.996527ms","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-25T22:01:32.483568Z","caller":"traceutil/trace.go:171","msg":"trace[1786752950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:546; }","duration":"344.05118ms","start":"2026-02-25T22:01:32.139505Z","end":"2026-02-25T22:01:32.483556Z","steps":["trace[1786752950] 'agreement among raft nodes before linearized reading' (duration: 343.935363ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:01:32.483601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.139495Z","time spent":"344.100092ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T22:01:32.483674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.098675ms","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-25T22:01:32.483748Z","caller":"traceutil/trace.go:171","msg":"trace[1417885062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:546; }","duration":"362.213852ms","start":"2026-02-25T22:01:32.121517Z","end":"2026-02-25T22:01:32.483731Z","steps":["trace[1417885062] 'agreement among raft nodes before linearized reading' (duration: 361.981278ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:01:32.483797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.121506Z","time spent":"362.282687ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T22:01:33.211071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.599729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T22:01:33.211208Z","caller":"traceutil/trace.go:171","msg":"trace[2115443930] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.043082145s","start":"2026-02-25T22:01:32.168109Z","end":"2026-02-25T22:01:33.211191Z","steps":["trace[2115443930] 'process raft request' (duration: 652.286684ms)","trace[2115443930] 'compare' (duration: 390.484772ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T22:01:33.211274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.168077Z","time spent":"1.04316894s","remote":"127.0.0.1:41754","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-25T22:01:33.211433Z","caller":"traceutil/trace.go:171","msg":"trace[1971541884] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.008000483s","start":"2026-02-25T22:01:32.203406Z","end":"2026-02-25T22:01:33.211406Z","steps":["trace[1971541884] 'process raft request' (duration: 1.007752228s)"],"step_count":1} {"level":"info","ts":"2026-02-25T22:01:33.211487Z","caller":"traceutil/trace.go:171","msg":"trace[1817624543] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:565; }","duration":"728.312943ms","start":"2026-02-25T22:01:32.483026Z","end":"2026-02-25T22:01:33.211339Z","steps":["trace[1817624543] 'read index received' (duration: 337.468239ms)","trace[1817624543] 'applied index is now lower than readState.Index' (duration: 390.844114ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T22:01:33.211586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.203382Z","time spent":"1.00811768s","remote":"127.0.0.1:41686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4744,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T22:01:33.211734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.333817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-25T22:01:33.211801Z","caller":"traceutil/trace.go:171","msg":"trace[1378542266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"812.434634ms","start":"2026-02-25T22:01:32.399345Z","end":"2026-02-25T22:01:33.211779Z","steps":["trace[1378542266] 'agreement among raft nodes before linearized reading' (duration: 812.122065ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:01:33.211841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.399325Z","time spent":"812.507918ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-25T22:01:33.252185Z","caller":"traceutil/trace.go:171","msg":"trace[1168326647] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"764.026545ms","start":"2026-02-25T22:01:32.48814Z","end":"2026-02-25T22:01:33.252167Z","steps":["trace[1168326647] 'process raft request' (duration: 763.592009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:01:33.252231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.891448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T22:01:33.252289Z","caller":"traceutil/trace.go:171","msg":"trace[8711078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"616.982204ms","start":"2026-02-25T22:01:32.635294Z","end":"2026-02-25T22:01:33.252276Z","steps":["trace[8711078] 'agreement among raft nodes before linearized reading' (duration: 616.624302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:01:33.252298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.488077Z","time spent":"764.163834ms","remote":"127.0.0.1:41754","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-25T22:01:33.252332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.635279Z","time spent":"617.044248ms","remote":"127.0.0.1:41458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-25T22:01:33.251842Z","caller":"traceutil/trace.go:171","msg":"trace[1613185024] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"763.878237ms","start":"2026-02-25T22:01:32.487943Z","end":"2026-02-25T22:01:33.251821Z","steps":["trace[1613185024] 'process raft request' (duration: 763.669854ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T22:01:33.252843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T22:01:32.487917Z","time spent":"764.881789ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T22:01:36.998236Z","caller":"traceutil/trace.go:171","msg":"trace[555855421] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"189.805633ms","start":"2026-02-25T22:01:36.808413Z","end":"2026-02-25T22:01:36.998219Z","steps":["trace[555855421] 'process raft request' (duration: 189.582339ms)"],"step_count":1}