{"level":"warn","ts":"2026-04-07T09:40:29.765313Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-07T09:40:29.765459Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-04-07T09:40:29.765551Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-07T09:40:29.765568Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]}
{"level":"info","ts":"2026-04-07T09:40:29.765593Z","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-04-07T09:40:29.766493Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]}
{"level":"info","ts":"2026-04-07T09:40:29.766589Z","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.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-04-07T09:40:29.772648Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.743665ms"}
{"level":"info","ts":"2026-04-07T09:40:29.780216Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"}
{"level":"info","ts":"2026-04-07T09:40:29.78029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"}
{"level":"info","ts":"2026-04-07T09:40:29.780313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"}
{"level":"info","ts":"2026-04-07T09:40:29.780322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-07T09:40:29.780334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"}
{"level":"info","ts":"2026-04-07T09:40:29.780364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"}
{"level":"warn","ts":"2026-04-07T09:40:29.787905Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-07T09:40:29.789066Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-07T09:40:29.790245Z","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-04-07T09:40:29.792406Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-07T09:40:29.792551Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-07T09:40:29.793705Z","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-04-07T09:40:29.793854Z","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-04-07T09:40:29.793868Z","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-04-07T09:40:29.794012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"}
{"level":"info","ts":"2026-04-07T09:40:29.794221Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]}
{"level":"info","ts":"2026-04-07T09:40:29.797928Z","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-04-07T09:40:29.798042Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"}
{"level":"info","ts":"2026-04-07T09:40:29.79808Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"}
{"level":"info","ts":"2026-04-07T09:40:29.801202Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-07T09:40:29.801266Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-07T09:40:30.08091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"}
{"level":"info","ts":"2026-04-07T09:40:30.080953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-07T09:40:30.080976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"}
{"level":"info","ts":"2026-04-07T09:40:30.080988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"}
{"level":"info","ts":"2026-04-07T09:40:30.080994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"}
{"level":"info","ts":"2026-04-07T09:40:30.081002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"}
{"level":"info","ts":"2026-04-07T09:40:30.08101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"}
{"level":"info","ts":"2026-04-07T09:40:30.081772Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-07T09:40:30.081796Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-07T09:40:30.082004Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-07T09:40:30.082449Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T09:40:30.083748Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T09:40:30.084009Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T09:40:30.08417Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-07T09:40:30.084377Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-07T09:40:30.0844Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-07T09:40:30.088756Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"}
{"level":"info","ts":"2026-04-07T09:40:30.091494Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-07T09:40:34.847978Z","caller":"traceutil/trace.go:171","msg":"trace[1012669821] linearizableReadLoop","detail":"{readStateIndex:232; appliedIndex:231; }","duration":"301.194856ms","start":"2026-04-07T09:40:34.546756Z","end":"2026-04-07T09:40:34.847951Z","steps":["trace[1012669821] 'read index received'  (duration: 282.218656ms)","trace[1012669821] 'applied index is now lower than readState.Index'  (duration: 18.9749ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:40:34.848044Z","caller":"traceutil/trace.go:171","msg":"trace[396374342] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"301.448943ms","start":"2026-04-07T09:40:34.546562Z","end":"2026-04-07T09:40:34.848011Z","steps":["trace[396374342] 'process raft request'  (duration: 282.349889ms)","trace[396374342] 'compare'  (duration: 18.888858ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T09:40:34.848226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.447883ms","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-04-07T09:40:34.848319Z","caller":"traceutil/trace.go:171","msg":"trace[206062616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:227; }","duration":"301.597787ms","start":"2026-04-07T09:40:34.546704Z","end":"2026-04-07T09:40:34.848302Z","steps":["trace[206062616] 'agreement among raft nodes before linearized reading'  (duration: 301.412852ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:34.848353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.546684Z","time spent":"301.662429ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-07T09:40:34.848623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.546547Z","time spent":"301.598947ms","remote":"127.0.0.1:51386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":597,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/kube-system/coredns\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/kube-system/coredns\" value_size:549 >> failure:<>"}
{"level":"warn","ts":"2026-04-07T09:40:35.050169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.547674Z","time spent":"502.489734ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-04-07T09:40:35.050208Z","caller":"traceutil/trace.go:171","msg":"trace[810656094] transaction","detail":"{read_only:false; number_of_response:0; response_revision:227; }","duration":"391.444106ms","start":"2026-04-07T09:40:34.658742Z","end":"2026-04-07T09:40:35.050186Z","steps":["trace[810656094] 'process raft request'  (duration: 391.331293ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:35.050285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.658722Z","time spent":"391.522237ms","remote":"127.0.0.1:51454","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3309 >> failure:<>"}
{"level":"info","ts":"2026-04-07T09:40:35.050325Z","caller":"traceutil/trace.go:171","msg":"trace[176738576] linearizableReadLoop","detail":"{readStateIndex:239; appliedIndex:232; }","duration":"202.234273ms","start":"2026-04-07T09:40:34.848068Z","end":"2026-04-07T09:40:35.050302Z","steps":["trace[176738576] 'read index received'  (duration: 197.796513ms)","trace[176738576] 'applied index is now lower than readState.Index'  (duration: 4.43657ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:40:35.05045Z","caller":"traceutil/trace.go:171","msg":"trace[108143612] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"377.377487ms","start":"2026-04-07T09:40:34.67304Z","end":"2026-04-07T09:40:35.050418Z","steps":["trace[108143612] 'process raft request'  (duration: 377.189732ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:40:35.050484Z","caller":"traceutil/trace.go:171","msg":"trace[655341285] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"378.906548ms","start":"2026-04-07T09:40:34.67157Z","end":"2026-04-07T09:40:35.050476Z","steps":["trace[655341285] 'process raft request'  (duration: 378.622551ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:35.050523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.671547Z","time spent":"378.959379ms","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"warn","ts":"2026-04-07T09:40:35.050516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.177513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T09:40:35.050493Z","caller":"traceutil/trace.go:171","msg":"trace[577081214] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"378.98925ms","start":"2026-04-07T09:40:34.671454Z","end":"2026-04-07T09:40:35.050443Z","steps":["trace[577081214] 'process raft request'  (duration: 378.673422ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:40:35.050553Z","caller":"traceutil/trace.go:171","msg":"trace[1005407792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:230; }","duration":"503.268635ms","start":"2026-04-07T09:40:34.547275Z","end":"2026-04-07T09:40:35.050543Z","steps":["trace[1005407792] 'agreement among raft nodes before linearized reading'  (duration: 503.120741ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:35.050564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.673034Z","time spent":"377.472839ms","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"warn","ts":"2026-04-07T09:40:35.050584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.547257Z","time spent":"503.320186ms","remote":"127.0.0.1:51312","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-04-07T09:40:35.050615Z","caller":"traceutil/trace.go:171","msg":"trace[452110147] transaction","detail":"{read_only:false; number_of_response:0; response_revision:230; }","duration":"374.921611ms","start":"2026-04-07T09:40:34.675687Z","end":"2026-04-07T09:40:35.050608Z","steps":["trace[452110147] 'process raft request'  (duration: 374.589512ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:35.050645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.67568Z","time spent":"374.952872ms","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5819 >> failure:<>"}
{"level":"warn","ts":"2026-04-07T09:40:35.050653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.671437Z","time spent":"379.143294ms","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3911 >> failure:<>"}
{"level":"info","ts":"2026-04-07T09:40:35.050689Z","caller":"traceutil/trace.go:171","msg":"trace[488533798] transaction","detail":"{read_only:false; number_of_response:0; response_revision:230; }","duration":"377.570822ms","start":"2026-04-07T09:40:34.673114Z","end":"2026-04-07T09:40:35.050685Z","steps":["trace[488533798] 'process raft request'  (duration: 377.14309ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:35.050717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.673093Z","time spent":"377.611873ms","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"warn","ts":"2026-04-07T09:40:35.050808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.630268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"warn","ts":"2026-04-07T09:40:35.050809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.621948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T09:40:35.050828Z","caller":"traceutil/trace.go:171","msg":"trace[804082669] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:230; }","duration":"489.665649ms","start":"2026-04-07T09:40:34.561156Z","end":"2026-04-07T09:40:35.050822Z","steps":["trace[804082669] 'agreement among raft nodes before linearized reading'  (duration: 489.597937ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:35.050849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.561146Z","time spent":"489.69728ms","remote":"127.0.0.1:51654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-04-07T09:40:35.050852Z","caller":"traceutil/trace.go:171","msg":"trace[1368887786] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:230; }","duration":"489.69533ms","start":"2026-04-07T09:40:34.561142Z","end":"2026-04-07T09:40:35.050838Z","steps":["trace[1368887786] 'agreement among raft nodes before linearized reading'  (duration: 489.627978ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:35.050888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:34.561127Z","time spent":"489.754121ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "}
{"level":"info","ts":"2026-04-07T09:40:35.054479Z","caller":"traceutil/trace.go:171","msg":"trace[1351812997] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"201.889414ms","start":"2026-04-07T09:40:34.85257Z","end":"2026-04-07T09:40:35.05446Z","steps":["trace[1351812997] 'process raft request'  (duration: 201.721719ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:40:35.054485Z","caller":"traceutil/trace.go:171","msg":"trace[1688546847] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"201.541534ms","start":"2026-04-07T09:40:34.85291Z","end":"2026-04-07T09:40:35.054452Z","steps":["trace[1688546847] 'process raft request'  (duration: 201.484023ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:56.043595Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:40:56.544054Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:40:57.045121Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:40:57.545679Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:40:58.045901Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:40:58.546267Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:40:58.776768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000343461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-07T09:40:58.776866Z","caller":"traceutil/trace.go:171","msg":"trace[1202692899] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000506315s","start":"2026-04-07T09:40:56.776332Z","end":"2026-04-07T09:40:58.776838Z","steps":["trace[1202692899] 'agreement among raft nodes before linearized reading'  (duration: 2.000383142s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:40:58.776962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:56.776303Z","time spent":"2.000646509s","remote":"127.0.0.1:51312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/07 09:40:58 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-07T09:40:59.047439Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:40:59.548465Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:41:00.049095Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:41:00.135641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:55.135715Z","time spent":"4.999915942s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
2026/04/07 09:41:00 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-07T09:41:00.549962Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:41:00.777152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999996091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-07T09:41:00.7773Z","caller":"traceutil/trace.go:171","msg":"trace[299494471] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000217037s","start":"2026-04-07T09:40:58.777047Z","end":"2026-04-07T09:41:00.777264Z","steps":["trace[299494471] 'agreement among raft nodes before linearized reading'  (duration: 2.000024922s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:00.777371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:58.777024Z","time spent":"2.00033281s","remote":"127.0.0.1:51296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/07 09:41:00 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-07T09:41:00.935433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999526791s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-07T09:41:00.935526Z","caller":"traceutil/trace.go:171","msg":"trace[1374248416] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999672845s","start":"2026-04-07T09:40:55.935831Z","end":"2026-04-07T09:41:00.935504Z","steps":["trace[1374248416] 'agreement among raft nodes before linearized reading'  (duration: 4.999567992s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:00.935578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:55.93581Z","time spent":"4.999757438s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
2026/04/07 09:41:00 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-07T09:41:01.050642Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:41:01.551458Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:41:02.052256Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775991,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:41:02.542995Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"}
{"level":"warn","ts":"2026-04-07T09:41:02.543134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000397188s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"","error":"etcdserver: request timed out"}
{"level":"info","ts":"2026-04-07T09:41:02.543168Z","caller":"traceutil/trace.go:171","msg":"trace[845844564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; }","duration":"7.0004843s","start":"2026-04-07T09:40:55.542666Z","end":"2026-04-07T09:41:02.543151Z","steps":["trace[845844564] 'agreement among raft nodes before linearized reading'  (duration: 7.000435618s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:02.543227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:55.542633Z","time spent":"7.000586123s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-07T09:41:02.722173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:55.721234Z","time spent":"7.000932371s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""}
{"level":"warn","ts":"2026-04-07T09:41:02.785098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000513216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-07T09:41:02.785183Z","caller":"traceutil/trace.go:171","msg":"trace[636489135] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000650549s","start":"2026-04-07T09:41:00.784511Z","end":"2026-04-07T09:41:02.785162Z","steps":["trace[636489135] 'agreement among raft nodes before linearized reading'  (duration: 2.000546546s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:02.785229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:00.784472Z","time spent":"2.000747962s","remote":"127.0.0.1:51312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-07T09:41:03.043613Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722775997,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-07T09:41:03.085096Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"7.949295859s","expected-duration":"1s"}
{"level":"warn","ts":"2026-04-07T09:41:04.785764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999870528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-07T09:41:04.785867Z","caller":"traceutil/trace.go:171","msg":"trace[1423768625] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999996232s","start":"2026-04-07T09:41:02.785852Z","end":"2026-04-07T09:41:04.785848Z","steps":["trace[1423768625] 'agreement among raft nodes before linearized reading'  (duration: 1.999866418s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:04.785925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:02.785808Z","time spent":"2.000097634s","remote":"127.0.0.1:51296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-07T09:41:05.056499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05303924s","expected-duration":"100ms","prefix":"","request":"header:<ID:3219120900722775994 > lease_revoke:<id:2cac9d67509dd737>","response":"size:28"}
{"level":"info","ts":"2026-04-07T09:41:05.057488Z","caller":"traceutil/trace.go:171","msg":"trace[1379525194] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:439; }","duration":"2.514362569s","start":"2026-04-07T09:41:02.543075Z","end":"2026-04-07T09:41:05.057438Z","steps":["trace[1379525194] 'read index received'  (duration: 542.210587ms)","trace[1379525194] 'applied index is now lower than readState.Index'  (duration: 1.972151122s)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:41:05.057618Z","caller":"traceutil/trace.go:171","msg":"trace[463357626] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"4.277011616s","start":"2026-04-07T09:41:00.780597Z","end":"2026-04-07T09:41:05.057609Z","steps":["trace[463357626] 'process raft request'  (duration: 4.276622886s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:05.057716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:00.780564Z","time spent":"4.277090948s","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18a409bd13e23372\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18a409bd13e23372\" value_size:672 lease:3219120900722775572 >> failure:<>"}
{"level":"warn","ts":"2026-04-07T09:41:05.057993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.514566441s","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-04-07T09:41:05.05798Z","caller":"traceutil/trace.go:171","msg":"trace[531397266] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"2.79204606s","start":"2026-04-07T09:41:02.265893Z","end":"2026-04-07T09:41:05.057939Z","steps":["trace[531397266] 'process raft request'  (duration: 2.791460184s)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:41:05.058039Z","caller":"traceutil/trace.go:171","msg":"trace[839744935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:428; }","duration":"9.514655963s","start":"2026-04-07T09:40:55.543372Z","end":"2026-04-07T09:41:05.058028Z","steps":["trace[839744935] 'agreement among raft nodes before linearized reading'  (duration: 9.514554641s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:05.058071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:55.54335Z","time spent":"9.514713825s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-07T09:41:05.058063Z","caller":"traceutil/trace.go:171","msg":"trace[733782682] transaction","detail":"{read_only:false; number_of_response:1; response_revision:428; }","duration":"2.330128315s","start":"2026-04-07T09:41:02.727901Z","end":"2026-04-07T09:41:05.058029Z","steps":["trace[733782682] 'process raft request'  (duration: 2.329503999s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:05.058091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.120530829s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-04-07T09:41:05.058144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.058244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T09:41:05.05817Z","caller":"traceutil/trace.go:171","msg":"trace[1443901727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"2.120661613s","start":"2026-04-07T09:41:02.937487Z","end":"2026-04-07T09:41:05.058149Z","steps":["trace[1443901727] 'agreement among raft nodes before linearized reading'  (duration: 2.120497318s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:05.05819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.676448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-07T09:41:05.058217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:02.937466Z","time spent":"2.120742415s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-07T09:41:05.058215Z","caller":"traceutil/trace.go:171","msg":"trace[1840459797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:428; }","duration":"264.156277ms","start":"2026-04-07T09:41:04.794038Z","end":"2026-04-07T09:41:05.058194Z","steps":["trace[1840459797] 'agreement among raft nodes before linearized reading'  (duration: 264.057324ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:05.058255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.170891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"}
{"level":"info","ts":"2026-04-07T09:41:05.058284Z","caller":"traceutil/trace.go:171","msg":"trace[566652936] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:428; }","duration":"864.236593ms","start":"2026-04-07T09:41:04.194037Z","end":"2026-04-07T09:41:05.058273Z","steps":["trace[566652936] 'agreement among raft nodes before linearized reading'  (duration: 864.152121ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:41:05.058273Z","caller":"traceutil/trace.go:171","msg":"trace[1526162628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:428; }","duration":"510.787581ms","start":"2026-04-07T09:41:04.547455Z","end":"2026-04-07T09:41:05.058243Z","steps":["trace[1526162628] 'agreement among raft nodes before linearized reading'  (duration: 510.607526ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:05.058304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:04.194017Z","time spent":"864.281625ms","remote":"127.0.0.1:51384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12696,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "}
{"level":"warn","ts":"2026-04-07T09:41:05.058323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:04.547436Z","time spent":"510.873893ms","remote":"127.0.0.1:51542","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-04-07T09:41:05.058326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.07119265s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"}
{"level":"warn","ts":"2026-04-07T09:41:05.058374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:02.727874Z","time spent":"2.330251259s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":45,"response count":0,"response size":570,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:371 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-04-07T09:41:05.058388Z","caller":"traceutil/trace.go:171","msg":"trace[1919179880] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:428; }","duration":"2.071299593s","start":"2026-04-07T09:41:02.98707Z","end":"2026-04-07T09:41:05.058369Z","steps":["trace[1919179880] 'agreement among raft nodes before linearized reading'  (duration: 2.071156179s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:05.05843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:02.987045Z","time spent":"2.071373465s","remote":"127.0.0.1:51336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.35\" "}
{"level":"warn","ts":"2026-04-07T09:41:05.058335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:02.265824Z","time spent":"2.792235435s","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:418 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-04-07T09:41:05.058569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.920907742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-07T09:41:05.058623Z","caller":"traceutil/trace.go:171","msg":"trace[1062888498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:428; }","duration":"2.920959013s","start":"2026-04-07T09:41:02.13765Z","end":"2026-04-07T09:41:05.058609Z","steps":["trace[1062888498] 'agreement among raft nodes before linearized reading'  (duration: 2.920241954s)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:05.058653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:02.137602Z","time spent":"2.921043495s","remote":"127.0.0.1:51542","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-04-07T09:41:08.055469Z","caller":"traceutil/trace.go:171","msg":"trace[1416112689] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"149.784925ms","start":"2026-04-07T09:41:07.905659Z","end":"2026-04-07T09:41:08.055444Z","steps":["trace[1416112689] 'process raft request'  (duration: 140.66603ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:41:08.055789Z","caller":"traceutil/trace.go:171","msg":"trace[411790621] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"112.800999ms","start":"2026-04-07T09:41:07.942968Z","end":"2026-04-07T09:41:08.055769Z","steps":["trace[411790621] 'process raft request'  (duration: 112.749368ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:41:08.055843Z","caller":"traceutil/trace.go:171","msg":"trace[2034622221] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"140.542837ms","start":"2026-04-07T09:41:07.915288Z","end":"2026-04-07T09:41:08.055831Z","steps":["trace[2034622221] 'process raft request'  (duration: 140.29612ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:11.667547Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219120900722776264,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-07T09:41:11.780728Z","caller":"traceutil/trace.go:171","msg":"trace[308633088] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:575; }","duration":"614.009122ms","start":"2026-04-07T09:41:11.166698Z","end":"2026-04-07T09:41:11.780707Z","steps":["trace[308633088] 'read index received'  (duration: 613.874299ms)","trace[308633088] 'applied index is now lower than readState.Index'  (duration: 134.043µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:41:11.780823Z","caller":"traceutil/trace.go:171","msg":"trace[824816472] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"618.296508ms","start":"2026-04-07T09:41:11.16252Z","end":"2026-04-07T09:41:11.780816Z","steps":["trace[824816472] 'process raft request'  (duration: 618.065122ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:11.780901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:11.162494Z","time spent":"618.346679ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:544 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-07T09:41:11.781009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.610151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-04-07T09:41:11.781267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.427066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-04-07T09:41:11.781278Z","caller":"traceutil/trace.go:171","msg":"trace[1640230098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:553; }","duration":"610.887148ms","start":"2026-04-07T09:41:11.17037Z","end":"2026-04-07T09:41:11.781257Z","steps":["trace[1640230098] 'agreement among raft nodes before linearized reading'  (duration: 610.532488ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:41:11.781295Z","caller":"traceutil/trace.go:171","msg":"trace[1092323204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:553; }","duration":"610.482637ms","start":"2026-04-07T09:41:11.170806Z","end":"2026-04-07T09:41:11.781288Z","steps":["trace[1092323204] 'agreement among raft nodes before linearized reading'  (duration: 610.415995ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:11.781318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:11.170362Z","time spent":"610.947929ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-07T09:41:11.781197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.497375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-04-07T09:41:11.781354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:11.170792Z","time spent":"610.554019ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-07T09:41:11.781468Z","caller":"traceutil/trace.go:171","msg":"trace[622356198] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"614.777913ms","start":"2026-04-07T09:41:11.166645Z","end":"2026-04-07T09:41:11.781423Z","steps":["trace[622356198] 'agreement among raft nodes before linearized reading'  (duration: 614.484086ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:11.781593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:11.166622Z","time spent":"614.933927ms","remote":"127.0.0.1:51542","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-04-07T09:41:15.419403Z","caller":"traceutil/trace.go:171","msg":"trace[813245865] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"122.085539ms","start":"2026-04-07T09:41:15.297285Z","end":"2026-04-07T09:41:15.419371Z","steps":["trace[813245865] 'process raft request'  (duration: 120.861146ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:15.630641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.893773ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3219120900722776327 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-07T09:41:15.631271Z","caller":"traceutil/trace.go:171","msg":"trace[1046569282] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"157.907034ms","start":"2026-04-07T09:41:15.473321Z","end":"2026-04-07T09:41:15.631228Z","steps":["trace[1046569282] 'process raft request'  (duration: 15.348054ms)","trace[1046569282] 'compare'  (duration: 141.635445ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:41:15.991795Z","caller":"traceutil/trace.go:171","msg":"trace[2036460964] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"212.216857ms","start":"2026-04-07T09:41:15.77955Z","end":"2026-04-07T09:41:15.991767Z","steps":["trace[2036460964] 'read index received'  (duration: 204.626532ms)","trace[2036460964] 'applied index is now lower than readState.Index'  (duration: 7.589225ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:41:15.991973Z","caller":"traceutil/trace.go:171","msg":"trace[553918844] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"289.084318ms","start":"2026-04-07T09:41:15.702876Z","end":"2026-04-07T09:41:15.99196Z","steps":["trace[553918844] 'process raft request'  (duration: 281.36736ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:15.992344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.304349ms","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-04-07T09:41:15.992815Z","caller":"traceutil/trace.go:171","msg":"trace[1968569242] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:583; }","duration":"160.802303ms","start":"2026-04-07T09:41:15.831992Z","end":"2026-04-07T09:41:15.992794Z","steps":["trace[1968569242] 'agreement among raft nodes before linearized reading'  (duration: 160.216007ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:15.99292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.549188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-04-07T09:41:15.992716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.148383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T09:41:15.992996Z","caller":"traceutil/trace.go:171","msg":"trace[775334633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:583; }","duration":"159.653921ms","start":"2026-04-07T09:41:15.833323Z","end":"2026-04-07T09:41:15.992977Z","steps":["trace[775334633] 'agreement among raft nodes before linearized reading'  (duration: 159.431005ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:41:15.993029Z","caller":"traceutil/trace.go:171","msg":"trace[1923234682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"213.470521ms","start":"2026-04-07T09:41:15.779519Z","end":"2026-04-07T09:41:15.992989Z","steps":["trace[1923234682] 'agreement among raft nodes before linearized reading'  (duration: 213.132192ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:15.99272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.640918ms","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-04-07T09:41:15.993132Z","caller":"traceutil/trace.go:171","msg":"trace[1096565692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:583; }","duration":"148.089339ms","start":"2026-04-07T09:41:15.845033Z","end":"2026-04-07T09:41:15.993122Z","steps":["trace[1096565692] 'agreement among raft nodes before linearized reading'  (duration: 147.560915ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:15.992738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.751091ms","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-04-07T09:41:15.99322Z","caller":"traceutil/trace.go:171","msg":"trace[1663750775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:583; }","duration":"148.245284ms","start":"2026-04-07T09:41:15.844966Z","end":"2026-04-07T09:41:15.993211Z","steps":["trace[1663750775] 'agreement among raft nodes before linearized reading'  (duration: 147.688919ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:16.407426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.840128ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3219120900722776334 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:569 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-07T09:41:16.407635Z","caller":"traceutil/trace.go:171","msg":"trace[285430443] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"407.752515ms","start":"2026-04-07T09:41:15.999857Z","end":"2026-04-07T09:41:16.40761Z","steps":["trace[285430443] 'process raft request'  (duration: 254.586029ms)","trace[285430443] 'compare'  (duration: 152.702593ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T09:41:16.407741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:15.999841Z","time spent":"407.852308ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:569 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-04-07T09:41:16.407855Z","caller":"traceutil/trace.go:171","msg":"trace[1536804249] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"407.91697ms","start":"2026-04-07T09:41:15.999916Z","end":"2026-04-07T09:41:16.407833Z","steps":["trace[1536804249] 'process raft request'  (duration: 407.621592ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:16.408019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:15.999893Z","time spent":"408.026982ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:567 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-07T09:41:16.408376Z","caller":"traceutil/trace.go:171","msg":"trace[45533338] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"407.973721ms","start":"2026-04-07T09:41:16.000381Z","end":"2026-04-07T09:41:16.408355Z","steps":["trace[45533338] 'process raft request'  (duration: 407.381575ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:16.408516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:16.000371Z","time spent":"408.052883ms","remote":"127.0.0.1:51542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:568 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-04-07T09:41:16.408979Z","caller":"traceutil/trace.go:171","msg":"trace[233574348] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"375.214879ms","start":"2026-04-07T09:41:16.033726Z","end":"2026-04-07T09:41:16.408941Z","steps":["trace[233574348] 'process raft request'  (duration: 374.587532ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:16.409114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:16.033701Z","time spent":"375.339181ms","remote":"127.0.0.1:51384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:580 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036217 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-04-07T09:41:16.607127Z","caller":"traceutil/trace.go:171","msg":"trace[480300965] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"141.929933ms","start":"2026-04-07T09:41:16.465173Z","end":"2026-04-07T09:41:16.607103Z","steps":["trace[480300965] 'process raft request'  (duration: 136.040605ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:41:31.104948Z","caller":"traceutil/trace.go:171","msg":"trace[139583827] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"323.050003ms","start":"2026-04-07T09:41:30.781874Z","end":"2026-04-07T09:41:31.104924Z","steps":["trace[139583827] 'process raft request'  (duration: 322.889349ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:41:31.105268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:30.781845Z","time spent":"323.29143ms","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4ttvh\" mod_revision:686 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4ttvh\" value_size:3940 >> failure:<request_range:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4ttvh\" > >"}
{"level":"info","ts":"2026-04-07T09:42:06.089704Z","caller":"traceutil/trace.go:171","msg":"trace[323302728] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"144.326917ms","start":"2026-04-07T09:42:05.945344Z","end":"2026-04-07T09:42:06.089671Z","steps":["trace[323302728] 'process raft request'  (duration: 144.128671ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:42:26.878401Z","caller":"traceutil/trace.go:171","msg":"trace[461216767] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1071; }","duration":"132.866967ms","start":"2026-04-07T09:42:26.74551Z","end":"2026-04-07T09:42:26.878377Z","steps":["trace[461216767] 'read index received'  (duration: 132.666812ms)","trace[461216767] 'applied index is now lower than readState.Index'  (duration: 198.905µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:42:26.878499Z","caller":"traceutil/trace.go:171","msg":"trace[1350247336] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"135.338024ms","start":"2026-04-07T09:42:26.74314Z","end":"2026-04-07T09:42:26.878478Z","steps":["trace[1350247336] 'process raft request'  (duration: 135.073927ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:42:26.87865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.430406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-04-07T09:42:26.878632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.124705ms","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-04-07T09:42:26.878697Z","caller":"traceutil/trace.go:171","msg":"trace[540741312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1031; }","duration":"132.560589ms","start":"2026-04-07T09:42:26.746126Z","end":"2026-04-07T09:42:26.878686Z","steps":["trace[540741312] 'agreement among raft nodes before linearized reading'  (duration: 132.384204ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:42:26.878708Z","caller":"traceutil/trace.go:171","msg":"trace[62559085] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1031; }","duration":"133.251598ms","start":"2026-04-07T09:42:26.745443Z","end":"2026-04-07T09:42:26.878695Z","steps":["trace[62559085] 'agreement among raft nodes before linearized reading'  (duration: 133.045542ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:42:27.121425Z","caller":"traceutil/trace.go:171","msg":"trace[1029537769] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"238.914813ms","start":"2026-04-07T09:42:26.882494Z","end":"2026-04-07T09:42:27.121409Z","steps":["trace[1029537769] 'process raft request'  (duration: 238.711268ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:42:27.134197Z","caller":"traceutil/trace.go:171","msg":"trace[1044166277] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"251.611575ms","start":"2026-04-07T09:42:26.882569Z","end":"2026-04-07T09:42:27.134181Z","steps":["trace[1044166277] 'process raft request'  (duration: 251.467471ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:42:28.330285Z","caller":"traceutil/trace.go:171","msg":"trace[381679950] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"114.993006ms","start":"2026-04-07T09:42:28.215271Z","end":"2026-04-07T09:42:28.330264Z","steps":["trace[381679950] 'process raft request'  (duration: 114.823972ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:43:00.631575Z","caller":"traceutil/trace.go:171","msg":"trace[815281457] linearizableReadLoop","detail":"{readStateIndex:1284; appliedIndex:1283; }","duration":"107.505224ms","start":"2026-04-07T09:43:00.524043Z","end":"2026-04-07T09:43:00.631548Z","steps":["trace[815281457] 'read index received'  (duration: 107.267108ms)","trace[815281457] 'applied index is now lower than readState.Index'  (duration: 236.766µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:43:00.631705Z","caller":"traceutil/trace.go:171","msg":"trace[1958004131] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"142.825435ms","start":"2026-04-07T09:43:00.488842Z","end":"2026-04-07T09:43:00.631667Z","steps":["trace[1958004131] 'process raft request'  (duration: 142.530287ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:43:00.631825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.756891ms","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-04-07T09:43:00.631915Z","caller":"traceutil/trace.go:171","msg":"trace[773912092] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1234; }","duration":"107.865125ms","start":"2026-04-07T09:43:00.524003Z","end":"2026-04-07T09:43:00.631868Z","steps":["trace[773912092] 'agreement among raft nodes before linearized reading'  (duration: 107.665789ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:43:00.884261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.446503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T09:43:00.884338Z","caller":"traceutil/trace.go:171","msg":"trace[423659792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1235; }","duration":"107.581367ms","start":"2026-04-07T09:43:00.776739Z","end":"2026-04-07T09:43:00.88432Z","steps":["trace[423659792] 'range keys from in-memory index tree'  (duration: 107.348031ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:43:01.574376Z","caller":"traceutil/trace.go:171","msg":"trace[168133484] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"298.410495ms","start":"2026-04-07T09:43:01.275935Z","end":"2026-04-07T09:43:01.574345Z","steps":["trace[168133484] 'process raft request'  (duration: 223.568539ms)","trace[168133484] 'compare'  (duration: 74.729253ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:43:01.719751Z","caller":"traceutil/trace.go:171","msg":"trace[1612926395] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"314.531099ms","start":"2026-04-07T09:43:01.405191Z","end":"2026-04-07T09:43:01.719722Z","steps":["trace[1612926395] 'process raft request'  (duration: 271.179052ms)","trace[1612926395] 'compare'  (duration: 43.233924ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T09:43:01.719943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:01.405175Z","time spent":"314.645451ms","remote":"127.0.0.1:51366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":886,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-kn2dx.18a409d929b187d3\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-kn2dx.18a409d929b187d3\" value_size:782 lease:3219120900722777448 >> failure:<>"}
{"level":"info","ts":"2026-04-07T09:43:11.569383Z","caller":"traceutil/trace.go:171","msg":"trace[2092247310] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"154.390326ms","start":"2026-04-07T09:43:11.414969Z","end":"2026-04-07T09:43:11.56936Z","steps":["trace[2092247310] 'process raft request'  (duration: 154.234312ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:45:03.877164Z","caller":"traceutil/trace.go:171","msg":"trace[903668585] linearizableReadLoop","detail":"{readStateIndex:1892; appliedIndex:1891; }","duration":"100.333654ms","start":"2026-04-07T09:45:03.776807Z","end":"2026-04-07T09:45:03.877141Z","steps":["trace[903668585] 'read index received'  (duration: 100.135009ms)","trace[903668585] 'applied index is now lower than readState.Index'  (duration: 197.585µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-07T09:45:03.877355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.526909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-07T09:45:03.877518Z","caller":"traceutil/trace.go:171","msg":"trace[1429977586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1817; }","duration":"100.735935ms","start":"2026-04-07T09:45:03.776768Z","end":"2026-04-07T09:45:03.877504Z","steps":["trace[1429977586] 'agreement among raft nodes before linearized reading'  (duration: 100.480458ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:45:03.877901Z","caller":"traceutil/trace.go:171","msg":"trace[723650089] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"227.971991ms","start":"2026-04-07T09:45:03.649233Z","end":"2026-04-07T09:45:03.877205Z","steps":["trace[723650089] 'process raft request'  (duration: 227.764486ms)"],"step_count":1}
{"level":"info","ts":"2026-04-07T09:45:12.47036Z","caller":"traceutil/trace.go:171","msg":"trace[1209828754] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"113.988035ms","start":"2026-04-07T09:45:12.356341Z","end":"2026-04-07T09:45:12.470329Z","steps":["trace[1209828754] 'process raft request'  (duration: 83.073147ms)","trace[1209828754] 'compare'  (duration: 30.791155ms)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:46:44.194298Z","caller":"traceutil/trace.go:171","msg":"trace[341726072] linearizableReadLoop","detail":"{readStateIndex:2411; appliedIndex:2410; }","duration":"125.437584ms","start":"2026-04-07T09:46:44.068835Z","end":"2026-04-07T09:46:44.194273Z","steps":["trace[341726072] 'read index received'  (duration: 125.190667ms)","trace[341726072] 'applied index is now lower than readState.Index'  (duration: 245.827µs)"],"step_count":2}
{"level":"info","ts":"2026-04-07T09:46:44.194447Z","caller":"traceutil/trace.go:171","msg":"trace[1184220540] transaction","detail":"{read_only:false; response_revision:2315; number_of_response:1; }","duration":"142.508069ms","start":"2026-04-07T09:46:44.051927Z","end":"2026-04-07T09:46:44.194435Z","steps":["trace[1184220540] 'process raft request'  (duration: 142.16501ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:46:44.194549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.721809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:496"}
{"level":"info","ts":"2026-04-07T09:46:44.194603Z","caller":"traceutil/trace.go:171","msg":"trace[239049944] range","detail":"{range_begin:/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:2315; }","duration":"117.79846ms","start":"2026-04-07T09:46:44.076792Z","end":"2026-04-07T09:46:44.194591Z","steps":["trace[239049944] 'agreement among raft nodes before linearized reading'  (duration: 117.707908ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-07T09:46:44.194989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.121362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/\" range_end:\"/registry/daemonsets/kube-system0\" limit:500 ","response":"range_response_count:3 size:26774"}
{"level":"info","ts":"2026-04-07T09:46:44.195105Z","caller":"traceutil/trace.go:171","msg":"trace[2117662053] range","detail":"{range_begin:/registry/daemonsets/kube-system/; range_end:/registry/daemonsets/kube-system0; response_count:3; response_revision:2315; }","duration":"126.268406ms","start":"2026-04-07T09:46:44.068809Z","end":"2026-04-07T09:46:44.195078Z","steps":["trace[2117662053] 'agreement among raft nodes before linearized reading'  (duration: 125.890636ms)"],"step_count":1}