{"level":"warn","ts":"2026-03-20T05:34:26.728674Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T05:34:26.728761Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-03-20T05:34:26.728833Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-20T05:34:26.728847Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-03-20T05:34:26.728873Z","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-03-20T05:34:26.729546Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]}
{"level":"info","ts":"2026-03-20T05:34:26.729622Z","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.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-03-20T05:34:26.733846Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.976123ms"}
{"level":"info","ts":"2026-03-20T05:34:26.743482Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"}
{"level":"info","ts":"2026-03-20T05:34:26.74361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"}
{"level":"info","ts":"2026-03-20T05:34:26.74364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"}
{"level":"info","ts":"2026-03-20T05:34:26.743658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-20T05:34:26.743671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"}
{"level":"info","ts":"2026-03-20T05:34:26.743709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"warn","ts":"2026-03-20T05:34:26.753628Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-20T05:34:26.756624Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-20T05:34:26.761889Z","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-03-20T05:34:26.766512Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-20T05:34:26.76681Z","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-03-20T05:34:26.766951Z","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-03-20T05:34:26.766969Z","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-03-20T05:34:26.766878Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-20T05:34:26.768617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"}
{"level":"info","ts":"2026-03-20T05:34:26.768921Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]}
{"level":"info","ts":"2026-03-20T05:34:26.772023Z","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-03-20T05:34:26.77221Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-03-20T05:34:26.772256Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"}
{"level":"info","ts":"2026-03-20T05:34:26.77257Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-20T05:34:26.772609Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-20T05:34:27.744757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"}
{"level":"info","ts":"2026-03-20T05:34:27.74482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-20T05:34:27.744837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"}
{"level":"info","ts":"2026-03-20T05:34:27.744849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"}
{"level":"info","ts":"2026-03-20T05:34:27.744854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-03-20T05:34:27.744862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"}
{"level":"info","ts":"2026-03-20T05:34:27.74487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"}
{"level":"info","ts":"2026-03-20T05:34:27.74632Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T05:34:27.746406Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T05:34:27.746396Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-20T05:34:27.746914Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-20T05:34:27.74714Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-20T05:34:27.747248Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-20T05:34:27.747588Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T05:34:27.747703Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T05:34:27.747754Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-20T05:34:27.74824Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-20T05:34:27.751293Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"}
{"level":"info","ts":"2026-03-20T05:34:29.44446Z","caller":"traceutil/trace.go:171","msg":"trace[1069575138] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"133.917906ms","start":"2026-03-20T05:34:29.310496Z","end":"2026-03-20T05:34:29.444414Z","steps":["trace[1069575138] 'process raft request'  (duration: 100.240224ms)","trace[1069575138] 'compare'  (duration: 33.422256ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:34:29.444605Z","caller":"traceutil/trace.go:171","msg":"trace[1222605789] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"133.63646ms","start":"2026-03-20T05:34:29.310926Z","end":"2026-03-20T05:34:29.444563Z","steps":["trace[1222605789] 'process raft request'  (duration: 133.384454ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:34:29.444477Z","caller":"traceutil/trace.go:171","msg":"trace[1285671897] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"132.844961ms","start":"2026-03-20T05:34:29.311598Z","end":"2026-03-20T05:34:29.444443Z","steps":["trace[1285671897] 'process raft request'  (duration: 132.77532ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:43.698774Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198433734572687,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T05:34:44.199625Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198433734572687,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T05:34:44.699779Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198433734572687,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-20T05:34:45.063744Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.202471225s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-20T05:34:45.06448Z","caller":"traceutil/trace.go:171","msg":"trace[1467316299] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"2.20327912s","start":"2026-03-20T05:34:42.86116Z","end":"2026-03-20T05:34:45.064439Z","steps":["trace[1467316299] 'process raft request'  (duration: 2.203016375s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.065682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:34:42.861143Z","time spent":"2.203469773s","remote":"127.0.0.1:34962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:369 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:4597 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-vip-instance\" > >"}
{"level":"warn","ts":"2026-03-20T05:34:45.1982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000465404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-03-20T05:34:45.198317Z","caller":"traceutil/trace.go:171","msg":"trace[1973844729] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000621908s","start":"2026-03-20T05:34:43.197671Z","end":"2026-03-20T05:34:45.198293Z","steps":["trace[1973844729] 'agreement among raft nodes before linearized reading'  (duration: 2.000486135s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.198368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:34:43.197655Z","time spent":"2.000703269s","remote":"127.0.0.1:60224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/03/20 05:34:45 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-03-20T05:34:45.249471Z","caller":"traceutil/trace.go:171","msg":"trace[843483334] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:419; }","duration":"2.051734797s","start":"2026-03-20T05:34:43.197706Z","end":"2026-03-20T05:34:45.249441Z","steps":["trace[843483334] 'read index received'  (duration: 1.866373217s)","trace[843483334] 'applied index is now lower than readState.Index'  (duration: 185.36035ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:34:45.249589Z","caller":"traceutil/trace.go:171","msg":"trace[692118745] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"2.30130014s","start":"2026-03-20T05:34:42.94823Z","end":"2026-03-20T05:34:45.24953Z","steps":["trace[692118745] 'process raft request'  (duration: 2.295037193s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.250527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:34:42.948209Z","time spent":"2.302140286s","remote":"127.0.0.1:35042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:271 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-20T05:34:45.24997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.678315779s","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-03-20T05:34:45.251361Z","caller":"traceutil/trace.go:171","msg":"trace[642835503] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:411; }","duration":"1.679771237s","start":"2026-03-20T05:34:43.571566Z","end":"2026-03-20T05:34:45.251337Z","steps":["trace[642835503] 'agreement among raft nodes before linearized reading'  (duration: 1.678182696s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.249733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.541617783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"}
{"level":"info","ts":"2026-03-20T05:34:45.25145Z","caller":"traceutil/trace.go:171","msg":"trace[1954859103] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:411; }","duration":"1.543383917s","start":"2026-03-20T05:34:43.708028Z","end":"2026-03-20T05:34:45.251412Z","steps":["trace[1954859103] 'agreement among raft nodes before linearized reading'  (duration: 1.541626533s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.249846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.63841195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-03-20T05:34:45.251432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:34:43.571556Z","time spent":"1.679858368s","remote":"127.0.0.1:35042","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-03-20T05:34:45.25152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:34:43.707996Z","time spent":"1.543506859s","remote":"127.0.0.1:35242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4078,"request content":"key:\"/registry/deployments/kube-system/coredns\" "}
{"level":"info","ts":"2026-03-20T05:34:45.251542Z","caller":"traceutil/trace.go:171","msg":"trace[898505235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"1.640135303s","start":"2026-03-20T05:34:43.611372Z","end":"2026-03-20T05:34:45.251507Z","steps":["trace[898505235] 'agreement among raft nodes before linearized reading'  (duration: 1.63844414s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.249912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.034629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"}
{"level":"warn","ts":"2026-03-20T05:34:45.251609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:34:43.61134Z","time spent":"1.640251174s","remote":"127.0.0.1:35042","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-03-20T05:34:45.251668Z","caller":"traceutil/trace.go:171","msg":"trace[644907051] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:411; }","duration":"181.802012ms","start":"2026-03-20T05:34:45.069832Z","end":"2026-03-20T05:34:45.251634Z","steps":["trace[644907051] 'agreement among raft nodes before linearized reading'  (duration: 180.002718ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.249731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.94213893s","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-03-20T05:34:45.251781Z","caller":"traceutil/trace.go:171","msg":"trace[975453467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:411; }","duration":"1.944230889s","start":"2026-03-20T05:34:43.307525Z","end":"2026-03-20T05:34:45.251756Z","steps":["trace[975453467] 'agreement among raft nodes before linearized reading'  (duration: 1.942106189s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.249991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.682412346s","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-03-20T05:34:45.251854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:34:43.307513Z","time spent":"1.944321382s","remote":"127.0.0.1:35042","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":"info","ts":"2026-03-20T05:34:45.251862Z","caller":"traceutil/trace.go:171","msg":"trace[1451780940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:411; }","duration":"1.684332342s","start":"2026-03-20T05:34:43.567517Z","end":"2026-03-20T05:34:45.251849Z","steps":["trace[1451780940] 'agreement among raft nodes before linearized reading'  (duration: 1.682347494s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:45.251902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:34:43.567491Z","time spent":"1.684400203s","remote":"127.0.0.1:35042","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-03-20T05:34:57.798048Z","caller":"traceutil/trace.go:171","msg":"trace[1995311453] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"136.729326ms","start":"2026-03-20T05:34:57.661296Z","end":"2026-03-20T05:34:57.798026Z","steps":["trace[1995311453] 'process raft request'  (duration: 85.686249ms)","trace[1995311453] 'compare'  (duration: 50.853324ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:34:57.798473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.714303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" ","response":"range_response_count:1 size:4309"}
{"level":"info","ts":"2026-03-20T05:34:57.798657Z","caller":"traceutil/trace.go:171","msg":"trace[667930026] range","detail":"{range_begin:/registry/replicasets/kube-system/cilium-operator-869df985b8; range_end:; response_count:1; response_revision:504; }","duration":"146.838866ms","start":"2026-03-20T05:34:57.651701Z","end":"2026-03-20T05:34:57.79854Z","steps":["trace[667930026] 'agreement among raft nodes before linearized reading'  (duration: 146.431658ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:34:57.798595Z","caller":"traceutil/trace.go:171","msg":"trace[1314429167] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:516; }","duration":"135.722798ms","start":"2026-03-20T05:34:57.662243Z","end":"2026-03-20T05:34:57.797965Z","steps":["trace[1314429167] 'read index received'  (duration: 84.820693ms)","trace[1314429167] 'applied index is now lower than readState.Index'  (duration: 50.900965ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:34:57.800959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.272038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14401"}
{"level":"info","ts":"2026-03-20T05:34:57.801051Z","caller":"traceutil/trace.go:171","msg":"trace[1476053925] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:505; }","duration":"136.410141ms","start":"2026-03-20T05:34:57.664623Z","end":"2026-03-20T05:34:57.801034Z","steps":["trace[1476053925] 'agreement among raft nodes before linearized reading'  (duration: 136.159236ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:34:58.135202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.878322ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198433734572866 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/deployments/kube-system/cilium-operator\" mod_revision:503 > success:<request_put:<key:\"/registry/deployments/kube-system/cilium-operator\" value_size:4599 >> failure:<request_range:<key:\"/registry/deployments/kube-system/cilium-operator\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:34:58.135297Z","caller":"traceutil/trace.go:171","msg":"trace[1194412719] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:521; }","duration":"256.871891ms","start":"2026-03-20T05:34:57.87841Z","end":"2026-03-20T05:34:58.135282Z","steps":["trace[1194412719] 'read index received'  (duration: 73.4748ms)","trace[1194412719] 'applied index is now lower than readState.Index'  (duration: 183.396001ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:34:58.135377Z","caller":"traceutil/trace.go:171","msg":"trace[1082127276] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"285.02497ms","start":"2026-03-20T05:34:57.850342Z","end":"2026-03-20T05:34:58.135367Z","steps":["trace[1082127276] 'process raft request'  (duration: 101.581308ms)","trace[1082127276] 'compare'  (duration: 182.765939ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:34:58.13561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.176867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"}
{"level":"warn","ts":"2026-03-20T05:34:58.135614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.701963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329948"}
{"level":"info","ts":"2026-03-20T05:34:58.135681Z","caller":"traceutil/trace.go:171","msg":"trace[1076827924] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:509; }","duration":"257.285099ms","start":"2026-03-20T05:34:57.878379Z","end":"2026-03-20T05:34:58.135664Z","steps":["trace[1076827924] 'agreement among raft nodes before linearized reading'  (duration: 257.078385ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:34:58.135694Z","caller":"traceutil/trace.go:171","msg":"trace[1734421431] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:509; }","duration":"235.791674ms","start":"2026-03-20T05:34:57.899883Z","end":"2026-03-20T05:34:58.135675Z","steps":["trace[1734421431] 'agreement among raft nodes before linearized reading'  (duration: 235.493739ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:00.214678Z","caller":"traceutil/trace.go:171","msg":"trace[1442653541] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"184.283667ms","start":"2026-03-20T05:35:00.030368Z","end":"2026-03-20T05:35:00.214652Z","steps":["trace[1442653541] 'process raft request'  (duration: 184.136674ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:08.244737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.249233ms","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-03-20T05:35:08.244795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.689657ms","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-03-20T05:35:08.244816Z","caller":"traceutil/trace.go:171","msg":"trace[1271440147] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:534; }","duration":"700.382904ms","start":"2026-03-20T05:35:07.544414Z","end":"2026-03-20T05:35:08.244797Z","steps":["trace[1271440147] 'range keys from in-memory index tree'  (duration: 700.072239ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:08.244822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.47415ms","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-03-20T05:35:08.24481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.255506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tht5s\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-03-20T05:35:08.244862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:07.544392Z","time spent":"700.461416ms","remote":"127.0.0.1:35042","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-03-20T05:35:08.244858Z","caller":"traceutil/trace.go:171","msg":"trace[331413024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:534; }","duration":"738.552571ms","start":"2026-03-20T05:35:07.506297Z","end":"2026-03-20T05:35:08.244849Z","steps":["trace[331413024] 'range keys from in-memory index tree'  (duration: 738.371388ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:08.244898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:07.506266Z","time spent":"738.625533ms","remote":"127.0.0.1:35042","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-03-20T05:35:08.244902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.979703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T05:35:08.244897Z","caller":"traceutil/trace.go:171","msg":"trace[1123886794] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tht5s; range_end:; response_count:1; response_revision:534; }","duration":"283.408829ms","start":"2026-03-20T05:35:07.961469Z","end":"2026-03-20T05:35:08.244878Z","steps":["trace[1123886794] 'range keys from in-memory index tree'  (duration: 283.084503ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:08.24492Z","caller":"traceutil/trace.go:171","msg":"trace[1734680475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:534; }","duration":"703.034055ms","start":"2026-03-20T05:35:07.541881Z","end":"2026-03-20T05:35:08.244915Z","steps":["trace[1734680475] 'range keys from in-memory index tree'  (duration: 702.887792ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:08.24495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:07.541864Z","time spent":"703.080465ms","remote":"127.0.0.1:35042","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-03-20T05:35:08.244853Z","caller":"traceutil/trace.go:171","msg":"trace[1797506941] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:534; }","duration":"719.797759ms","start":"2026-03-20T05:35:07.52504Z","end":"2026-03-20T05:35:08.244837Z","steps":["trace[1797506941] 'range keys from in-memory index tree'  (duration: 719.529944ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:08.245038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:07.525015Z","time spent":"720.019443ms","remote":"127.0.0.1:35042","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-03-20T05:35:08.88338Z","caller":"traceutil/trace.go:171","msg":"trace[1738902346] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"634.250425ms","start":"2026-03-20T05:35:08.249107Z","end":"2026-03-20T05:35:08.883358Z","steps":["trace[1738902346] 'process raft request'  (duration: 634.125102ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:08.883491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:08.249085Z","time spent":"634.348496ms","remote":"127.0.0.1:35042","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:531 > 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-03-20T05:35:09.699051Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198433734572940,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-20T05:35:09.70152Z","caller":"traceutil/trace.go:171","msg":"trace[799353051] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.452077922s","start":"2026-03-20T05:35:08.249408Z","end":"2026-03-20T05:35:09.701486Z","steps":["trace[799353051] 'process raft request'  (duration: 1.451892409s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:09.701573Z","caller":"traceutil/trace.go:171","msg":"trace[1249405807] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.451684234s","start":"2026-03-20T05:35:08.249878Z","end":"2026-03-20T05:35:09.701563Z","steps":["trace[1249405807] 'process raft request'  (duration: 1.451578352s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:09.701564Z","caller":"traceutil/trace.go:171","msg":"trace[751312817] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.451723926s","start":"2026-03-20T05:35:08.249815Z","end":"2026-03-20T05:35:09.701539Z","steps":["trace[751312817] 'process raft request'  (duration: 1.451607984s)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:09.701585Z","caller":"traceutil/trace.go:171","msg":"trace[1702378924] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:550; }","duration":"503.017711ms","start":"2026-03-20T05:35:09.198547Z","end":"2026-03-20T05:35:09.701564Z","steps":["trace[1702378924] 'read index received'  (duration: 502.695176ms)","trace[1702378924] 'applied index is now lower than readState.Index'  (duration: 321.625µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:35:09.701648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:08.249872Z","time spent":"1.451725885s","remote":"127.0.0.1:35042","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:529 > 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":"warn","ts":"2026-03-20T05:35:09.701667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:08.249777Z","time spent":"1.451840347s","remote":"127.0.0.1:35042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:530 > 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":"warn","ts":"2026-03-20T05:35:09.701678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:08.249399Z","time spent":"1.452193274s","remote":"127.0.0.1:35042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:528 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-20T05:35:09.701728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.161504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:35:09.701762Z","caller":"traceutil/trace.go:171","msg":"trace[796654945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:539; }","duration":"503.239045ms","start":"2026-03-20T05:35:09.198513Z","end":"2026-03-20T05:35:09.701752Z","steps":["trace[796654945] 'agreement among raft nodes before linearized reading'  (duration: 503.129513ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:09.70176Z","caller":"traceutil/trace.go:171","msg":"trace[1691350106] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.444860747s","start":"2026-03-20T05:35:08.256889Z","end":"2026-03-20T05:35:09.70175Z","steps":["trace[1691350106] 'process raft request'  (duration: 1.444610042s)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:09.70183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:09.198496Z","time spent":"503.323567ms","remote":"127.0.0.1:60224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-20T05:35:09.701852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:08.256882Z","time spent":"1.444937268s","remote":"127.0.0.1:34962","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-tht5s\" mod_revision:504 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-tht5s\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-tht5s\" > >"}
{"level":"warn","ts":"2026-03-20T05:35:12.535662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.31952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:35:12.535761Z","caller":"traceutil/trace.go:171","msg":"trace[1109454134] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"337.482533ms","start":"2026-03-20T05:35:12.198256Z","end":"2026-03-20T05:35:12.535738Z","steps":["trace[1109454134] 'range keys from in-memory index tree'  (duration: 337.216977ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:12.535825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:12.198233Z","time spent":"337.582435ms","remote":"127.0.0.1:60224","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-03-20T05:35:28.012194Z","caller":"traceutil/trace.go:171","msg":"trace[52517761] linearizableReadLoop","detail":"{readStateIndex:742; appliedIndex:741; }","duration":"222.315659ms","start":"2026-03-20T05:35:27.789853Z","end":"2026-03-20T05:35:28.012168Z","steps":["trace[52517761] 'read index received'  (duration: 221.938891ms)","trace[52517761] 'applied index is now lower than readState.Index'  (duration: 375.728µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:35:28.01234Z","caller":"traceutil/trace.go:171","msg":"trace[1812101349] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"224.853725ms","start":"2026-03-20T05:35:27.787449Z","end":"2026-03-20T05:35:28.012303Z","steps":["trace[1812101349] 'process raft request'  (duration: 224.493997ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:28.012474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.585615ms","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-03-20T05:35:28.012496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.470679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T05:35:28.012541Z","caller":"traceutil/trace.go:171","msg":"trace[1956717040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:721; }","duration":"222.753178ms","start":"2026-03-20T05:35:27.789773Z","end":"2026-03-20T05:35:28.012526Z","steps":["trace[1956717040] 'agreement among raft nodes before linearized reading'  (duration: 222.551153ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:28.012561Z","caller":"traceutil/trace.go:171","msg":"trace[851882759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:721; }","duration":"207.54504ms","start":"2026-03-20T05:35:27.804997Z","end":"2026-03-20T05:35:28.012542Z","steps":["trace[851882759] 'agreement among raft nodes before linearized reading'  (duration: 207.366056ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:28.657754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.973652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:35:28.657877Z","caller":"traceutil/trace.go:171","msg":"trace[126590395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:723; }","duration":"456.148865ms","start":"2026-03-20T05:35:28.201708Z","end":"2026-03-20T05:35:28.657857Z","steps":["trace[126590395] 'range keys from in-memory index tree'  (duration: 455.898039ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:28.657914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:28.201696Z","time spent":"456.209767ms","remote":"127.0.0.1:60224","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-03-20T05:35:50.978318Z","caller":"traceutil/trace.go:171","msg":"trace[1102256506] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"172.652061ms","start":"2026-03-20T05:35:50.805621Z","end":"2026-03-20T05:35:50.978273Z","steps":["trace[1102256506] 'process raft request'  (duration: 172.364095ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:56.414715Z","caller":"traceutil/trace.go:171","msg":"trace[1210708378] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"239.076483ms","start":"2026-03-20T05:35:56.175621Z","end":"2026-03-20T05:35:56.414697Z","steps":["trace[1210708378] 'read index received'  (duration: 238.92943ms)","trace[1210708378] 'applied index is now lower than readState.Index'  (duration: 146.423µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:35:56.414763Z","caller":"traceutil/trace.go:171","msg":"trace[815209262] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"303.913089ms","start":"2026-03-20T05:35:56.110823Z","end":"2026-03-20T05:35:56.414736Z","steps":["trace[815209262] 'process raft request'  (duration: 303.742635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:56.414903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:56.110804Z","time spent":"304.01405ms","remote":"127.0.0.1:35042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:777 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-20T05:35:56.415052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.387519ms","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-03-20T05:35:56.415162Z","caller":"traceutil/trace.go:171","msg":"trace[1233290199] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:805; }","duration":"239.561933ms","start":"2026-03-20T05:35:56.175575Z","end":"2026-03-20T05:35:56.415137Z","steps":["trace[1233290199] 'agreement among raft nodes before linearized reading'  (duration: 239.203525ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:56.796086Z","caller":"traceutil/trace.go:171","msg":"trace[1697808629] transaction","detail":"{read_only:false; response_revision:806; number_of_response:1; }","duration":"377.753764ms","start":"2026-03-20T05:35:56.418307Z","end":"2026-03-20T05:35:56.796061Z","steps":["trace[1697808629] 'process raft request'  (duration: 377.624941ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:56.796133Z","caller":"traceutil/trace.go:171","msg":"trace[1871793746] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"381.319612ms","start":"2026-03-20T05:35:56.414769Z","end":"2026-03-20T05:35:56.796088Z","steps":["trace[1871793746] 'read index received'  (duration: 299.718376ms)","trace[1871793746] 'applied index is now lower than readState.Index'  (duration: 81.596676ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:35:56.79626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:56.418285Z","time spent":"377.879486ms","remote":"127.0.0.1:35042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:800 > 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-03-20T05:35:56.796365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.94688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-20T05:35:56.796472Z","caller":"traceutil/trace.go:171","msg":"trace[329070713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:806; }","duration":"604.030202ms","start":"2026-03-20T05:35:56.192371Z","end":"2026-03-20T05:35:56.796401Z","steps":["trace[329070713] 'agreement among raft nodes before linearized reading'  (duration: 603.831168ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:56.796521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:56.192363Z","time spent":"604.148474ms","remote":"127.0.0.1:35042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-20T05:35:56.796737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.117764ms","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-03-20T05:35:56.796875Z","caller":"traceutil/trace.go:171","msg":"trace[593655908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:806; }","duration":"604.313758ms","start":"2026-03-20T05:35:56.192529Z","end":"2026-03-20T05:35:56.796843Z","steps":["trace[593655908] 'agreement among raft nodes before linearized reading'  (duration: 603.856879ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:56.796937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:56.192514Z","time spent":"604.411601ms","remote":"127.0.0.1:35042","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-03-20T05:35:58.976818Z","caller":"traceutil/trace.go:171","msg":"trace[1101111518] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"104.634507ms","start":"2026-03-20T05:35:58.872159Z","end":"2026-03-20T05:35:58.976793Z","steps":["trace[1101111518] 'read index received'  (duration: 104.424703ms)","trace[1101111518] 'applied index is now lower than readState.Index'  (duration: 208.774µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:35:58.977157Z","caller":"traceutil/trace.go:171","msg":"trace[1935449005] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"172.453688ms","start":"2026-03-20T05:35:58.804674Z","end":"2026-03-20T05:35:58.977127Z","steps":["trace[1935449005] 'process raft request'  (duration: 171.986368ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:58.977266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.091498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-20T05:35:58.977339Z","caller":"traceutil/trace.go:171","msg":"trace[623573945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"105.232011ms","start":"2026-03-20T05:35:58.872089Z","end":"2026-03-20T05:35:58.977322Z","steps":["trace[623573945] 'agreement among raft nodes before linearized reading'  (duration: 104.991195ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:35:59.260966Z","caller":"traceutil/trace.go:171","msg":"trace[1717580805] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"278.68277ms","start":"2026-03-20T05:35:58.982254Z","end":"2026-03-20T05:35:59.260936Z","steps":["trace[1717580805] 'process raft request'  (duration: 213.67437ms)","trace[1717580805] 'compare'  (duration: 64.893637ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:35:59.262766Z","caller":"traceutil/trace.go:171","msg":"trace[481220162] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:838; }","duration":"147.421174ms","start":"2026-03-20T05:35:59.115321Z","end":"2026-03-20T05:35:59.262743Z","steps":["trace[481220162] 'read index received'  (duration: 80.617565ms)","trace[481220162] 'applied index is now lower than readState.Index'  (duration: 66.802549ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:35:59.262875Z","caller":"traceutil/trace.go:171","msg":"trace[351410228] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"280.101671ms","start":"2026-03-20T05:35:58.982735Z","end":"2026-03-20T05:35:59.262837Z","steps":["trace[351410228] 'process raft request'  (duration: 279.869966ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:35:59.263059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.724791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-03-20T05:35:59.263101Z","caller":"traceutil/trace.go:171","msg":"trace[1576976993] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:813; }","duration":"147.820873ms","start":"2026-03-20T05:35:59.115268Z","end":"2026-03-20T05:35:59.263089Z","steps":["trace[1576976993] 'agreement among raft nodes before linearized reading'  (duration: 147.604798ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:29.526935Z","caller":"traceutil/trace.go:171","msg":"trace[1030037565] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:995; }","duration":"129.941306ms","start":"2026-03-20T05:36:29.396965Z","end":"2026-03-20T05:36:29.526906Z","steps":["trace[1030037565] 'read index received'  (duration: 129.922296ms)","trace[1030037565] 'applied index is now lower than readState.Index'  (duration: 18.09µs)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:36:29.527019Z","caller":"traceutil/trace.go:171","msg":"trace[277037033] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"130.96371ms","start":"2026-03-20T05:36:29.396029Z","end":"2026-03-20T05:36:29.526993Z","steps":["trace[277037033] 'process raft request'  (duration: 130.751635ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:29.527213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.223092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-03-20T05:36:29.527426Z","caller":"traceutil/trace.go:171","msg":"trace[744677644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:961; }","duration":"130.473188ms","start":"2026-03-20T05:36:29.396941Z","end":"2026-03-20T05:36:29.527414Z","steps":["trace[744677644] 'agreement among raft nodes before linearized reading'  (duration: 130.132891ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:29.527962Z","caller":"traceutil/trace.go:171","msg":"trace[2030238203] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"129.145919ms","start":"2026-03-20T05:36:29.398803Z","end":"2026-03-20T05:36:29.527949Z","steps":["trace[2030238203] 'process raft request'  (duration: 128.935484ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:29.528019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.840936ms","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-03-20T05:36:29.528099Z","caller":"traceutil/trace.go:171","msg":"trace[1332688479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:962; }","duration":"130.950169ms","start":"2026-03-20T05:36:29.397129Z","end":"2026-03-20T05:36:29.528079Z","steps":["trace[1332688479] 'agreement among raft nodes before linearized reading'  (duration: 130.725384ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:38.899666Z","caller":"traceutil/trace.go:171","msg":"trace[1541727167] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1080; }","duration":"176.755783ms","start":"2026-03-20T05:36:38.722887Z","end":"2026-03-20T05:36:38.899643Z","steps":["trace[1541727167] 'read index received'  (duration: 176.542858ms)","trace[1541727167] 'applied index is now lower than readState.Index'  (duration: 212.125µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:38.899848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.947648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"}
{"level":"info","ts":"2026-03-20T05:36:38.899842Z","caller":"traceutil/trace.go:171","msg":"trace[1331040862] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"181.417486ms","start":"2026-03-20T05:36:38.718396Z","end":"2026-03-20T05:36:38.899814Z","steps":["trace[1331040862] 'process raft request'  (duration: 181.082339ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:38.899894Z","caller":"traceutil/trace.go:171","msg":"trace[1125161942] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1044; }","duration":"177.04574ms","start":"2026-03-20T05:36:38.722835Z","end":"2026-03-20T05:36:38.899881Z","steps":["trace[1125161942] 'agreement among raft nodes before linearized reading'  (duration: 176.898837ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:39.382362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.89952ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198433734574058 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1018 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:36:39.382503Z","caller":"traceutil/trace.go:171","msg":"trace[729378585] linearizableReadLoop","detail":"{readStateIndex:1082; appliedIndex:1081; }","duration":"184.182378ms","start":"2026-03-20T05:36:39.198304Z","end":"2026-03-20T05:36:39.382486Z","steps":["trace[729378585] 'read index received'  (duration: 26.831µs)","trace[729378585] 'applied index is now lower than readState.Index'  (duration: 184.154167ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:39.382685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.375472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:36:39.38275Z","caller":"traceutil/trace.go:171","msg":"trace[1606794786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1045; }","duration":"184.464445ms","start":"2026-03-20T05:36:39.198265Z","end":"2026-03-20T05:36:39.38273Z","steps":["trace[1606794786] 'agreement among raft nodes before linearized reading'  (duration: 184.341502ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:39.382813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.811829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-03-20T05:36:39.38289Z","caller":"traceutil/trace.go:171","msg":"trace[675380807] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1045; }","duration":"141.899081ms","start":"2026-03-20T05:36:39.240945Z","end":"2026-03-20T05:36:39.382844Z","steps":["trace[675380807] 'agreement among raft nodes before linearized reading'  (duration: 141.752328ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:39.383154Z","caller":"traceutil/trace.go:171","msg":"trace[933119012] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"478.780099ms","start":"2026-03-20T05:36:38.904354Z","end":"2026-03-20T05:36:39.383134Z","steps":["trace[933119012] 'process raft request'  (duration: 276.022631ms)","trace[933119012] 'compare'  (duration: 201.788657ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:39.383251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:38.904329Z","time spent":"478.869331ms","remote":"127.0.0.1:35042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" mod_revision:1018 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" value_size:440 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-20T05:36:39.517716Z","caller":"traceutil/trace.go:171","msg":"trace[740331430] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"129.978797ms","start":"2026-03-20T05:36:39.387715Z","end":"2026-03-20T05:36:39.517694Z","steps":["trace[740331430] 'process raft request'  (duration: 107.52539ms)","trace[740331430] 'compare'  (duration: 22.332285ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:41.270244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.615167ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198433734574083 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.244\" mod_revision:971 > success:<request_put:<key:\"/registry/masterleases/199.204.45.244\" value_size:67 lease:9142198433734574081 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.244\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:36:41.270482Z","caller":"traceutil/trace.go:171","msg":"trace[1065124271] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"321.292787ms","start":"2026-03-20T05:36:40.949159Z","end":"2026-03-20T05:36:41.270452Z","steps":["trace[1065124271] 'process raft request'  (duration: 175.380583ms)","trace[1065124271] 'compare'  (duration: 145.228399ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:41.270598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:36:40.949133Z","time spent":"321.418509ms","remote":"127.0.0.1:34838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.244\" mod_revision:971 > success:<request_put:<key:\"/registry/masterleases/199.204.45.244\" value_size:67 lease:9142198433734574081 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.244\" > >"}
{"level":"info","ts":"2026-03-20T05:36:41.733992Z","caller":"traceutil/trace.go:171","msg":"trace[1536802660] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"106.632953ms","start":"2026-03-20T05:36:41.627318Z","end":"2026-03-20T05:36:41.733951Z","steps":["trace[1536802660] 'process raft request'  (duration: 106.266514ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:41.975821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.474029ms","expected-duration":"100ms","prefix":"","request":"header:<ID:9142198433734574103 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1052 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-20T05:36:41.97593Z","caller":"traceutil/trace.go:171","msg":"trace[1568434179] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"237.455099ms","start":"2026-03-20T05:36:41.738449Z","end":"2026-03-20T05:36:41.975904Z","steps":["trace[1568434179] 'process raft request'  (duration: 111.782876ms)","trace[1568434179] 'compare'  (duration: 125.328926ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:36:42.324602Z","caller":"traceutil/trace.go:171","msg":"trace[1135717125] linearizableReadLoop","detail":"{readStateIndex:1100; appliedIndex:1099; }","duration":"121.824928ms","start":"2026-03-20T05:36:42.20275Z","end":"2026-03-20T05:36:42.324575Z","steps":["trace[1135717125] 'read index received'  (duration: 84.224118ms)","trace[1135717125] 'applied index is now lower than readState.Index'  (duration: 37.599649ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:42.324736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.978601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-20T05:36:42.324766Z","caller":"traceutil/trace.go:171","msg":"trace[4137385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1062; }","duration":"122.067253ms","start":"2026-03-20T05:36:42.20269Z","end":"2026-03-20T05:36:42.324757Z","steps":["trace[4137385] 'agreement among raft nodes before linearized reading'  (duration: 121.991252ms)"],"step_count":1}
{"level":"info","ts":"2026-03-20T05:36:42.32481Z","caller":"traceutil/trace.go:171","msg":"trace[47545586] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"266.01005ms","start":"2026-03-20T05:36:42.058769Z","end":"2026-03-20T05:36:42.324779Z","steps":["trace[47545586] 'process raft request'  (duration: 228.272207ms)","trace[47545586] 'compare'  (duration: 37.425705ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:36:43.800764Z","caller":"traceutil/trace.go:171","msg":"trace[1453318311] linearizableReadLoop","detail":"{readStateIndex:1102; appliedIndex:1101; }","duration":"169.143711ms","start":"2026-03-20T05:36:43.631603Z","end":"2026-03-20T05:36:43.800746Z","steps":["trace[1453318311] 'read index received'  (duration: 93.110074ms)","trace[1453318311] 'applied index is now lower than readState.Index'  (duration: 76.032787ms)"],"step_count":2}
{"level":"info","ts":"2026-03-20T05:36:43.800865Z","caller":"traceutil/trace.go:171","msg":"trace[2147205934] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"243.913672ms","start":"2026-03-20T05:36:43.556906Z","end":"2026-03-20T05:36:43.80082Z","steps":["trace[2147205934] 'process raft request'  (duration: 167.925965ms)","trace[2147205934] 'compare'  (duration: 75.828143ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-20T05:36:43.800947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.074208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"}
{"level":"info","ts":"2026-03-20T05:36:43.800977Z","caller":"traceutil/trace.go:171","msg":"trace[1223230329] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1064; }","duration":"168.12823ms","start":"2026-03-20T05:36:43.632839Z","end":"2026-03-20T05:36:43.800967Z","steps":["trace[1223230329] 'agreement among raft nodes before linearized reading'  (duration: 168.006117ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-20T05:36:43.801026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.398358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-03-20T05:36:43.801084Z","caller":"traceutil/trace.go:171","msg":"trace[1393007081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1064; }","duration":"169.492489ms","start":"2026-03-20T05:36:43.631576Z","end":"2026-03-20T05:36:43.801069Z","steps":["trace[1393007081] 'agreement among raft nodes before linearized reading'  (duration: 169.246334ms)"],"step_count":1}