{"level":"warn","ts":"2026-01-28T14:54:48.930673Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-01-28T14:54:48.930784Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.132: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.19.213.132:2380","--initial-cluster=instance=https://199.19.213.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.132: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-01-28T14:54:48.930881Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-01-28T14:54:48.930901Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.132:2380"]} {"level":"info","ts":"2026-01-28T14:54:48.930929Z","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-01-28T14:54:48.931637Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.132:2379"]} {"level":"info","ts":"2026-01-28T14:54:48.931721Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.132:2380"],"listen-peer-urls":["https://199.19.213.132:2380"],"advertise-client-urls":["https://199.19.213.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.132: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-01-28T14:54:48.949967Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"18.024544ms"} {"level":"info","ts":"2026-01-28T14:54:48.964979Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"19a81b20c4b111c3","cluster-id":"42a0cab9df6b0eb"} {"level":"info","ts":"2026-01-28T14:54:48.965058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 switched to configuration voters=()"} {"level":"info","ts":"2026-01-28T14:54:48.965081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became follower at term 0"} {"level":"info","ts":"2026-01-28T14:54:48.965094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 19a81b20c4b111c3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-01-28T14:54:48.965103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became follower at term 1"} {"level":"info","ts":"2026-01-28T14:54:48.96514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 switched to configuration voters=(1848757474588430787)"} {"level":"warn","ts":"2026-01-28T14:54:48.995225Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-01-28T14:54:49.00454Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-01-28T14:54:49.008332Z","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-01-28T14:54:49.027338Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"19a81b20c4b111c3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-01-28T14:54:49.030371Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"19a81b20c4b111c3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-01-28T14:54:49.030513Z","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-01-28T14:54:49.030535Z","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-01-28T14:54:49.030545Z","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-01-28T14:54:49.030719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 switched to configuration voters=(1848757474588430787)"} {"level":"info","ts":"2026-01-28T14:54:49.030781Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"42a0cab9df6b0eb","local-member-id":"19a81b20c4b111c3","added-peer-id":"19a81b20c4b111c3","added-peer-peer-urls":["https://199.19.213.132:2380"]} {"level":"info","ts":"2026-01-28T14:54:49.039854Z","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-01-28T14:54:49.046364Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.132:2380"} {"level":"info","ts":"2026-01-28T14:54:49.046414Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.132:2380"} {"level":"info","ts":"2026-01-28T14:54:49.046615Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"19a81b20c4b111c3","initial-advertise-peer-urls":["https://199.19.213.132:2380"],"listen-peer-urls":["https://199.19.213.132:2380"],"advertise-client-urls":["https://199.19.213.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-01-28T14:54:49.046663Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-01-28T14:54:49.266154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 is starting a new election at term 1"} {"level":"info","ts":"2026-01-28T14:54:49.266271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became pre-candidate at term 1"} {"level":"info","ts":"2026-01-28T14:54:49.266318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 received MsgPreVoteResp from 19a81b20c4b111c3 at term 1"} {"level":"info","ts":"2026-01-28T14:54:49.266379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became candidate at term 2"} {"level":"info","ts":"2026-01-28T14:54:49.266453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 received MsgVoteResp from 19a81b20c4b111c3 at term 2"} {"level":"info","ts":"2026-01-28T14:54:49.266505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"19a81b20c4b111c3 became leader at term 2"} {"level":"info","ts":"2026-01-28T14:54:49.266545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 19a81b20c4b111c3 elected leader 19a81b20c4b111c3 at term 2"} {"level":"info","ts":"2026-01-28T14:54:49.267203Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-01-28T14:54:49.267812Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"19a81b20c4b111c3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.132:2379]}","request-path":"/0/members/19a81b20c4b111c3/attributes","cluster-id":"42a0cab9df6b0eb","publish-timeout":"7s"} {"level":"info","ts":"2026-01-28T14:54:49.268118Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-01-28T14:54:49.268499Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-01-28T14:54:49.270604Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.132:2379"} {"level":"info","ts":"2026-01-28T14:54:49.268566Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"42a0cab9df6b0eb","local-member-id":"19a81b20c4b111c3","cluster-version":"3.5"} {"level":"info","ts":"2026-01-28T14:54:49.270834Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-01-28T14:54:49.270886Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-01-28T14:54:49.273085Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-01-28T14:54:49.275189Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-01-28T14:54:49.275259Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-01-28T14:55:07.701206Z","caller":"traceutil/trace.go:171","msg":"trace[135343362] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"296.655558ms","start":"2026-01-28T14:55:07.404532Z","end":"2026-01-28T14:55:07.701188Z","steps":["trace[135343362] 'process raft request' (duration: 296.530413ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:08.861611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.338979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-28T14:55:08.861748Z","caller":"traceutil/trace.go:171","msg":"trace[1718257806] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"1.150368525s","start":"2026-01-28T14:55:07.711362Z","end":"2026-01-28T14:55:08.86173Z","steps":["trace[1718257806] 'process raft request' (duration: 634.281839ms)","trace[1718257806] 'compare' (duration: 515.183683ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:08.861802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:07.711338Z","time spent":"1.150441238s","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-28T14:55:08.894075Z","caller":"traceutil/trace.go:171","msg":"trace[1276943304] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:440; }","duration":"892.062824ms","start":"2026-01-28T14:55:08.00199Z","end":"2026-01-28T14:55:08.894052Z","steps":["trace[1276943304] 'read index received' (duration: 343.73343ms)","trace[1276943304] 'applied index is now lower than readState.Index' (duration: 548.328424ms)"],"step_count":2} {"level":"info","ts":"2026-01-28T14:55:08.894227Z","caller":"traceutil/trace.go:171","msg":"trace[48335624] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"1.181128647s","start":"2026-01-28T14:55:07.713085Z","end":"2026-01-28T14:55:08.894213Z","steps":["trace[48335624] 'process raft request' (duration: 1.180744933s)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:08.894333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:07.713073Z","time spent":"1.18119023s","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-28T14:55:08.894553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.547902ms","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-01-28T14:55:08.894669Z","caller":"traceutil/trace.go:171","msg":"trace[325402073] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"892.77715ms","start":"2026-01-28T14:55:08.001877Z","end":"2026-01-28T14:55:08.894655Z","steps":["trace[325402073] 'agreement among raft nodes before linearized reading' (duration: 892.462079ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:08.894765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:08.001853Z","time spent":"892.902925ms","remote":"127.0.0.1:49996","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-01-28T14:55:08.894896Z","caller":"traceutil/trace.go:171","msg":"trace[1331820403] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"1.180336736s","start":"2026-01-28T14:55:07.714547Z","end":"2026-01-28T14:55:08.894883Z","steps":["trace[1331820403] 'process raft request' (duration: 1.179404322s)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:08.895815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:07.714457Z","time spent":"1.181315544s","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7030,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-28T14:55:09.29828Z","caller":"traceutil/trace.go:171","msg":"trace[1974786324] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"396.754944ms","start":"2026-01-28T14:55:08.901505Z","end":"2026-01-28T14:55:09.29826Z","steps":["trace[1974786324] 'process raft request' (duration: 396.660769ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:09.298407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:08.901481Z","time spent":"396.861388ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-28T14:55:09.29876Z","caller":"traceutil/trace.go:171","msg":"trace[1834304659] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"404.545853ms","start":"2026-01-28T14:55:08.894176Z","end":"2026-01-28T14:55:09.298722Z","steps":["trace[1834304659] 'read index received' (duration: 389.119246ms)","trace[1834304659] 'applied index is now lower than readState.Index' (duration: 15.423577ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:09.299156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.918816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-01-28T14:55:09.299424Z","caller":"traceutil/trace.go:171","msg":"trace[759530749] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:429; }","duration":"943.109643ms","start":"2026-01-28T14:55:08.356185Z","end":"2026-01-28T14:55:09.299295Z","steps":["trace[759530749] 'agreement among raft nodes before linearized reading' (duration: 942.892706ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:09.299569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.168614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-28T14:55:09.299607Z","caller":"traceutil/trace.go:171","msg":"trace[566209783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:429; }","duration":"607.267987ms","start":"2026-01-28T14:55:08.69233Z","end":"2026-01-28T14:55:09.299598Z","steps":["trace[566209783] 'agreement among raft nodes before linearized reading' (duration: 607.210905ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:09.299634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:08.692292Z","time spent":"607.333761ms","remote":"127.0.0.1:49740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-01-28T14:55:09.299574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:08.356165Z","time spent":"943.396904ms","remote":"127.0.0.1:50174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4056,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-01-28T14:55:09.299887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.3879ms","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-01-28T14:55:09.300168Z","caller":"traceutil/trace.go:171","msg":"trace[29709865] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:429; }","duration":"712.717792ms","start":"2026-01-28T14:55:08.58744Z","end":"2026-01-28T14:55:09.300157Z","steps":["trace[29709865] 'agreement among raft nodes before linearized reading' (duration: 712.37951ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:09.300267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:08.587414Z","time spent":"712.843596ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-01-28T14:55:18.850521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.070512ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-01-28T14:55:18.850592Z","caller":"traceutil/trace.go:171","msg":"trace[753946340] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"156.96956ms","start":"2026-01-28T14:55:18.693612Z","end":"2026-01-28T14:55:18.850581Z","steps":["trace[753946340] 'read index received' (duration: 41.531µs)","trace[753946340] 'applied index is now lower than readState.Index' (duration: 156.927119ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:18.850655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.036912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-28T14:55:18.850671Z","caller":"traceutil/trace.go:171","msg":"trace[515311495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"157.095025ms","start":"2026-01-28T14:55:18.69357Z","end":"2026-01-28T14:55:18.850665Z","steps":["trace[515311495] 'agreement among raft nodes before linearized reading' (duration: 157.037793ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:55:23.651882Z","caller":"traceutil/trace.go:171","msg":"trace[1582182391] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:544; }","duration":"108.343768ms","start":"2026-01-28T14:55:23.543523Z","end":"2026-01-28T14:55:23.651866Z","steps":["trace[1582182391] 'read index received' (duration: 108.189593ms)","trace[1582182391] 'applied index is now lower than readState.Index' (duration: 153.615µs)"],"step_count":2} {"level":"info","ts":"2026-01-28T14:55:23.651954Z","caller":"traceutil/trace.go:171","msg":"trace[1630090875] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"189.472468ms","start":"2026-01-28T14:55:23.462477Z","end":"2026-01-28T14:55:23.65195Z","steps":["trace[1630090875] 'process raft request' (duration: 189.290212ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:23.652101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.565675ms","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-01-28T14:55:23.652118Z","caller":"traceutil/trace.go:171","msg":"trace[183109610] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:526; }","duration":"108.620697ms","start":"2026-01-28T14:55:23.543492Z","end":"2026-01-28T14:55:23.652112Z","steps":["trace[183109610] 'agreement among raft nodes before linearized reading' (duration: 108.572545ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:55:27.899762Z","caller":"traceutil/trace.go:171","msg":"trace[863486251] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"281.229069ms","start":"2026-01-28T14:55:27.618511Z","end":"2026-01-28T14:55:27.89974Z","steps":["trace[863486251] 'process raft request' (duration: 224.238938ms)","trace[863486251] 'compare' (duration: 56.827476ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:28.138706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.034302ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-01-28T14:55:28.139186Z","caller":"traceutil/trace.go:171","msg":"trace[1145317317] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:570; }","duration":"471.66583ms","start":"2026-01-28T14:55:27.667504Z","end":"2026-01-28T14:55:28.13917Z","steps":["trace[1145317317] 'read index received' (duration: 175.256224ms)","trace[1145317317] 'applied index is now lower than readState.Index' (duration: 296.408896ms)"],"step_count":2} {"level":"info","ts":"2026-01-28T14:55:28.139206Z","caller":"traceutil/trace.go:171","msg":"trace[1547617669] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"518.011214ms","start":"2026-01-28T14:55:27.621137Z","end":"2026-01-28T14:55:28.139148Z","steps":["trace[1547617669] 'process raft request' (duration: 404.477209ms)","trace[1547617669] 'compare' (duration: 112.930197ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:28.139361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:27.62112Z","time spent":"518.17524ms","remote":"127.0.0.1:49834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":785,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-01-28T14:55:28.13963Z","caller":"traceutil/trace.go:171","msg":"trace[583769412] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"518.374455ms","start":"2026-01-28T14:55:27.62119Z","end":"2026-01-28T14:55:28.139565Z","steps":["trace[583769412] 'process raft request' (duration: 517.844669ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:28.139782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:27.621186Z","time spent":"518.52152ms","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3024,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-28T14:55:28.140174Z","caller":"traceutil/trace.go:171","msg":"trace[1794973879] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"518.831759ms","start":"2026-01-28T14:55:27.621333Z","end":"2026-01-28T14:55:28.140164Z","steps":["trace[1794973879] 'process raft request' (duration: 517.755846ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:28.141452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:27.621328Z","time spent":"520.087867ms","remote":"127.0.0.1:50174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3638,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-28T14:55:28.142146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.639661ms","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-01-28T14:55:28.142208Z","caller":"traceutil/trace.go:171","msg":"trace[698983726] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"474.749575ms","start":"2026-01-28T14:55:27.667449Z","end":"2026-01-28T14:55:28.142198Z","steps":["trace[698983726] 'agreement among raft nodes before linearized reading' (duration: 474.606439ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:28.142276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:27.667416Z","time spent":"474.830338ms","remote":"127.0.0.1:49996","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-01-28T14:55:28.304425Z","caller":"traceutil/trace.go:171","msg":"trace[1956844089] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"156.743771ms","start":"2026-01-28T14:55:28.147664Z","end":"2026-01-28T14:55:28.304407Z","steps":["trace[1956844089] 'process raft request' (duration: 156.70399ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:55:28.304626Z","caller":"traceutil/trace.go:171","msg":"trace[811932044] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"399.544319ms","start":"2026-01-28T14:55:27.905059Z","end":"2026-01-28T14:55:28.304604Z","steps":["trace[811932044] 'process raft request' (duration: 347.769913ms)","trace[811932044] 'compare' (duration: 51.408854ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:28.304744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:27.905047Z","time spent":"399.627401ms","remote":"127.0.0.1:50190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3210,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-28T14:55:28.304964Z","caller":"traceutil/trace.go:171","msg":"trace[1350946952] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:574; }","duration":"165.707704ms","start":"2026-01-28T14:55:28.139246Z","end":"2026-01-28T14:55:28.304954Z","steps":["trace[1350946952] 'read index received' (duration: 113.591958ms)","trace[1350946952] 'applied index is now lower than readState.Index' (duration: 52.114196ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:28.30519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.775577ms","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-01-28T14:55:28.305323Z","caller":"traceutil/trace.go:171","msg":"trace[2081409427] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:557; }","duration":"625.909382ms","start":"2026-01-28T14:55:27.679371Z","end":"2026-01-28T14:55:28.30528Z","steps":["trace[2081409427] 'agreement among raft nodes before linearized reading' (duration: 625.680344ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:28.305434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:27.67935Z","time spent":"626.073797ms","remote":"127.0.0.1:49852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":12749,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-01-28T14:55:28.305528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.459261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-28T14:55:28.305579Z","caller":"traceutil/trace.go:171","msg":"trace[1966847479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:557; }","duration":"246.531964ms","start":"2026-01-28T14:55:28.059031Z","end":"2026-01-28T14:55:28.305563Z","steps":["trace[1966847479] 'agreement among raft nodes before linearized reading' (duration: 246.437991ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:28.305778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.300447ms","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-01-28T14:55:28.305857Z","caller":"traceutil/trace.go:171","msg":"trace[1526558439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:557; }","duration":"617.380979ms","start":"2026-01-28T14:55:27.688467Z","end":"2026-01-28T14:55:28.305848Z","steps":["trace[1526558439] 'agreement among raft nodes before linearized reading' (duration: 617.259556ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:28.305932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:27.688431Z","time spent":"617.492173ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-01-28T14:55:28.510546Z","caller":"traceutil/trace.go:171","msg":"trace[1592686690] linearizableReadLoop","detail":"{readStateIndex:578; appliedIndex:577; }","duration":"145.961043ms","start":"2026-01-28T14:55:28.36457Z","end":"2026-01-28T14:55:28.510531Z","steps":["trace[1592686690] 'read index received' (duration: 127.001135ms)","trace[1592686690] 'applied index is now lower than readState.Index' (duration: 18.959318ms)"],"step_count":2} {"level":"info","ts":"2026-01-28T14:55:28.510819Z","caller":"traceutil/trace.go:171","msg":"trace[2139030667] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"191.749066ms","start":"2026-01-28T14:55:28.319063Z","end":"2026-01-28T14:55:28.510812Z","steps":["trace[2139030667] 'process raft request' (duration: 172.553692ms)","trace[2139030667] 'compare' (duration: 18.859764ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:28.511084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.351865ms","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-01-28T14:55:28.511164Z","caller":"traceutil/trace.go:171","msg":"trace[162843224] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:559; }","duration":"147.464148ms","start":"2026-01-28T14:55:28.363691Z","end":"2026-01-28T14:55:28.511155Z","steps":["trace[162843224] 'agreement among raft nodes before linearized reading' (duration: 147.321163ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:28.511763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.182859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/local-path-storage/local-path-provisioner-6f56467975\" ","response":"range_response_count:1 size:3225"} {"level":"info","ts":"2026-01-28T14:55:28.511972Z","caller":"traceutil/trace.go:171","msg":"trace[334917572] range","detail":"{range_begin:/registry/replicasets/local-path-storage/local-path-provisioner-6f56467975; range_end:; response_count:1; response_revision:559; }","duration":"145.408296ms","start":"2026-01-28T14:55:28.366542Z","end":"2026-01-28T14:55:28.51195Z","steps":["trace[334917572] 'agreement among raft nodes before linearized reading' (duration: 145.045995ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:55:31.287267Z","caller":"traceutil/trace.go:171","msg":"trace[1890653096] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"128.921646ms","start":"2026-01-28T14:55:31.158307Z","end":"2026-01-28T14:55:31.287228Z","steps":["trace[1890653096] 'process raft request' (duration: 125.581337ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:55:32.081989Z","caller":"traceutil/trace.go:171","msg":"trace[2077539635] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"160.770979ms","start":"2026-01-28T14:55:31.921156Z","end":"2026-01-28T14:55:32.081927Z","steps":["trace[2077539635] 'process raft request' (duration: 160.490431ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:32.873815Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1280038264821418442,"retry-timeout":"500ms"} {"level":"info","ts":"2026-01-28T14:55:33.215723Z","caller":"traceutil/trace.go:171","msg":"trace[1430601320] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"891.421129ms","start":"2026-01-28T14:55:32.324286Z","end":"2026-01-28T14:55:33.215707Z","steps":["trace[1430601320] 'process raft request' (duration: 891.327906ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:33.215818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:32.32427Z","time spent":"891.499082ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-28T14:55:34.498057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.913595ms","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-01-28T14:55:34.498145Z","caller":"traceutil/trace.go:171","msg":"trace[1309853644] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:570; }","duration":"582.012727ms","start":"2026-01-28T14:55:33.916115Z","end":"2026-01-28T14:55:34.498127Z","steps":["trace[1309853644] 'range keys from in-memory index tree' (duration: 581.902054ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:34.498453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.43378ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-28T14:55:34.498482Z","caller":"traceutil/trace.go:171","msg":"trace[756114287] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:589; }","duration":"2.124763896s","start":"2026-01-28T14:55:32.373713Z","end":"2026-01-28T14:55:34.498476Z","steps":["trace[756114287] 'read index received' (duration: 841.869735ms)","trace[756114287] 'applied index is now lower than readState.Index' (duration: 1.282893611s)"],"step_count":2} {"level":"info","ts":"2026-01-28T14:55:34.498527Z","caller":"traceutil/trace.go:171","msg":"trace[1415628152] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"2.061396868s","start":"2026-01-28T14:55:32.437124Z","end":"2026-01-28T14:55:34.498521Z","steps":["trace[1415628152] 'process raft request' (duration: 1.765856155s)","trace[1415628152] 'compare' (duration: 294.993627ms)"],"step_count":2} {"level":"warn","ts":"2026-01-28T14:55:34.498553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:32.437101Z","time spent":"2.061437489s","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-28T14:55:34.498657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.124953521s","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-01-28T14:55:34.498668Z","caller":"traceutil/trace.go:171","msg":"trace[585222850] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:571; }","duration":"2.124993192s","start":"2026-01-28T14:55:32.373671Z","end":"2026-01-28T14:55:34.498664Z","steps":["trace[585222850] 'agreement among raft nodes before linearized reading' (duration: 2.124933261s)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:34.498683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:32.373653Z","time spent":"2.125025824s","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-01-28T14:55:34.498787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.373084301s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.132\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-01-28T14:55:34.4988Z","caller":"traceutil/trace.go:171","msg":"trace[148572483] range","detail":"{range_begin:/registry/masterleases/199.19.213.132; range_end:; response_count:1; response_revision:571; }","duration":"1.373097652s","start":"2026-01-28T14:55:33.125698Z","end":"2026-01-28T14:55:34.498796Z","steps":["trace[148572483] 'agreement among raft nodes before linearized reading' (duration: 1.373068791s)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:34.498825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:33.125632Z","time spent":"1.373178224s","remote":"127.0.0.1:49790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.132\" "} {"level":"warn","ts":"2026-01-28T14:55:34.498861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.754609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-28T14:55:34.498927Z","caller":"traceutil/trace.go:171","msg":"trace[140029593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"808.858142ms","start":"2026-01-28T14:55:33.690051Z","end":"2026-01-28T14:55:34.498909Z","steps":["trace[140029593] 'agreement among raft nodes before linearized reading' (duration: 808.760659ms)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:34.498944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207327554s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-01-28T14:55:34.498967Z","caller":"traceutil/trace.go:171","msg":"trace[964255518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:571; }","duration":"1.207384285s","start":"2026-01-28T14:55:33.291576Z","end":"2026-01-28T14:55:34.498961Z","steps":["trace[964255518] 'agreement among raft nodes before linearized reading' (duration: 1.207313253s)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:34.498965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:33.690033Z","time spent":"808.923453ms","remote":"127.0.0.1:49740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-01-28T14:55:34.498982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:33.291549Z","time spent":"1.207430038s","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-01-28T14:55:34.499073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.356594273s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-01-28T14:55:34.499092Z","caller":"traceutil/trace.go:171","msg":"trace[904590371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:571; }","duration":"1.356633094s","start":"2026-01-28T14:55:33.142452Z","end":"2026-01-28T14:55:34.499085Z","steps":["trace[904590371] 'agreement among raft nodes before linearized reading' (duration: 1.356593123s)"],"step_count":1} {"level":"warn","ts":"2026-01-28T14:55:34.499119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-28T14:55:33.142439Z","time spent":"1.356670855s","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-01-28T14:55:34.742053Z","caller":"traceutil/trace.go:171","msg":"trace[1076131798] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"234.091533ms","start":"2026-01-28T14:55:34.507943Z","end":"2026-01-28T14:55:34.742035Z","steps":["trace[1076131798] 'process raft request' (duration: 234.060413ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:55:34.742397Z","caller":"traceutil/trace.go:171","msg":"trace[670622702] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"235.428501ms","start":"2026-01-28T14:55:34.506959Z","end":"2026-01-28T14:55:34.742387Z","steps":["trace[670622702] 'process raft request' (duration: 234.904406ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:55:34.742504Z","caller":"traceutil/trace.go:171","msg":"trace[764145056] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"235.495293ms","start":"2026-01-28T14:55:34.507003Z","end":"2026-01-28T14:55:34.742498Z","steps":["trace[764145056] 'process raft request' (duration: 234.976729ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:56:16.436726Z","caller":"traceutil/trace.go:171","msg":"trace[2140099307] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"125.345354ms","start":"2026-01-28T14:56:16.311364Z","end":"2026-01-28T14:56:16.43671Z","steps":["trace[2140099307] 'process raft request' (duration: 125.238881ms)"],"step_count":1} {"level":"info","ts":"2026-01-28T14:56:17.754948Z","caller":"traceutil/trace.go:171","msg":"trace[874215328] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"165.597199ms","start":"2026-01-28T14:56:17.589315Z","end":"2026-01-28T14:56:17.754912Z","steps":["trace[874215328] 'process raft request' (duration: 163.771572ms)"],"step_count":1}