{"level":"warn","ts":"2026-04-21T17:06:52.100402Z","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-21T17:06:52.100559Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.220: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.220:2380","--initial-cluster=instance=https://199.19.213.220:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.220:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.220: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-21T17:06:52.100685Z","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-21T17:06:52.10071Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.220:2380"]}
{"level":"info","ts":"2026-04-21T17:06:52.100742Z","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-21T17:06:52.102077Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.220:2379"]}
{"level":"info","ts":"2026-04-21T17:06:52.102226Z","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.19.213.220:2380"],"listen-peer-urls":["https://199.19.213.220:2380"],"advertise-client-urls":["https://199.19.213.220:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.220:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.220: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-21T17:06:52.219371Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"116.737158ms"}
{"level":"info","ts":"2026-04-21T17:06:52.23202Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab3c4fae41c4ba3","cluster-id":"574139c3944fcfd2"}
{"level":"info","ts":"2026-04-21T17:06:52.232134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-21T17:06:52.23216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became follower at term 0"}
{"level":"info","ts":"2026-04-21T17:06:52.232171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab3c4fae41c4ba3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-21T17:06:52.232184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became follower at term 1"}
{"level":"info","ts":"2026-04-21T17:06:52.232235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 switched to configuration voters=(771176543058414499)"}
{"level":"warn","ts":"2026-04-21T17:06:52.237155Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-21T17:06:52.238711Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-21T17:06:52.240141Z","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-21T17:06:52.242913Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab3c4fae41c4ba3","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-21T17:06:52.249136Z","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-21T17:06:52.24932Z","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-21T17:06:52.249388Z","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-21T17:06:52.249481Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab3c4fae41c4ba3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-21T17:06:52.249846Z","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-21T17:06:52.249941Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.220:2380"}
{"level":"info","ts":"2026-04-21T17:06:52.250036Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.220:2380"}
{"level":"info","ts":"2026-04-21T17:06:52.250298Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab3c4fae41c4ba3","initial-advertise-peer-urls":["https://199.19.213.220:2380"],"listen-peer-urls":["https://199.19.213.220:2380"],"advertise-client-urls":["https://199.19.213.220:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.220:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-21T17:06:52.250298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 switched to configuration voters=(771176543058414499)"}
{"level":"info","ts":"2026-04-21T17:06:52.250385Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-21T17:06:52.250616Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"574139c3944fcfd2","local-member-id":"ab3c4fae41c4ba3","added-peer-id":"ab3c4fae41c4ba3","added-peer-peer-urls":["https://199.19.213.220:2380"]}
{"level":"info","ts":"2026-04-21T17:06:52.432505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-21T17:06:52.433256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-21T17:06:52.433281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 received MsgPreVoteResp from ab3c4fae41c4ba3 at term 1"}
{"level":"info","ts":"2026-04-21T17:06:52.433301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became candidate at term 2"}
{"level":"info","ts":"2026-04-21T17:06:52.433429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 received MsgVoteResp from ab3c4fae41c4ba3 at term 2"}
{"level":"info","ts":"2026-04-21T17:06:52.433458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab3c4fae41c4ba3 became leader at term 2"}
{"level":"info","ts":"2026-04-21T17:06:52.433538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab3c4fae41c4ba3 elected leader ab3c4fae41c4ba3 at term 2"}
{"level":"info","ts":"2026-04-21T17:06:52.435949Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-21T17:06:52.437286Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-21T17:06:52.437305Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab3c4fae41c4ba3","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.220:2379]}","request-path":"/0/members/ab3c4fae41c4ba3/attributes","cluster-id":"574139c3944fcfd2","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-21T17:06:52.437397Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-21T17:06:52.437602Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-21T17:06:52.437724Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-21T17:06:52.437997Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"574139c3944fcfd2","local-member-id":"ab3c4fae41c4ba3","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-21T17:06:52.438125Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-21T17:06:52.438198Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-21T17:06:52.440434Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-21T17:06:52.440938Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.220:2379"}
{"level":"warn","ts":"2026-04-21T17:06:58.000963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.234592ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5450373357622053383 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-controller-manager.18a86e32cdef855c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-controller-manager.18a86e32cdef855c\" value_size:666 lease:5450373357622053380 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-21T17:06:58.001205Z","caller":"traceutil/trace.go:171","msg":"trace[148003762] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"183.179403ms","start":"2026-04-21T17:06:57.818008Z","end":"2026-04-21T17:06:58.001188Z","steps":["trace[148003762] 'process raft request'  (duration: 183.127352ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:06:58.001259Z","caller":"traceutil/trace.go:171","msg":"trace[245045775] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"510.966697ms","start":"2026-04-21T17:06:57.490232Z","end":"2026-04-21T17:06:58.001198Z","steps":["trace[245045775] 'process raft request'  (duration: 228.943148ms)","trace[245045775] 'compare'  (duration: 281.086527ms)"],"step_count":2}
{"level":"info","ts":"2026-04-21T17:06:58.001276Z","caller":"traceutil/trace.go:171","msg":"trace[1564274049] linearizableReadLoop","detail":"{readStateIndex:217; appliedIndex:215; }","duration":"503.35218ms","start":"2026-04-21T17:06:57.497875Z","end":"2026-04-21T17:06:58.001227Z","steps":["trace[1564274049] 'read index received'  (duration: 2.003688ms)","trace[1564274049] 'applied index is now lower than readState.Index'  (duration: 501.342071ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-21T17:06:58.00147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.562607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-21T17:06:58.0015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:06:57.490223Z","time spent":"511.152883ms","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-controller-manager.18a86e32cdef855c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-controller-manager.18a86e32cdef855c\" value_size:666 lease:5450373357622053380 >> failure:<>"}
{"level":"info","ts":"2026-04-21T17:06:58.00158Z","caller":"traceutil/trace.go:171","msg":"trace[251460261] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:211; }","duration":"503.724592ms","start":"2026-04-21T17:06:57.497828Z","end":"2026-04-21T17:06:58.001552Z","steps":["trace[251460261] 'agreement among raft nodes before linearized reading'  (duration: 503.499504ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:06:58.001629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:06:57.497804Z","time spent":"503.815365ms","remote":"127.0.0.1:42934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "}
{"level":"warn","ts":"2026-04-21T17:06:58.001688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.480643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"}
{"level":"info","ts":"2026-04-21T17:06:58.001742Z","caller":"traceutil/trace.go:171","msg":"trace[1211083990] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:211; }","duration":"295.606128ms","start":"2026-04-21T17:06:57.70612Z","end":"2026-04-21T17:06:58.001726Z","steps":["trace[1211083990] 'agreement among raft nodes before linearized reading'  (duration: 295.339949ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:06:58.499994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.17806ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5450373357622053388 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.18a86e3149c7350c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18a86e3149c7350c\" value_size:557 lease:5450373357622053380 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-21T17:06:58.500203Z","caller":"traceutil/trace.go:171","msg":"trace[1087597018] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"493.833311ms","start":"2026-04-21T17:06:58.006353Z","end":"2026-04-21T17:06:58.500186Z","steps":["trace[1087597018] 'process raft request'  (duration: 184.377271ms)","trace[1087597018] 'compare'  (duration: 308.795028ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-21T17:06:58.500289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:06:58.006333Z","time spent":"493.916713ms","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18a86e3149c7350c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18a86e3149c7350c\" value_size:557 lease:5450373357622053380 >> failure:<>"}
{"level":"info","ts":"2026-04-21T17:06:58.505265Z","caller":"traceutil/trace.go:171","msg":"trace[425635320] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"496.762878ms","start":"2026-04-21T17:06:58.008486Z","end":"2026-04-21T17:06:58.505249Z","steps":["trace[425635320] 'process raft request'  (duration: 496.493589ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:06:58.505257Z","caller":"traceutil/trace.go:171","msg":"trace[1827961518] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"496.291382ms","start":"2026-04-21T17:06:58.008938Z","end":"2026-04-21T17:06:58.50523Z","steps":["trace[1827961518] 'process raft request'  (duration: 496.23779ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:06:58.505548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:06:58.008926Z","time spent":"496.529461ms","remote":"127.0.0.1:42934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" value_size:124 >> failure:<>"}
{"level":"warn","ts":"2026-04-21T17:06:58.505633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:06:58.008473Z","time spent":"496.865302ms","remote":"127.0.0.1:42910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:27 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3661 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-04-21T17:06:58.509026Z","caller":"traceutil/trace.go:171","msg":"trace[1177515481] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"315.419149ms","start":"2026-04-21T17:06:58.193583Z","end":"2026-04-21T17:06:58.509002Z","steps":["trace[1177515481] 'process raft request'  (duration: 314.903932ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:06:58.509155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:06:58.193521Z","time spent":"315.568074ms","remote":"127.0.0.1:42918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"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":"info","ts":"2026-04-21T17:06:58.509391Z","caller":"traceutil/trace.go:171","msg":"trace[733387503] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"238.408006ms","start":"2026-04-21T17:06:58.270919Z","end":"2026-04-21T17:06:58.509327Z","steps":["trace[733387503] 'process raft request'  (duration: 237.669732ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:21.88917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.573727ms","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-21T17:07:21.889268Z","caller":"traceutil/trace.go:171","msg":"trace[682299313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:471; }","duration":"262.69657ms","start":"2026-04-21T17:07:21.62655Z","end":"2026-04-21T17:07:21.889246Z","steps":["trace[682299313] 'range keys from in-memory index tree'  (duration: 262.398102ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:22.389733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.107858ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5450373357622053926 > lease_revoke:<id:4ba39db10250cb91>","response":"size:27"}
{"level":"info","ts":"2026-04-21T17:07:23.502915Z","caller":"traceutil/trace.go:171","msg":"trace[425627899] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:494; }","duration":"543.64339ms","start":"2026-04-21T17:07:22.959253Z","end":"2026-04-21T17:07:23.502896Z","steps":["trace[425627899] 'read index received'  (duration: 59.867935ms)","trace[425627899] 'applied index is now lower than readState.Index'  (duration: 483.774045ms)"],"step_count":2}
{"level":"info","ts":"2026-04-21T17:07:23.503218Z","caller":"traceutil/trace.go:171","msg":"trace[53774774] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"776.805041ms","start":"2026-04-21T17:07:22.726389Z","end":"2026-04-21T17:07:23.503194Z","steps":["trace[53774774] 'process raft request'  (duration: 776.38069ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:23.503347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:22.726359Z","time spent":"776.914644ms","remote":"127.0.0.1:42992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:469 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-21T17:07:23.503788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.755153ms","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-21T17:07:23.503836Z","caller":"traceutil/trace.go:171","msg":"trace[1544865777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:473; }","duration":"544.579775ms","start":"2026-04-21T17:07:22.959245Z","end":"2026-04-21T17:07:23.503824Z","steps":["trace[1544865777] 'agreement among raft nodes before linearized reading'  (duration: 543.728522ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:23.503864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:22.959178Z","time spent":"544.676377ms","remote":"127.0.0.1:42992","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-21T17:07:24.217699Z","caller":"traceutil/trace.go:171","msg":"trace[977909451] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"305.085993ms","start":"2026-04-21T17:07:23.912586Z","end":"2026-04-21T17:07:24.217672Z","steps":["trace[977909451] 'process raft request'  (duration: 304.907378ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:24.218621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:23.912564Z","time spent":"305.291979ms","remote":"127.0.0.1:42992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:472 > 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-21T17:07:24.936826Z","caller":"traceutil/trace.go:171","msg":"trace[1806978301] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"366.776518ms","start":"2026-04-21T17:07:24.570019Z","end":"2026-04-21T17:07:24.936795Z","steps":["trace[1806978301] 'process raft request'  (duration: 366.577123ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:24.93703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:24.569986Z","time spent":"366.935473ms","remote":"127.0.0.1:42992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:426 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-04-21T17:07:25.693909Z","caller":"traceutil/trace.go:171","msg":"trace[2147214702] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"165.917475ms","start":"2026-04-21T17:07:25.527943Z","end":"2026-04-21T17:07:25.69386Z","steps":["trace[2147214702] 'process raft request'  (duration: 164.238281ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:29.846089Z","caller":"traceutil/trace.go:171","msg":"trace[406055263] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"303.38937ms","start":"2026-04-21T17:07:29.542669Z","end":"2026-04-21T17:07:29.846059Z","steps":["trace[406055263] 'process raft request'  (duration: 303.132434ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:29.846325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:29.542656Z","time spent":"303.516913ms","remote":"127.0.0.1:42992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:483 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-04-21T17:07:29.854325Z","caller":"traceutil/trace.go:171","msg":"trace[583288906] linearizableReadLoop","detail":"{readStateIndex:511; appliedIndex:509; }","duration":"143.13452ms","start":"2026-04-21T17:07:29.711155Z","end":"2026-04-21T17:07:29.854289Z","steps":["trace[583288906] 'read index received'  (duration: 134.666607ms)","trace[583288906] 'applied index is now lower than readState.Index'  (duration: 8.466373ms)"],"step_count":2}
{"level":"info","ts":"2026-04-21T17:07:29.854394Z","caller":"traceutil/trace.go:171","msg":"trace[1735323863] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"311.500975ms","start":"2026-04-21T17:07:29.542849Z","end":"2026-04-21T17:07:29.85435Z","steps":["trace[1735323863] 'process raft request'  (duration: 311.228998ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:29.854517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:29.542822Z","time spent":"311.633048ms","remote":"127.0.0.1:42992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:484 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-21T17:07:29.854524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.323555ms","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-21T17:07:29.854631Z","caller":"traceutil/trace.go:171","msg":"trace[184605897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:488; }","duration":"143.51797ms","start":"2026-04-21T17:07:29.711098Z","end":"2026-04-21T17:07:29.854615Z","steps":["trace[184605897] 'agreement among raft nodes before linearized reading'  (duration: 143.328805ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:30.690785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.508243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-21T17:07:30.690877Z","caller":"traceutil/trace.go:171","msg":"trace[1909297967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:489; }","duration":"489.672066ms","start":"2026-04-21T17:07:30.201189Z","end":"2026-04-21T17:07:30.690861Z","steps":["trace[1909297967] 'range keys from in-memory index tree'  (duration: 489.41316ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:30.690867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.826752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-04-21T17:07:30.69092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:30.201159Z","time spent":"489.747389ms","remote":"127.0.0.1:42708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-21T17:07:30.69093Z","caller":"traceutil/trace.go:171","msg":"trace[1219639464] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:489; }","duration":"445.962106ms","start":"2026-04-21T17:07:30.244952Z","end":"2026-04-21T17:07:30.690914Z","steps":["trace[1219639464] 'range keys from in-memory index tree'  (duration: 445.706689ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:30.690962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:30.244914Z","time spent":"446.041098ms","remote":"127.0.0.1:42992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-21T17:07:32.701073Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5450373357622053984,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-21T17:07:33.201582Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5450373357622053984,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-21T17:07:33.702594Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5450373357622053984,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-21T17:07:34.201326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000284155s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-21T17:07:34.201406Z","caller":"traceutil/trace.go:171","msg":"trace[631648193] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000429898s","start":"2026-04-21T17:07:32.200956Z","end":"2026-04-21T17:07:34.201386Z","steps":["trace[631648193] 'agreement among raft nodes before linearized reading'  (duration: 2.000333856s)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:34.201457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:32.200921Z","time spent":"2.00052639s","remote":"127.0.0.1:42718","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-21T17:07:34.202876Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5450373357622053984,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-21T17:07:34.703905Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5450373357622053984,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-21T17:07:34.959985Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.089625573s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-21T17:07:34.960529Z","caller":"traceutil/trace.go:171","msg":"trace[654140736] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"3.090200207s","start":"2026-04-21T17:07:31.870305Z","end":"2026-04-21T17:07:34.960505Z","steps":["trace[654140736] 'process raft request'  (duration: 3.090061324s)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:34.960665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:31.870299Z","time spent":"3.090275589s","remote":"127.0.0.1:42992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:489 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-04-21T17:07:35.402961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.980602ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5450373357622053986 > lease_revoke:<id:4ba39db10250cc01>","response":"size:27"}
{"level":"info","ts":"2026-04-21T17:07:35.404078Z","caller":"traceutil/trace.go:171","msg":"trace[695300971] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.198841034s","start":"2026-04-21T17:07:34.205167Z","end":"2026-04-21T17:07:35.404008Z","steps":["trace[695300971] 'process raft request'  (duration: 1.198017664s)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:35.40413Z","caller":"traceutil/trace.go:171","msg":"trace[533888604] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"151.329837ms","start":"2026-04-21T17:07:35.252775Z","end":"2026-04-21T17:07:35.404104Z","steps":["trace[533888604] 'process raft request'  (duration: 151.178413ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:35.40413Z","caller":"traceutil/trace.go:171","msg":"trace[300204548] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:516; }","duration":"3.203066763s","start":"2026-04-21T17:07:32.201016Z","end":"2026-04-21T17:07:35.404083Z","steps":["trace[300204548] 'read index received'  (duration: 2.759453912s)","trace[300204548] 'applied index is now lower than readState.Index'  (duration: 443.609361ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-21T17:07:35.404248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:34.205153Z","time spent":"1.199010277s","remote":"127.0.0.1:42794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.18a86e3b5abd873e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.18a86e3b5abd873e\" value_size:672 lease:5450373357622053380 >> failure:<>"}
{"level":"warn","ts":"2026-04-21T17:07:35.404384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.539973991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-21T17:07:35.404427Z","caller":"traceutil/trace.go:171","msg":"trace[546219695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:496; }","duration":"1.540095184s","start":"2026-04-21T17:07:33.864322Z","end":"2026-04-21T17:07:35.404417Z","steps":["trace[546219695] 'agreement among raft nodes before linearized reading'  (duration: 1.539962231s)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:35.40443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.01948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-04-21T17:07:35.40446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.193638698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-21T17:07:35.404516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.535542063s","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-21T17:07:35.404581Z","caller":"traceutil/trace.go:171","msg":"trace[74031771] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:496; }","duration":"1.535625955s","start":"2026-04-21T17:07:33.868949Z","end":"2026-04-21T17:07:35.404575Z","steps":["trace[74031771] 'agreement among raft nodes before linearized reading'  (duration: 1.535526503s)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:35.404566Z","caller":"traceutil/trace.go:171","msg":"trace[1068982217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:496; }","duration":"1.19376184s","start":"2026-04-21T17:07:34.210772Z","end":"2026-04-21T17:07:35.404534Z","steps":["trace[1068982217] 'agreement among raft nodes before linearized reading'  (duration: 1.193603226s)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:35.404601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:33.868939Z","time spent":"1.535656266s","remote":"127.0.0.1:42992","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":"warn","ts":"2026-04-21T17:07:35.404455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:33.864296Z","time spent":"1.540153125s","remote":"127.0.0.1:42992","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-21T17:07:35.404651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:34.210765Z","time spent":"1.193869753s","remote":"127.0.0.1:42708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-21T17:07:35.404494Z","caller":"traceutil/trace.go:171","msg":"trace[946076709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:496; }","duration":"942.098712ms","start":"2026-04-21T17:07:34.46238Z","end":"2026-04-21T17:07:35.404479Z","steps":["trace[946076709] 'agreement among raft nodes before linearized reading'  (duration: 941.975119ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:35.404714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:34.46233Z","time spent":"942.369338ms","remote":"127.0.0.1:42992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-04-21T17:07:38.907344Z","caller":"traceutil/trace.go:171","msg":"trace[1221778875] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"193.098031ms","start":"2026-04-21T17:07:38.714213Z","end":"2026-04-21T17:07:38.907311Z","steps":["trace[1221778875] 'process raft request'  (duration: 192.894476ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.913931Z","caller":"traceutil/trace.go:171","msg":"trace[231488328] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"195.404496ms","start":"2026-04-21T17:07:38.718508Z","end":"2026-04-21T17:07:38.913912Z","steps":["trace[231488328] 'process raft request'  (duration: 195.17528ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.914149Z","caller":"traceutil/trace.go:171","msg":"trace[1976710136] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"183.129138ms","start":"2026-04-21T17:07:38.730984Z","end":"2026-04-21T17:07:38.914113Z","steps":["trace[1976710136] 'process raft request'  (duration: 182.851892ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.914136Z","caller":"traceutil/trace.go:171","msg":"trace[1335767902] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"182.972944ms","start":"2026-04-21T17:07:38.731117Z","end":"2026-04-21T17:07:38.91409Z","steps":["trace[1335767902] 'process raft request'  (duration: 182.82559ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.914167Z","caller":"traceutil/trace.go:171","msg":"trace[1209891477] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"182.989655ms","start":"2026-04-21T17:07:38.731069Z","end":"2026-04-21T17:07:38.914059Z","steps":["trace[1209891477] 'process raft request'  (duration: 182.811711ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.914298Z","caller":"traceutil/trace.go:171","msg":"trace[1658397261] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"183.137998ms","start":"2026-04-21T17:07:38.731116Z","end":"2026-04-21T17:07:38.914254Z","steps":["trace[1658397261] 'process raft request'  (duration: 182.890022ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.915504Z","caller":"traceutil/trace.go:171","msg":"trace[1463314121] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"181.853688ms","start":"2026-04-21T17:07:38.733599Z","end":"2026-04-21T17:07:38.915453Z","steps":["trace[1463314121] 'process raft request'  (duration: 181.249293ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.917336Z","caller":"traceutil/trace.go:171","msg":"trace[1789677174] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"174.051345ms","start":"2026-04-21T17:07:38.742909Z","end":"2026-04-21T17:07:38.91696Z","steps":["trace[1789677174] 'process raft request'  (duration: 172.374426ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.918246Z","caller":"traceutil/trace.go:171","msg":"trace[1883358914] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"170.754258ms","start":"2026-04-21T17:07:38.747278Z","end":"2026-04-21T17:07:38.918033Z","steps":["trace[1883358914] 'process raft request'  (duration: 169.439897ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.91928Z","caller":"traceutil/trace.go:171","msg":"trace[678650882] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"153.542156ms","start":"2026-04-21T17:07:38.76572Z","end":"2026-04-21T17:07:38.919262Z","steps":["trace[678650882] 'process raft request'  (duration: 152.241956ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:38.922453Z","caller":"traceutil/trace.go:171","msg":"trace[1718772439] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"123.273006ms","start":"2026-04-21T17:07:38.799156Z","end":"2026-04-21T17:07:38.922429Z","steps":["trace[1718772439] 'process raft request'  (duration: 119.956229ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:39.312427Z","caller":"traceutil/trace.go:171","msg":"trace[971256518] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"106.850153ms","start":"2026-04-21T17:07:39.205549Z","end":"2026-04-21T17:07:39.3124Z","steps":["trace[971256518] 'process raft request'  (duration: 106.614927ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:39.363143Z","caller":"traceutil/trace.go:171","msg":"trace[2039351933] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"150.583619ms","start":"2026-04-21T17:07:39.212535Z","end":"2026-04-21T17:07:39.363118Z","steps":["trace[2039351933] 'process raft request'  (duration: 150.312693ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:39.363321Z","caller":"traceutil/trace.go:171","msg":"trace[308726132] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"146.712638ms","start":"2026-04-21T17:07:39.216598Z","end":"2026-04-21T17:07:39.363311Z","steps":["trace[308726132] 'process raft request'  (duration: 146.476743ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:39.504812Z","caller":"traceutil/trace.go:171","msg":"trace[1577377261] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"114.03895ms","start":"2026-04-21T17:07:39.390745Z","end":"2026-04-21T17:07:39.504784Z","steps":["trace[1577377261] 'process raft request'  (duration: 45.223861ms)","trace[1577377261] 'compare'  (duration: 68.614674ms)"],"step_count":2}
{"level":"info","ts":"2026-04-21T17:07:39.506708Z","caller":"traceutil/trace.go:171","msg":"trace[960322608] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"113.497907ms","start":"2026-04-21T17:07:39.392393Z","end":"2026-04-21T17:07:39.505891Z","steps":["trace[960322608] 'process raft request'  (duration: 113.267962ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:40.08804Z","caller":"traceutil/trace.go:171","msg":"trace[1305046414] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"113.77365ms","start":"2026-04-21T17:07:39.974232Z","end":"2026-04-21T17:07:40.088006Z","steps":["trace[1305046414] 'process raft request'  (duration: 113.397741ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:45.588612Z","caller":"traceutil/trace.go:171","msg":"trace[2066809830] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"145.29768ms","start":"2026-04-21T17:07:45.443296Z","end":"2026-04-21T17:07:45.588594Z","steps":["trace[2066809830] 'process raft request'  (duration: 144.542053ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:45.813272Z","caller":"traceutil/trace.go:171","msg":"trace[1765965981] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"138.795095ms","start":"2026-04-21T17:07:45.674437Z","end":"2026-04-21T17:07:45.813232Z","steps":["trace[1765965981] 'process raft request'  (duration: 138.151731ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:45.960273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.137753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6pgqp\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-04-21T17:07:45.960363Z","caller":"traceutil/trace.go:171","msg":"trace[1231384048] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6pgqp; range_end:; response_count:1; response_revision:649; }","duration":"202.294216ms","start":"2026-04-21T17:07:45.758047Z","end":"2026-04-21T17:07:45.960341Z","steps":["trace[1231384048] 'agreement among raft nodes before linearized reading'  (duration: 55.153026ms)","trace[1231384048] 'range keys from in-memory index tree'  (duration: 146.869354ms)"],"step_count":2}
{"level":"info","ts":"2026-04-21T17:07:46.000222Z","caller":"traceutil/trace.go:171","msg":"trace[1492405963] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"120.876017ms","start":"2026-04-21T17:07:45.879287Z","end":"2026-04-21T17:07:46.000163Z","steps":["trace[1492405963] 'process raft request'  (duration: 120.646942ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:07:46.770757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.734665ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5450373357622054258 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-6pgqp\" mod_revision:532 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-6pgqp\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-6pgqp\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-21T17:07:46.770883Z","caller":"traceutil/trace.go:171","msg":"trace[1945134562] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"757.356122ms","start":"2026-04-21T17:07:46.013509Z","end":"2026-04-21T17:07:46.770865Z","steps":["trace[1945134562] 'read index received'  (duration: 447.387852ms)","trace[1945134562] 'applied index is now lower than readState.Index'  (duration: 309.96702ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-21T17:07:46.770979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.476295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-21T17:07:46.771008Z","caller":"traceutil/trace.go:171","msg":"trace[1900440160] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:651; }","duration":"757.541286ms","start":"2026-04-21T17:07:46.013455Z","end":"2026-04-21T17:07:46.770996Z","steps":["trace[1900440160] 'agreement among raft nodes before linearized reading'  (duration: 757.451824ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:07:46.771071Z","caller":"traceutil/trace.go:171","msg":"trace[2027375610] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"793.345941ms","start":"2026-04-21T17:07:45.977669Z","end":"2026-04-21T17:07:46.771015Z","steps":["trace[2027375610] 'process raft request'  (duration: 483.244888ms)","trace[2027375610] 'compare'  (duration: 308.712702ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-21T17:07:46.771109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:46.013423Z","time spent":"757.674209ms","remote":"127.0.0.1:42970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "}
{"level":"warn","ts":"2026-04-21T17:07:46.77118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:07:45.97763Z","time spent":"793.493734ms","remote":"127.0.0.1:42918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-6pgqp\" mod_revision:532 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-6pgqp\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-6pgqp\" > >"}
{"level":"info","ts":"2026-04-21T17:08:04.020414Z","caller":"traceutil/trace.go:171","msg":"trace[222575895] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"276.004967ms","start":"2026-04-21T17:08:03.74437Z","end":"2026-04-21T17:08:04.020375Z","steps":["trace[222575895] 'process raft request'  (duration: 275.780073ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:08:04.020314Z","caller":"traceutil/trace.go:171","msg":"trace[1663952078] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:854; }","duration":"243.17577ms","start":"2026-04-21T17:08:03.777113Z","end":"2026-04-21T17:08:04.020288Z","steps":["trace[1663952078] 'read index received'  (duration: 243.074778ms)","trace[1663952078] 'applied index is now lower than readState.Index'  (duration: 99.872µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-21T17:08:04.020874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.738781ms","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-21T17:08:04.020961Z","caller":"traceutil/trace.go:171","msg":"trace[1634024302] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:818; }","duration":"243.861433ms","start":"2026-04-21T17:08:03.777085Z","end":"2026-04-21T17:08:04.020946Z","steps":["trace[1634024302] 'agreement among raft nodes before linearized reading'  (duration: 243.403464ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:08:04.02498Z","caller":"traceutil/trace.go:171","msg":"trace[623674951] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"136.495337ms","start":"2026-04-21T17:08:03.888459Z","end":"2026-04-21T17:08:04.024954Z","steps":["trace[623674951] 'process raft request'  (duration: 136.15154ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:08:04.025049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.439877ms","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-21T17:08:04.025187Z","caller":"traceutil/trace.go:171","msg":"trace[986170734] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:819; }","duration":"202.59395ms","start":"2026-04-21T17:08:03.822564Z","end":"2026-04-21T17:08:04.025158Z","steps":["trace[986170734] 'agreement among raft nodes before linearized reading'  (duration: 202.243293ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:08:28.357186Z","caller":"traceutil/trace.go:171","msg":"trace[1350835601] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1066; }","duration":"186.603199ms","start":"2026-04-21T17:08:28.170544Z","end":"2026-04-21T17:08:28.357147Z","steps":["trace[1350835601] 'read index received'  (duration: 186.101671ms)","trace[1350835601] 'applied index is now lower than readState.Index'  (duration: 500.228µs)"],"step_count":2}
{"level":"info","ts":"2026-04-21T17:08:28.35725Z","caller":"traceutil/trace.go:171","msg":"trace[1980966264] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"198.567935ms","start":"2026-04-21T17:08:28.158629Z","end":"2026-04-21T17:08:28.357197Z","steps":["trace[1980966264] 'process raft request'  (duration: 198.177498ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:08:28.357565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.984966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-04-21T17:08:28.357664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.459888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-04-21T17:08:28.357686Z","caller":"traceutil/trace.go:171","msg":"trace[1669881086] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1025; }","duration":"187.167059ms","start":"2026-04-21T17:08:28.170489Z","end":"2026-04-21T17:08:28.357656Z","steps":["trace[1669881086] 'agreement among raft nodes before linearized reading'  (duration: 186.842664ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:08:28.357736Z","caller":"traceutil/trace.go:171","msg":"trace[469223788] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1025; }","duration":"143.575349ms","start":"2026-04-21T17:08:28.214148Z","end":"2026-04-21T17:08:28.357723Z","steps":["trace[469223788] 'agreement among raft nodes before linearized reading'  (duration: 143.332665ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:08:28.358197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.273838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-21T17:08:28.358292Z","caller":"traceutil/trace.go:171","msg":"trace[1676135275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1025; }","duration":"156.416101ms","start":"2026-04-21T17:08:28.201857Z","end":"2026-04-21T17:08:28.358273Z","steps":["trace[1676135275] 'agreement among raft nodes before linearized reading'  (duration: 155.575226ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:08:29.277182Z","caller":"traceutil/trace.go:171","msg":"trace[1865515086] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"100.768875ms","start":"2026-04-21T17:08:29.176394Z","end":"2026-04-21T17:08:29.277163Z","steps":["trace[1865515086] 'process raft request'  (duration: 100.649573ms)"],"step_count":1}
{"level":"info","ts":"2026-04-21T17:08:29.538282Z","caller":"traceutil/trace.go:171","msg":"trace[1306794016] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"202.158772ms","start":"2026-04-21T17:08:29.336089Z","end":"2026-04-21T17:08:29.538248Z","steps":["trace[1306794016] 'process raft request'  (duration: 200.143727ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-21T17:09:06.894432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.781672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-21T17:09:06.894573Z","caller":"traceutil/trace.go:171","msg":"trace[2069733424] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1156; }","duration":"115.992625ms","start":"2026-04-21T17:09:06.778554Z","end":"2026-04-21T17:09:06.894547Z","steps":["trace[2069733424] 'range keys from in-memory index tree'  (duration: 115.492378ms)"],"step_count":1}