{"level":"warn","ts":"2026-03-04T01:22:07.282372Z","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-04T01:22:07.28247Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-04T01:22:07.282536Z","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-04T01:22:07.282551Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]}
{"level":"info","ts":"2026-03-04T01:22:07.282569Z","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-04T01:22:07.283303Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]}
{"level":"info","ts":"2026-03-04T01:22:07.2834Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-04T01:22:07.28753Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.914627ms"}
{"level":"info","ts":"2026-03-04T01:22:07.293789Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"}
{"level":"info","ts":"2026-03-04T01:22:07.293865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"}
{"level":"info","ts":"2026-03-04T01:22:07.293892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"}
{"level":"info","ts":"2026-03-04T01:22:07.293907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-04T01:22:07.293921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"}
{"level":"info","ts":"2026-03-04T01:22:07.293956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"}
{"level":"warn","ts":"2026-03-04T01:22:07.303129Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-04T01:22:07.304747Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-04T01:22:07.308455Z","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-04T01:22:07.315112Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-04T01:22:07.315911Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-04T01:22:07.316039Z","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-04T01:22:07.316086Z","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-04T01:22:07.316097Z","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-04T01:22:07.316347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"}
{"level":"info","ts":"2026-03-04T01:22:07.316446Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]}
{"level":"info","ts":"2026-03-04T01:22:07.319407Z","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-04T01:22:07.319981Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"}
{"level":"info","ts":"2026-03-04T01:22:07.320336Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-04T01:22:07.320416Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-04T01:22:07.320082Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"}
{"level":"info","ts":"2026-03-04T01:22:07.794623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"}
{"level":"info","ts":"2026-03-04T01:22:07.794739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-04T01:22:07.794792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"}
{"level":"info","ts":"2026-03-04T01:22:07.79484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"}
{"level":"info","ts":"2026-03-04T01:22:07.794868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"}
{"level":"info","ts":"2026-03-04T01:22:07.794897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"}
{"level":"info","ts":"2026-03-04T01:22:07.794915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"}
{"level":"info","ts":"2026-03-04T01:22:07.8287Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-04T01:22:07.829735Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-04T01:22:07.829743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-04T01:22:07.829907Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-04T01:22:07.830055Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-04T01:22:07.830216Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-04T01:22:07.830275Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-04T01:22:07.830402Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-04T01:22:07.830429Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-04T01:22:07.834669Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"}
{"level":"info","ts":"2026-03-04T01:22:07.834714Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-04T01:22:19.049216Z","caller":"traceutil/trace.go:171","msg":"trace[450152761] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"207.964594ms","start":"2026-03-04T01:22:18.841222Z","end":"2026-03-04T01:22:19.049186Z","steps":["trace[450152761] 'process raft request'  (duration: 207.76299ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:22:25.700261Z","caller":"traceutil/trace.go:171","msg":"trace[1970031312] linearizableReadLoop","detail":"{readStateIndex:432; appliedIndex:431; }","duration":"463.787053ms","start":"2026-03-04T01:22:25.236445Z","end":"2026-03-04T01:22:25.700232Z","steps":["trace[1970031312] 'read index received'  (duration: 463.6294ms)","trace[1970031312] 'applied index is now lower than readState.Index'  (duration: 156.243µs)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:22:25.700331Z","caller":"traceutil/trace.go:171","msg":"trace[321305205] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"510.674026ms","start":"2026-03-04T01:22:25.189621Z","end":"2026-03-04T01:22:25.700295Z","steps":["trace[321305205] 'process raft request'  (duration: 510.42767ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:25.700543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.516092ms","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-04T01:22:25.700549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.059899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-04T01:22:25.700619Z","caller":"traceutil/trace.go:171","msg":"trace[29374518] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:422; }","duration":"322.708707ms","start":"2026-03-04T01:22:25.377897Z","end":"2026-03-04T01:22:25.700605Z","steps":["trace[29374518] 'agreement among raft nodes before linearized reading'  (duration: 322.500812ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:22:25.700661Z","caller":"traceutil/trace.go:171","msg":"trace[146225156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:422; }","duration":"464.228812ms","start":"2026-03-04T01:22:25.236407Z","end":"2026-03-04T01:22:25.700636Z","steps":["trace[146225156] 'agreement among raft nodes before linearized reading'  (duration: 463.986227ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:25.700671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:25.377874Z","time spent":"322.787098ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-04T01:22:25.700544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.476849ms","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-04T01:22:25.700732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:25.23639Z","time spent":"464.332385ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-04T01:22:25.700768Z","caller":"traceutil/trace.go:171","msg":"trace[1168901970] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:422; }","duration":"183.754416ms","start":"2026-03-04T01:22:25.516992Z","end":"2026-03-04T01:22:25.700746Z","steps":["trace[1168901970] 'agreement among raft nodes before linearized reading'  (duration: 183.453779ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:25.701131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:25.189589Z","time spent":"510.83095ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-04T01:22:26.538963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.47428ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746630563 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:417 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:22:26.539196Z","caller":"traceutil/trace.go:171","msg":"trace[1092080375] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"833.825213ms","start":"2026-03-04T01:22:25.705331Z","end":"2026-03-04T01:22:26.539156Z","steps":["trace[1092080375] 'process raft request'  (duration: 46.940814ms)","trace[1092080375] 'compare'  (duration: 786.339827ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:22:26.539362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:25.705314Z","time spent":"833.951746ms","remote":"127.0.0.1:42362","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:417 > 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-03-04T01:22:26.539588Z","caller":"traceutil/trace.go:171","msg":"trace[1623494682] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"834.14759ms","start":"2026-03-04T01:22:25.705429Z","end":"2026-03-04T01:22:26.539577Z","steps":["trace[1623494682] 'process raft request'  (duration: 833.67879ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:26.539657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:25.705397Z","time spent":"834.231942ms","remote":"127.0.0.1:42362","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:418 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-04T01:22:26.539749Z","caller":"traceutil/trace.go:171","msg":"trace[1447196501] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:432; }","duration":"792.745819ms","start":"2026-03-04T01:22:25.746987Z","end":"2026-03-04T01:22:26.539733Z","steps":["trace[1447196501] 'read index received'  (duration: 5.296608ms)","trace[1447196501] 'applied index is now lower than readState.Index'  (duration: 787.447981ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:22:26.539838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.858401ms","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-04T01:22:26.539874Z","caller":"traceutil/trace.go:171","msg":"trace[368514053] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:425; }","duration":"792.935863ms","start":"2026-03-04T01:22:25.746929Z","end":"2026-03-04T01:22:26.539865Z","steps":["trace[368514053] 'agreement among raft nodes before linearized reading'  (duration: 792.853772ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:26.539907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:25.746905Z","time spent":"792.994574ms","remote":"127.0.0.1:42530","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-04T01:22:26.539958Z","caller":"traceutil/trace.go:171","msg":"trace[446603462] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"834.252042ms","start":"2026-03-04T01:22:25.705692Z","end":"2026-03-04T01:22:26.539944Z","steps":["trace[446603462] 'process raft request'  (duration: 833.512926ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:26.540027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:25.70567Z","time spent":"834.320774ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:416 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-03-04T01:22:41.186913Z","caller":"traceutil/trace.go:171","msg":"trace[1783568357] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"569.280969ms","start":"2026-03-04T01:22:40.617608Z","end":"2026-03-04T01:22:41.186889Z","steps":["trace[1783568357] 'process raft request'  (duration: 569.134256ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:41.187111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:40.617592Z","time spent":"569.410153ms","remote":"127.0.0.1:42362","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:479 > 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-03-04T01:22:41.427121Z","caller":"traceutil/trace.go:171","msg":"trace[374006038] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"807.901046ms","start":"2026-03-04T01:22:40.619193Z","end":"2026-03-04T01:22:41.427094Z","steps":["trace[374006038] 'process raft request'  (duration: 790.98534ms)","trace[374006038] 'compare'  (duration: 16.376214ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:22:41.427275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:40.619172Z","time spent":"808.026238ms","remote":"127.0.0.1:42362","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:480 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-04T01:22:41.42779Z","caller":"traceutil/trace.go:171","msg":"trace[377077746] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:533; }","duration":"430.83482ms","start":"2026-03-04T01:22:40.996911Z","end":"2026-03-04T01:22:41.427745Z","steps":["trace[377077746] 'read index received'  (duration: 189.834491ms)","trace[377077746] 'applied index is now lower than readState.Index'  (duration: 240.998059ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:22:41.427978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.063146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:22:41.428071Z","caller":"traceutil/trace.go:171","msg":"trace[1693878190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:521; }","duration":"431.190938ms","start":"2026-03-04T01:22:40.996854Z","end":"2026-03-04T01:22:41.428045Z","steps":["trace[1693878190] 'agreement among raft nodes before linearized reading'  (duration: 431.080576ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:41.428113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:40.996826Z","time spent":"431.276281ms","remote":"127.0.0.1:42080","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-04T01:22:41.428117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.936873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-03-04T01:22:41.427872Z","caller":"traceutil/trace.go:171","msg":"trace[1154015744] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"806.470994ms","start":"2026-03-04T01:22:40.621356Z","end":"2026-03-04T01:22:41.427827Z","steps":["trace[1154015744] 'process raft request'  (duration: 805.667646ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:22:41.42817Z","caller":"traceutil/trace.go:171","msg":"trace[398963921] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:521; }","duration":"413.023605ms","start":"2026-03-04T01:22:41.015129Z","end":"2026-03-04T01:22:41.428152Z","steps":["trace[398963921] 'agreement among raft nodes before linearized reading'  (duration: 412.848591ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:41.428228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:41.015044Z","time spent":"413.163798ms","remote":"127.0.0.1:42122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.72\" "}
{"level":"warn","ts":"2026-03-04T01:22:41.428294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:40.621347Z","time spent":"806.835522ms","remote":"127.0.0.1:42362","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:481 > 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":"info","ts":"2026-03-04T01:22:47.612189Z","caller":"traceutil/trace.go:171","msg":"trace[1112594507] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"154.628239ms","start":"2026-03-04T01:22:47.457514Z","end":"2026-03-04T01:22:47.612142Z","steps":["trace[1112594507] 'process raft request'  (duration: 154.398844ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:48.061956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.642923ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746630802 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:532 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:22:48.062089Z","caller":"traceutil/trace.go:171","msg":"trace[847362583] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:555; }","duration":"233.678127ms","start":"2026-03-04T01:22:47.828389Z","end":"2026-03-04T01:22:48.062067Z","steps":["trace[847362583] 'read index received'  (duration: 9.831029ms)","trace[847362583] 'applied index is now lower than readState.Index'  (duration: 223.845328ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:22:48.062441Z","caller":"traceutil/trace.go:171","msg":"trace[1274626423] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"602.57387ms","start":"2026-03-04T01:22:47.459852Z","end":"2026-03-04T01:22:48.062426Z","steps":["trace[1274626423] 'process raft request'  (duration: 378.350934ms)","trace[1274626423] 'compare'  (duration: 223.49411ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:22:48.062524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:47.459812Z","time spent":"602.657722ms","remote":"127.0.0.1:42362","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:532 > 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-03-04T01:22:48.062871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.516426ms","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-04T01:22:48.062835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.316098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jl94n\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-03-04T01:22:48.062904Z","caller":"traceutil/trace.go:171","msg":"trace[157838527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:539; }","duration":"234.590337ms","start":"2026-03-04T01:22:47.828302Z","end":"2026-03-04T01:22:48.062893Z","steps":["trace[157838527] 'agreement among raft nodes before linearized reading'  (duration: 234.520316ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:22:48.062946Z","caller":"traceutil/trace.go:171","msg":"trace[1218705070] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jl94n; range_end:; response_count:1; response_revision:539; }","duration":"157.478572ms","start":"2026-03-04T01:22:47.905439Z","end":"2026-03-04T01:22:48.062917Z","steps":["trace[1218705070] 'agreement among raft nodes before linearized reading'  (duration: 157.217306ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:22:48.838526Z","caller":"traceutil/trace.go:171","msg":"trace[1977024652] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"770.496024ms","start":"2026-03-04T01:22:48.067995Z","end":"2026-03-04T01:22:48.838491Z","steps":["trace[1977024652] 'process raft request'  (duration: 770.290259ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:48.838819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:48.067972Z","time spent":"770.74191ms","remote":"127.0.0.1:42362","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:533 > 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":"info","ts":"2026-03-04T01:22:48.924324Z","caller":"traceutil/trace.go:171","msg":"trace[208354292] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"846.820211ms","start":"2026-03-04T01:22:48.077476Z","end":"2026-03-04T01:22:48.924297Z","steps":["trace[208354292] 'process raft request'  (duration: 846.550045ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:48.924615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:48.077458Z","time spent":"847.050537ms","remote":"127.0.0.1:42292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-jl94n\" mod_revision:511 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-jl94n\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-jl94n\" > >"}
{"level":"warn","ts":"2026-03-04T01:22:49.526693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.610114ms","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-04T01:22:49.526792Z","caller":"traceutil/trace.go:171","msg":"trace[1112671530] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:541; }","duration":"304.757987ms","start":"2026-03-04T01:22:49.222015Z","end":"2026-03-04T01:22:49.526773Z","steps":["trace[1112671530] 'range keys from in-memory index tree'  (duration: 304.51106ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:49.526836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:49.221993Z","time spent":"304.834449ms","remote":"127.0.0.1:42362","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-03-04T01:22:49.943518Z","caller":"traceutil/trace.go:171","msg":"trace[972220241] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:558; }","duration":"326.114802ms","start":"2026-03-04T01:22:49.617368Z","end":"2026-03-04T01:22:49.943483Z","steps":["trace[972220241] 'read index received'  (duration: 325.765664ms)","trace[972220241] 'applied index is now lower than readState.Index'  (duration: 348.038µs)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:22:49.943583Z","caller":"traceutil/trace.go:171","msg":"trace[1281838698] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"411.740406ms","start":"2026-03-04T01:22:49.531814Z","end":"2026-03-04T01:22:49.943555Z","steps":["trace[1281838698] 'process raft request'  (duration: 411.44342ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:49.94372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.327256ms","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-04T01:22:49.943773Z","caller":"traceutil/trace.go:171","msg":"trace[902967042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:542; }","duration":"326.405898ms","start":"2026-03-04T01:22:49.61735Z","end":"2026-03-04T01:22:49.943756Z","steps":["trace[902967042] 'agreement among raft nodes before linearized reading'  (duration: 326.287115ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:49.943809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:49.61727Z","time spent":"326.53021ms","remote":"127.0.0.1:42362","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-04T01:22:49.943823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:49.531785Z","time spent":"411.87925ms","remote":"127.0.0.1:42362","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:535 > 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-04T01:22:50.603457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.192276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:22:50.603559Z","caller":"traceutil/trace.go:171","msg":"trace[947708124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:543; }","duration":"573.3338ms","start":"2026-03-04T01:22:50.030202Z","end":"2026-03-04T01:22:50.603536Z","steps":["trace[947708124] 'range keys from in-memory index tree'  (duration: 573.136325ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:50.603603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:50.030191Z","time spent":"573.403091ms","remote":"127.0.0.1:42090","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-04T01:22:50.603456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.309384ms","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-04T01:22:50.60374Z","caller":"traceutil/trace.go:171","msg":"trace[131718313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:543; }","duration":"535.595161ms","start":"2026-03-04T01:22:50.068102Z","end":"2026-03-04T01:22:50.603697Z","steps":["trace[131718313] 'range keys from in-memory index tree'  (duration: 535.197642ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:50.603786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:50.068097Z","time spent":"535.678972ms","remote":"127.0.0.1:42362","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-04T01:22:52.164085Z","caller":"traceutil/trace.go:171","msg":"trace[1568386827] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"214.94915ms","start":"2026-03-04T01:22:51.949109Z","end":"2026-03-04T01:22:52.164058Z","steps":["trace[1568386827] 'read index received'  (duration: 214.144552ms)","trace[1568386827] 'applied index is now lower than readState.Index'  (duration: 803.468µs)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:22:52.164204Z","caller":"traceutil/trace.go:171","msg":"trace[2040780915] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"227.748065ms","start":"2026-03-04T01:22:51.936429Z","end":"2026-03-04T01:22:52.164177Z","steps":["trace[2040780915] 'process raft request'  (duration: 226.736752ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:52.164459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.318179ms","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-04T01:22:52.164536Z","caller":"traceutil/trace.go:171","msg":"trace[429713462] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:553; }","duration":"215.469352ms","start":"2026-03-04T01:22:51.949036Z","end":"2026-03-04T01:22:52.164506Z","steps":["trace[429713462] 'agreement among raft nodes before linearized reading'  (duration: 215.237317ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:52.165057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.092664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:22:52.165097Z","caller":"traceutil/trace.go:171","msg":"trace[91797293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"166.169475ms","start":"2026-03-04T01:22:51.998918Z","end":"2026-03-04T01:22:52.165088Z","steps":["trace[91797293] 'agreement among raft nodes before linearized reading'  (duration: 166.109153ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:22:52.165256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.338203ms","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-04T01:22:52.166213Z","caller":"traceutil/trace.go:171","msg":"trace[118864759] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"133.330046ms","start":"2026-03-04T01:22:52.032866Z","end":"2026-03-04T01:22:52.166196Z","steps":["trace[118864759] 'agreement among raft nodes before linearized reading'  (duration: 132.20089ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:22:53.532896Z","caller":"traceutil/trace.go:171","msg":"trace[1958907927] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"413.2524ms","start":"2026-03-04T01:22:53.119588Z","end":"2026-03-04T01:22:53.532841Z","steps":["trace[1958907927] 'process raft request'  (duration: 357.279825ms)","trace[1958907927] 'compare'  (duration: 55.405432ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:22:53.533556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:22:53.119569Z","time spent":"413.908874ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<>"}
{"level":"info","ts":"2026-03-04T01:23:09.897332Z","caller":"traceutil/trace.go:171","msg":"trace[471963275] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"267.409288ms","start":"2026-03-04T01:23:09.629901Z","end":"2026-03-04T01:23:09.89731Z","steps":["trace[471963275] 'process raft request'  (duration: 267.282435ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:10.336374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.717294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-04T01:23:10.336487Z","caller":"traceutil/trace.go:171","msg":"trace[673280959] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:730; }","duration":"356.898687ms","start":"2026-03-04T01:23:09.979565Z","end":"2026-03-04T01:23:10.336463Z","steps":["trace[673280959] 'count revisions from in-memory index tree'  (duration: 356.602421ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:10.336385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.244315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-04T01:23:10.336539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:09.979544Z","time spent":"356.98379ms","remote":"127.0.0.1:42508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"info","ts":"2026-03-04T01:23:10.336634Z","caller":"traceutil/trace.go:171","msg":"trace[1643106359] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:730; }","duration":"368.517771ms","start":"2026-03-04T01:23:09.968063Z","end":"2026-03-04T01:23:10.336581Z","steps":["trace[1643106359] 'count revisions from in-memory index tree'  (duration: 368.160894ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:10.336797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:09.968042Z","time spent":"368.701836ms","remote":"127.0.0.1:42172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":100,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-03-04T01:23:11.261941Z","caller":"traceutil/trace.go:171","msg":"trace[271574744] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:752; }","duration":"843.561686ms","start":"2026-03-04T01:23:10.418347Z","end":"2026-03-04T01:23:11.261909Z","steps":["trace[271574744] 'read index received'  (duration: 6.070347ms)","trace[271574744] 'applied index is now lower than readState.Index'  (duration: 837.490249ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:23:11.262147Z","caller":"traceutil/trace.go:171","msg":"trace[167199380] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"921.381733ms","start":"2026-03-04T01:23:10.340755Z","end":"2026-03-04T01:23:11.262137Z","steps":["trace[167199380] 'process raft request'  (duration: 896.980183ms)","trace[167199380] 'compare'  (duration: 23.844718ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:23:11.262232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:10.340735Z","time spent":"921.433475ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:727 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-04T01:23:11.262389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.040367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:23:11.262416Z","caller":"traceutil/trace.go:171","msg":"trace[2094130266] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:732; }","duration":"844.065387ms","start":"2026-03-04T01:23:10.418339Z","end":"2026-03-04T01:23:11.262404Z","steps":["trace[2094130266] 'agreement among raft nodes before linearized reading'  (duration: 844.024517ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:11.262436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:10.418259Z","time spent":"844.17278ms","remote":"127.0.0.1:42230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "}
{"level":"warn","ts":"2026-03-04T01:23:11.306045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.670201ms","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-04T01:23:11.306152Z","caller":"traceutil/trace.go:171","msg":"trace[2111875774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:733; }","duration":"561.835145ms","start":"2026-03-04T01:23:10.744291Z","end":"2026-03-04T01:23:11.306126Z","steps":["trace[2111875774] 'agreement among raft nodes before linearized reading'  (duration: 561.469287ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:11.306206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:10.744271Z","time spent":"561.923816ms","remote":"127.0.0.1:42362","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":"warn","ts":"2026-03-04T01:23:11.306202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.513306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-03-04T01:23:11.306292Z","caller":"traceutil/trace.go:171","msg":"trace[717839581] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:733; }","duration":"289.644999ms","start":"2026-03-04T01:23:11.016625Z","end":"2026-03-04T01:23:11.30627Z","steps":["trace[717839581] 'agreement among raft nodes before linearized reading'  (duration: 289.400274ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:23:11.306418Z","caller":"traceutil/trace.go:171","msg":"trace[1457363557] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"484.760265ms","start":"2026-03-04T01:23:10.821637Z","end":"2026-03-04T01:23:11.306397Z","steps":["trace[1457363557] 'process raft request'  (duration: 483.920406ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:11.306457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.18757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:23:11.306499Z","caller":"traceutil/trace.go:171","msg":"trace[807722931] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:733; }","duration":"309.263432ms","start":"2026-03-04T01:23:10.997224Z","end":"2026-03-04T01:23:11.306487Z","steps":["trace[807722931] 'agreement among raft nodes before linearized reading'  (duration: 309.19725ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:11.306526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:10.997207Z","time spent":"309.313413ms","remote":"127.0.0.1:42080","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-04T01:23:11.306533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:10.821622Z","time spent":"484.829547ms","remote":"127.0.0.1:42362","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:661 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-04T01:23:11.306672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.023286ms","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-04T01:23:11.3067Z","caller":"traceutil/trace.go:171","msg":"trace[384661280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:733; }","duration":"363.092297ms","start":"2026-03-04T01:23:10.943601Z","end":"2026-03-04T01:23:11.306693Z","steps":["trace[384661280] 'agreement among raft nodes before linearized reading'  (duration: 363.003345ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:11.306721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:10.94357Z","time spent":"363.145799ms","remote":"127.0.0.1:42362","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-04T01:23:12.415773Z","caller":"traceutil/trace.go:171","msg":"trace[1530313309] linearizableReadLoop","detail":"{readStateIndex:760; appliedIndex:759; }","duration":"131.050529ms","start":"2026-03-04T01:23:12.284702Z","end":"2026-03-04T01:23:12.415752Z","steps":["trace[1530313309] 'read index received'  (duration: 130.859654ms)","trace[1530313309] 'applied index is now lower than readState.Index'  (duration: 190.275µs)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:23:12.415921Z","caller":"traceutil/trace.go:171","msg":"trace[494172100] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"503.579021ms","start":"2026-03-04T01:23:11.912309Z","end":"2026-03-04T01:23:12.415888Z","steps":["trace[494172100] 'process raft request'  (duration: 503.311315ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:12.415977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.249023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-04T01:23:12.416013Z","caller":"traceutil/trace.go:171","msg":"trace[1494738261] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:737; }","duration":"131.337845ms","start":"2026-03-04T01:23:12.284663Z","end":"2026-03-04T01:23:12.416001Z","steps":["trace[1494738261] 'agreement among raft nodes before linearized reading'  (duration: 131.174211ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:12.416146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:11.912281Z","time spent":"503.719973ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:730 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-04T01:23:12.555783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.83134ms","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-04T01:23:12.555872Z","caller":"traceutil/trace.go:171","msg":"trace[560741516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:737; }","duration":"121.956703ms","start":"2026-03-04T01:23:12.433894Z","end":"2026-03-04T01:23:12.555851Z","steps":["trace[560741516] 'range keys from in-memory index tree'  (duration: 121.655057ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:37.10333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.298289ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746631400 > lease_revoke:<id:4bba9cb6701f446f>","response":"size:27"}
{"level":"info","ts":"2026-03-04T01:23:37.103446Z","caller":"traceutil/trace.go:171","msg":"trace[2111387763] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"546.07969ms","start":"2026-03-04T01:23:36.557347Z","end":"2026-03-04T01:23:37.103427Z","steps":["trace[2111387763] 'read index received'  (duration: 33.211µs)","trace[2111387763] 'applied index is now lower than readState.Index'  (duration: 546.044989ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:23:37.10367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.310485ms","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-03-04T01:23:37.103711Z","caller":"traceutil/trace.go:171","msg":"trace[1065342636] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:809; }","duration":"546.393037ms","start":"2026-03-04T01:23:36.557308Z","end":"2026-03-04T01:23:37.103701Z","steps":["trace[1065342636] 'agreement among raft nodes before linearized reading'  (duration: 546.232603ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:37.10375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:36.557288Z","time spent":"546.453358ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-04T01:23:37.103746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.223339ms","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-04T01:23:37.103847Z","caller":"traceutil/trace.go:171","msg":"trace[2130450180] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"382.368563ms","start":"2026-03-04T01:23:36.721457Z","end":"2026-03-04T01:23:37.103825Z","steps":["trace[2130450180] 'agreement among raft nodes before linearized reading'  (duration: 382.127917ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:37.103898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:36.721431Z","time spent":"382.458595ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-04T01:23:37.104014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.933739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:23:37.104044Z","caller":"traceutil/trace.go:171","msg":"trace[423039643] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"105.00971ms","start":"2026-03-04T01:23:36.999026Z","end":"2026-03-04T01:23:37.104036Z","steps":["trace[423039643] 'agreement among raft nodes before linearized reading'  (duration: 104.964929ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:23:37.245591Z","caller":"traceutil/trace.go:171","msg":"trace[254289305] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"134.733862ms","start":"2026-03-04T01:23:37.110827Z","end":"2026-03-04T01:23:37.24556Z","steps":["trace[254289305] 'process raft request'  (duration: 123.992049ms)","trace[254289305] 'compare'  (duration: 10.61568ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:23:39.378617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.795286ms","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-03-04T01:23:39.378854Z","caller":"traceutil/trace.go:171","msg":"trace[1224886599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"128.056362ms","start":"2026-03-04T01:23:39.250733Z","end":"2026-03-04T01:23:39.37879Z","steps":["trace[1224886599] 'range keys from in-memory index tree'  (duration: 127.574111ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:49.846652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.921948ms","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-04T01:23:49.846754Z","caller":"traceutil/trace.go:171","msg":"trace[488944816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:896; }","duration":"248.071952ms","start":"2026-03-04T01:23:49.598664Z","end":"2026-03-04T01:23:49.846736Z","steps":["trace[488944816] 'range keys from in-memory index tree'  (duration: 247.737504ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:49.84684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.621282ms","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-04T01:23:49.846846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.293127ms","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-04T01:23:49.846948Z","caller":"traceutil/trace.go:171","msg":"trace[87969879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:896; }","duration":"233.427271ms","start":"2026-03-04T01:23:49.613494Z","end":"2026-03-04T01:23:49.846922Z","steps":["trace[87969879] 'range keys from in-memory index tree'  (duration: 233.084963ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:23:49.846935Z","caller":"traceutil/trace.go:171","msg":"trace[622400135] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:896; }","duration":"290.772426ms","start":"2026-03-04T01:23:49.556137Z","end":"2026-03-04T01:23:49.84691Z","steps":["trace[622400135] 'range keys from in-memory index tree'  (duration: 290.375717ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:51.732058Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680218242746631607,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-04T01:23:51.752636Z","caller":"traceutil/trace.go:171","msg":"trace[242256739] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:932; }","duration":"521.532705ms","start":"2026-03-04T01:23:51.23108Z","end":"2026-03-04T01:23:51.752613Z","steps":["trace[242256739] 'read index received'  (duration: 521.360051ms)","trace[242256739] 'applied index is now lower than readState.Index'  (duration: 171.204µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:23:51.752737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:51.01979Z","time spent":"732.940668ms","remote":"127.0.0.1:42122","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-04T01:23:51.753061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.972765ms","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-04T01:23:51.753092Z","caller":"traceutil/trace.go:171","msg":"trace[114795405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:899; }","duration":"522.043127ms","start":"2026-03-04T01:23:51.231037Z","end":"2026-03-04T01:23:51.75308Z","steps":["trace[114795405] 'agreement among raft nodes before linearized reading'  (duration: 521.897813ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:51.753118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:51.231019Z","time spent":"522.093307ms","remote":"127.0.0.1:42362","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-03-04T01:23:51.753345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.657926ms","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-03-04T01:23:51.753383Z","caller":"traceutil/trace.go:171","msg":"trace[116651416] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:899; }","duration":"276.737207ms","start":"2026-03-04T01:23:51.476633Z","end":"2026-03-04T01:23:51.75337Z","steps":["trace[116651416] 'agreement among raft nodes before linearized reading'  (duration: 276.631185ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:52.281142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.783494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-03-04T01:23:52.281258Z","caller":"traceutil/trace.go:171","msg":"trace[1432661032] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:900; }","duration":"522.958438ms","start":"2026-03-04T01:23:51.758273Z","end":"2026-03-04T01:23:52.281232Z","steps":["trace[1432661032] 'range keys from in-memory index tree'  (duration: 522.676751ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:52.281323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:51.758242Z","time spent":"523.06573ms","remote":"127.0.0.1:42268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":443,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"info","ts":"2026-03-04T01:23:52.336622Z","caller":"traceutil/trace.go:171","msg":"trace[933415614] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"578.102083ms","start":"2026-03-04T01:23:51.758489Z","end":"2026-03-04T01:23:52.336591Z","steps":["trace[933415614] 'process raft request'  (duration: 577.944669ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:52.336831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:51.758471Z","time spent":"578.235616ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:896 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-03-04T01:23:52.338054Z","caller":"traceutil/trace.go:171","msg":"trace[232229699] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:934; }","duration":"482.430632ms","start":"2026-03-04T01:23:51.855594Z","end":"2026-03-04T01:23:52.338024Z","steps":["trace[232229699] 'read index received'  (duration: 480.867557ms)","trace[232229699] 'applied index is now lower than readState.Index'  (duration: 1.561545ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:23:52.338413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.809291ms","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-04T01:23:52.338472Z","caller":"traceutil/trace.go:171","msg":"trace[1280490301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:903; }","duration":"482.917682ms","start":"2026-03-04T01:23:51.855541Z","end":"2026-03-04T01:23:52.338459Z","steps":["trace[1280490301] 'agreement among raft nodes before linearized reading'  (duration: 482.702178ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:52.338503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:51.855515Z","time spent":"482.983944ms","remote":"127.0.0.1:42362","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-04T01:23:52.338522Z","caller":"traceutil/trace.go:171","msg":"trace[1670486947] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"579.993055ms","start":"2026-03-04T01:23:51.758492Z","end":"2026-03-04T01:23:52.338485Z","steps":["trace[1670486947] 'process raft request'  (duration: 579.3234ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:52.338591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.519292ms","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-04T01:23:52.338638Z","caller":"traceutil/trace.go:171","msg":"trace[170306122] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"137.677878ms","start":"2026-03-04T01:23:52.200954Z","end":"2026-03-04T01:23:52.338631Z","steps":["trace[170306122] 'process raft request'  (duration: 137.011203ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:23:52.338643Z","caller":"traceutil/trace.go:171","msg":"trace[357841278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:903; }","duration":"481.570983ms","start":"2026-03-04T01:23:51.857056Z","end":"2026-03-04T01:23:52.338627Z","steps":["trace[357841278] 'agreement among raft nodes before linearized reading'  (duration: 481.44572ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:52.338676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:51.857029Z","time spent":"481.639954ms","remote":"127.0.0.1:42362","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":"warn","ts":"2026-03-04T01:23:52.338713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:51.758467Z","time spent":"580.136159ms","remote":"127.0.0.1:42362","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:895 > 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-04T01:23:52.338795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.984387ms","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-04T01:23:52.338811Z","caller":"traceutil/trace.go:171","msg":"trace[259716723] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:903; }","duration":"480.011607ms","start":"2026-03-04T01:23:51.858795Z","end":"2026-03-04T01:23:52.338806Z","steps":["trace[259716723] 'agreement among raft nodes before linearized reading'  (duration: 479.967446ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:23:52.338827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:23:51.858788Z","time spent":"480.035198ms","remote":"127.0.0.1:42362","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-04T01:24:04.540676Z","caller":"traceutil/trace.go:171","msg":"trace[988373517] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"150.54665ms","start":"2026-03-04T01:24:04.390099Z","end":"2026-03-04T01:24:04.540646Z","steps":["trace[988373517] 'process raft request'  (duration: 150.247953ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:04.540634Z","caller":"traceutil/trace.go:171","msg":"trace[184982915] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:970; }","duration":"139.409538ms","start":"2026-03-04T01:24:04.401198Z","end":"2026-03-04T01:24:04.540607Z","steps":["trace[184982915] 'read index received'  (duration: 139.05243ms)","trace[184982915] 'applied index is now lower than readState.Index'  (duration: 355.758µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:24:04.540905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.684654ms","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-04T01:24:04.540972Z","caller":"traceutil/trace.go:171","msg":"trace[82563607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:935; }","duration":"139.798227ms","start":"2026-03-04T01:24:04.40116Z","end":"2026-03-04T01:24:04.540958Z","steps":["trace[82563607] 'agreement among raft nodes before linearized reading'  (duration: 139.587902ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:04.541064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.406208ms","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-04T01:24:04.541116Z","caller":"traceutil/trace.go:171","msg":"trace[255673475] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:935; }","duration":"139.46646ms","start":"2026-03-04T01:24:04.401634Z","end":"2026-03-04T01:24:04.5411Z","steps":["trace[255673475] 'agreement among raft nodes before linearized reading'  (duration: 139.303286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:04.541124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.092122ms","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-04T01:24:04.541173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.700381ms","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-04T01:24:04.541207Z","caller":"traceutil/trace.go:171","msg":"trace[881809907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:935; }","duration":"138.740062ms","start":"2026-03-04T01:24:04.402455Z","end":"2026-03-04T01:24:04.541195Z","steps":["trace[881809907] 'agreement among raft nodes before linearized reading'  (duration: 138.65704ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:04.541202Z","caller":"traceutil/trace.go:171","msg":"trace[1566549781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:935; }","duration":"136.219245ms","start":"2026-03-04T01:24:04.404964Z","end":"2026-03-04T01:24:04.541183Z","steps":["trace[1566549781] 'agreement among raft nodes before linearized reading'  (duration: 136.030901ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:07.430132Z","caller":"traceutil/trace.go:171","msg":"trace[1772844679] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"103.469866ms","start":"2026-03-04T01:24:07.326627Z","end":"2026-03-04T01:24:07.430097Z","steps":["trace[1772844679] 'process raft request'  (duration: 103.182789ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:07.639085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.548376ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746631755 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" mod_revision:887 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-nodeplugin-http-metrics\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:24:07.639308Z","caller":"traceutil/trace.go:171","msg":"trace[440123631] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"195.645007ms","start":"2026-03-04T01:24:07.443648Z","end":"2026-03-04T01:24:07.639293Z","steps":["trace[440123631] 'process raft request'  (duration: 195.603676ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:07.639439Z","caller":"traceutil/trace.go:171","msg":"trace[717884495] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"197.507119ms","start":"2026-03-04T01:24:07.441895Z","end":"2026-03-04T01:24:07.639402Z","steps":["trace[717884495] 'process raft request'  (duration: 32.551504ms)","trace[717884495] 'compare'  (duration: 164.438423ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:24:07.639608Z","caller":"traceutil/trace.go:171","msg":"trace[878377062] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"197.647222ms","start":"2026-03-04T01:24:07.441953Z","end":"2026-03-04T01:24:07.6396Z","steps":["trace[878377062] 'process raft request'  (duration: 197.243583ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:08.550166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.335339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-04T01:24:08.55021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.362365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:24:08.550253Z","caller":"traceutil/trace.go:171","msg":"trace[1837211217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:965; }","duration":"648.468402ms","start":"2026-03-04T01:24:07.901766Z","end":"2026-03-04T01:24:08.550235Z","steps":["trace[1837211217] 'range keys from in-memory index tree'  (duration: 648.258867ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:08.550282Z","caller":"traceutil/trace.go:171","msg":"trace[290228107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:965; }","duration":"553.473337ms","start":"2026-03-04T01:24:07.99679Z","end":"2026-03-04T01:24:08.550263Z","steps":["trace[290228107] 'range keys from in-memory index tree'  (duration: 553.307683ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:08.550298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:07.901744Z","time spent":"648.544804ms","remote":"127.0.0.1:42080","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-04T01:24:08.550327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:07.996771Z","time spent":"553.547289ms","remote":"127.0.0.1:42090","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-04T01:24:09.014417Z","caller":"traceutil/trace.go:171","msg":"trace[1945448257] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1002; }","duration":"440.934475ms","start":"2026-03-04T01:24:08.573461Z","end":"2026-03-04T01:24:09.014395Z","steps":["trace[1945448257] 'read index received'  (duration: 440.789472ms)","trace[1945448257] 'applied index is now lower than readState.Index'  (duration: 143.903µs)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:24:09.014711Z","caller":"traceutil/trace.go:171","msg":"trace[942673814] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"455.203087ms","start":"2026-03-04T01:24:08.5595Z","end":"2026-03-04T01:24:09.014703Z","steps":["trace[942673814] 'process raft request'  (duration: 454.726346ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:09.014804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:08.559485Z","time spent":"455.254659ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:954 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-04T01:24:09.01496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.57178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:24:09.014991Z","caller":"traceutil/trace.go:171","msg":"trace[1870271007] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:966; }","duration":"441.653151ms","start":"2026-03-04T01:24:08.57333Z","end":"2026-03-04T01:24:09.014983Z","steps":["trace[1870271007] 'agreement among raft nodes before linearized reading'  (duration: 441.60445ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:09.015012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:08.573286Z","time spent":"441.721923ms","remote":"127.0.0.1:42312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "}
{"level":"warn","ts":"2026-03-04T01:24:09.015308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.959884ms","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-04T01:24:09.015269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.986748ms","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-04T01:24:09.015359Z","caller":"traceutil/trace.go:171","msg":"trace[140828266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:966; }","duration":"355.028835ms","start":"2026-03-04T01:24:08.660311Z","end":"2026-03-04T01:24:09.01534Z","steps":["trace[140828266] 'agreement among raft nodes before linearized reading'  (duration: 354.917583ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:09.015368Z","caller":"traceutil/trace.go:171","msg":"trace[595527182] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"356.157851ms","start":"2026-03-04T01:24:08.659191Z","end":"2026-03-04T01:24:09.015349Z","steps":["trace[595527182] 'agreement among raft nodes before linearized reading'  (duration: 355.843704ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:09.015403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:08.660296Z","time spent":"355.099297ms","remote":"127.0.0.1:42362","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-04T01:24:09.015404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:08.659167Z","time spent":"356.229783ms","remote":"127.0.0.1:42362","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-04T01:24:09.015363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.522378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-03-04T01:24:09.015434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.543157ms","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-04T01:24:09.015495Z","caller":"traceutil/trace.go:171","msg":"trace[1905776889] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"355.630429ms","start":"2026-03-04T01:24:08.659848Z","end":"2026-03-04T01:24:09.015479Z","steps":["trace[1905776889] 'agreement among raft nodes before linearized reading'  (duration: 355.458295ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:09.01549Z","caller":"traceutil/trace.go:171","msg":"trace[78222581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:966; }","duration":"352.694903ms","start":"2026-03-04T01:24:08.662763Z","end":"2026-03-04T01:24:09.015458Z","steps":["trace[78222581] 'agreement among raft nodes before linearized reading'  (duration: 352.279464ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:09.015538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:08.659839Z","time spent":"355.6886ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-04T01:24:09.015567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:08.662716Z","time spent":"352.834326ms","remote":"127.0.0.1:42362","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":"warn","ts":"2026-03-04T01:24:09.294588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.696173ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746631766 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:958 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:24:09.294874Z","caller":"traceutil/trace.go:171","msg":"trace[1185437500] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"273.316161ms","start":"2026-03-04T01:24:09.021539Z","end":"2026-03-04T01:24:09.294855Z","steps":["trace[1185437500] 'process raft request'  (duration: 273.256169ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:09.295021Z","caller":"traceutil/trace.go:171","msg":"trace[328862044] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"274.651621ms","start":"2026-03-04T01:24:09.020346Z","end":"2026-03-04T01:24:09.294998Z","steps":["trace[328862044] 'process raft request'  (duration: 138.431696ms)","trace[328862044] 'compare'  (duration: 135.498499ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:24:09.295041Z","caller":"traceutil/trace.go:171","msg":"trace[583267426] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"273.780551ms","start":"2026-03-04T01:24:09.02124Z","end":"2026-03-04T01:24:09.29502Z","steps":["trace[583267426] 'process raft request'  (duration: 273.460894ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:11.456796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.020777Z","time spent":"436.012515ms","remote":"127.0.0.1:42122","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-04T01:24:11.460641Z","caller":"traceutil/trace.go:171","msg":"trace[165564578] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"438.276563ms","start":"2026-03-04T01:24:11.022327Z","end":"2026-03-04T01:24:11.460604Z","steps":["trace[165564578] 'process raft request'  (duration: 437.17127ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:11.460826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.022291Z","time spent":"438.419136ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:966 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-04T01:24:11.461022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.866093ms","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-04T01:24:11.461106Z","caller":"traceutil/trace.go:171","msg":"trace[1666529125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:972; }","duration":"420.975546ms","start":"2026-03-04T01:24:11.040107Z","end":"2026-03-04T01:24:11.461082Z","steps":["trace[1666529125] 'agreement among raft nodes before linearized reading'  (duration: 420.637448ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:11.461152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.040098Z","time spent":"421.045717ms","remote":"127.0.0.1:42362","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-04T01:24:11.463623Z","caller":"traceutil/trace.go:171","msg":"trace[89990863] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"423.47336ms","start":"2026-03-04T01:24:11.040125Z","end":"2026-03-04T01:24:11.463598Z","steps":["trace[89990863] 'read index received'  (duration: 416.639641ms)","trace[89990863] 'applied index is now lower than readState.Index'  (duration: 3.790892ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:24:11.760679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.43722ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746631779 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/199.204.45.72\" mod_revision:928 > success:<request_put:<key:\"/registry/masterleases/199.204.45.72\" value_size:66 lease:5456846205891855968 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.72\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:24:11.760808Z","caller":"traceutil/trace.go:171","msg":"trace[1656696587] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"297.116451ms","start":"2026-03-04T01:24:11.463673Z","end":"2026-03-04T01:24:11.760789Z","steps":["trace[1656696587] 'read index received'  (duration: 117.490507ms)","trace[1656696587] 'applied index is now lower than readState.Index'  (duration: 179.622714ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:24:11.760959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.710876ms","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-04T01:24:11.76098Z","caller":"traceutil/trace.go:171","msg":"trace[542059485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:973; }","duration":"461.774008ms","start":"2026-03-04T01:24:11.2992Z","end":"2026-03-04T01:24:11.760974Z","steps":["trace[542059485] 'agreement among raft nodes before linearized reading'  (duration: 461.630973ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:11.761006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.299174Z","time spent":"461.826178ms","remote":"127.0.0.1:42362","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-04T01:24:11.761262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.99207ms","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-04T01:24:11.761263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.351658ms","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-04T01:24:11.761355Z","caller":"traceutil/trace.go:171","msg":"trace[1801046923] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"302.484698ms","start":"2026-03-04T01:24:11.458861Z","end":"2026-03-04T01:24:11.761346Z","steps":["trace[1801046923] 'process raft request'  (duration: 122.28045ms)","trace[1801046923] 'compare'  (duration: 179.284937ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:24:11.761357Z","caller":"traceutil/trace.go:171","msg":"trace[1750950352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:973; }","duration":"461.110913ms","start":"2026-03-04T01:24:11.300225Z","end":"2026-03-04T01:24:11.761335Z","steps":["trace[1750950352] 'agreement among raft nodes before linearized reading'  (duration: 460.819967ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:11.761373Z","caller":"traceutil/trace.go:171","msg":"trace[1189146018] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:973; }","duration":"461.495042ms","start":"2026-03-04T01:24:11.299851Z","end":"2026-03-04T01:24:11.761346Z","steps":["trace[1189146018] 'agreement among raft nodes before linearized reading'  (duration: 461.232196ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:11.761419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.458834Z","time spent":"302.541819ms","remote":"127.0.0.1:42122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.72\" mod_revision:928 > success:<request_put:<key:\"/registry/masterleases/199.204.45.72\" value_size:66 lease:5456846205891855968 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.72\" > >"}
{"level":"warn","ts":"2026-03-04T01:24:11.761435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.300219Z","time spent":"461.207065ms","remote":"127.0.0.1:42362","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-04T01:24:11.761453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.299827Z","time spent":"461.607984ms","remote":"127.0.0.1:42362","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-04T01:24:11.762004Z","caller":"traceutil/trace.go:171","msg":"trace[1829937089] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"296.265602ms","start":"2026-03-04T01:24:11.465724Z","end":"2026-03-04T01:24:11.76199Z","steps":["trace[1829937089] 'process raft request'  (duration: 296.15809ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:12.095317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.792935ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746631785 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:970 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:24:12.096784Z","caller":"traceutil/trace.go:171","msg":"trace[422968992] linearizableReadLoop","detail":"{readStateIndex:1015; appliedIndex:1013; }","duration":"264.105229ms","start":"2026-03-04T01:24:11.832642Z","end":"2026-03-04T01:24:12.096747Z","steps":["trace[422968992] 'read index received'  (duration: 73.71475ms)","trace[422968992] 'applied index is now lower than readState.Index'  (duration: 190.388229ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:24:12.097045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.366955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-03-04T01:24:12.097091Z","caller":"traceutil/trace.go:171","msg":"trace[680238049] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:977; }","duration":"264.477537ms","start":"2026-03-04T01:24:11.8326Z","end":"2026-03-04T01:24:12.097077Z","steps":["trace[680238049] 'agreement among raft nodes before linearized reading'  (duration: 264.319144ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:12.095623Z","caller":"traceutil/trace.go:171","msg":"trace[1495795657] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"329.372805ms","start":"2026-03-04T01:24:11.766205Z","end":"2026-03-04T01:24:12.095578Z","steps":["trace[1495795657] 'process raft request'  (duration: 140.12387ms)","trace[1495795657] 'compare'  (duration: 188.55643ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:24:12.097685Z","caller":"traceutil/trace.go:171","msg":"trace[927730206] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"331.247506ms","start":"2026-03-04T01:24:11.766394Z","end":"2026-03-04T01:24:12.097641Z","steps":["trace[927730206] 'process raft request'  (duration: 329.10876ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:12.097741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.76619Z","time spent":"331.43337ms","remote":"127.0.0.1:42362","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:970 > 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-04T01:24:12.097819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:11.766382Z","time spent":"331.346878ms","remote":"127.0.0.1:42362","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:968 > 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-03-04T01:24:12.140448Z","caller":"traceutil/trace.go:171","msg":"trace[446141562] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"127.2596ms","start":"2026-03-04T01:24:12.013167Z","end":"2026-03-04T01:24:12.140427Z","steps":["trace[446141562] 'process raft request'  (duration: 127.153838ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:12.300579Z","caller":"traceutil/trace.go:171","msg":"trace[938567346] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"102.604261ms","start":"2026-03-04T01:24:12.197947Z","end":"2026-03-04T01:24:12.300551Z","steps":["trace[938567346] 'process raft request'  (duration: 23.083494ms)","trace[938567346] 'compare'  (duration: 79.183929ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:24:12.909512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.259101ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746631792 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.18997ee573d8f4e0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.18997ee573d8f4e0\" value_size:692 lease:5456846205891855744 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:24:12.909611Z","caller":"traceutil/trace.go:171","msg":"trace[337143335] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1017; }","duration":"602.362478ms","start":"2026-03-04T01:24:12.307232Z","end":"2026-03-04T01:24:12.909594Z","steps":["trace[337143335] 'read index received'  (duration: 115.82925ms)","trace[337143335] 'applied index is now lower than readState.Index'  (duration: 486.531928ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:24:12.909696Z","caller":"traceutil/trace.go:171","msg":"trace[1115599153] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"602.609924ms","start":"2026-03-04T01:24:12.307031Z","end":"2026-03-04T01:24:12.909641Z","steps":["trace[1115599153] 'process raft request'  (duration: 116.097436ms)","trace[1115599153] 'compare'  (duration: 486.145669ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:24:12.909768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.542212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"info","ts":"2026-03-04T01:24:12.909814Z","caller":"traceutil/trace.go:171","msg":"trace[1821973716] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:980; }","duration":"602.629884ms","start":"2026-03-04T01:24:12.307174Z","end":"2026-03-04T01:24:12.909804Z","steps":["trace[1821973716] 'agreement among raft nodes before linearized reading'  (duration: 602.465941ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:12.90985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:12.307153Z","time spent":"602.688036ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":494,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-04T01:24:12.909885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:12.307013Z","time spent":"602.778038ms","remote":"127.0.0.1:42172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.18997ee573d8f4e0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.18997ee573d8f4e0\" value_size:692 lease:5456846205891855744 >> failure:<>"}
{"level":"info","ts":"2026-03-04T01:24:12.911046Z","caller":"traceutil/trace.go:171","msg":"trace[103134440] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"579.137401ms","start":"2026-03-04T01:24:12.331891Z","end":"2026-03-04T01:24:12.911028Z","steps":["trace[103134440] 'process raft request'  (duration: 579.033768ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:12.911145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:12.331861Z","time spent":"579.234603ms","remote":"127.0.0.1:42172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":787,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tlhbp.18997ee5755643a0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tlhbp.18997ee5755643a0\" value_size:683 lease:5456846205891855744 >> failure:<>"}
{"level":"warn","ts":"2026-03-04T01:24:13.444764Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680218242746631795,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-03-04T01:24:13.589445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.252322ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746631796 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:979 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:24:13.58955Z","caller":"traceutil/trace.go:171","msg":"trace[1314650537] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"673.675636ms","start":"2026-03-04T01:24:12.915857Z","end":"2026-03-04T01:24:13.589533Z","steps":["trace[1314650537] 'process raft request'  (duration: 545.216509ms)","trace[1314650537] 'compare'  (duration: 128.14829ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:24:13.589621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:12.915828Z","time spent":"673.750707ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:979 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:405 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-04T01:24:14.022046Z","caller":"traceutil/trace.go:171","msg":"trace[1228914619] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"1.106096951s","start":"2026-03-04T01:24:12.915923Z","end":"2026-03-04T01:24:14.02202Z","steps":["trace[1228914619] 'process raft request'  (duration: 1.026762317s)","trace[1228914619] 'compare'  (duration: 79.18452ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:24:14.022062Z","caller":"traceutil/trace.go:171","msg":"trace[987305093] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1020; }","duration":"1.077741332s","start":"2026-03-04T01:24:12.944289Z","end":"2026-03-04T01:24:14.02203Z","steps":["trace[987305093] 'read index received'  (duration: 516.795909ms)","trace[987305093] 'applied index is now lower than readState.Index'  (duration: 560.929693ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-04T01:24:14.022305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077987477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-04T01:24:14.022354Z","caller":"traceutil/trace.go:171","msg":"trace[1433158950] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:984; }","duration":"1.07810118s","start":"2026-03-04T01:24:12.944238Z","end":"2026-03-04T01:24:14.022339Z","steps":["trace[1433158950] 'agreement among raft nodes before linearized reading'  (duration: 1.077970407s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:14.022403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:12.944214Z","time spent":"1.078174461s","remote":"127.0.0.1:42470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-03-04T01:24:14.022491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:12.915888Z","time spent":"1.106244584s","remote":"127.0.0.1:42172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":835,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tlhbp.18997ee57567e989\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tlhbp.18997ee57567e989\" value_size:731 lease:5456846205891855744 >> failure:<>"}
{"level":"warn","ts":"2026-03-04T01:24:14.022725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.025536621s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:24:14.02278Z","caller":"traceutil/trace.go:171","msg":"trace[414445489] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:984; }","duration":"1.025617603s","start":"2026-03-04T01:24:12.997149Z","end":"2026-03-04T01:24:14.022767Z","steps":["trace[414445489] 'agreement among raft nodes before linearized reading'  (duration: 1.025536011s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:14.022826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:12.997135Z","time spent":"1.025680584s","remote":"127.0.0.1:42080","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-04T01:24:14.022922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.207569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-04T01:24:14.022994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.794264ms","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-04T01:24:14.022994Z","caller":"traceutil/trace.go:171","msg":"trace[1892244076] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:984; }","duration":"849.358972ms","start":"2026-03-04T01:24:13.173615Z","end":"2026-03-04T01:24:14.022974Z","steps":["trace[1892244076] 'agreement among raft nodes before linearized reading'  (duration: 849.188939ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:14.023028Z","caller":"traceutil/trace.go:171","msg":"trace[300628591] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:984; }","duration":"188.873455ms","start":"2026-03-04T01:24:13.834144Z","end":"2026-03-04T01:24:14.023018Z","steps":["trace[300628591] 'agreement among raft nodes before linearized reading'  (duration: 188.791003ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:14.022838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.169859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-03-04T01:24:14.023064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:13.173594Z","time spent":"849.452534ms","remote":"127.0.0.1:42144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":11,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "}
{"level":"info","ts":"2026-03-04T01:24:14.023108Z","caller":"traceutil/trace.go:171","msg":"trace[1473773118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:984; }","duration":"214.476086ms","start":"2026-03-04T01:24:13.808616Z","end":"2026-03-04T01:24:14.023092Z","steps":["trace[1473773118] 'agreement among raft nodes before linearized reading'  (duration: 214.120838ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:14.023121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.729368ms","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":"warn","ts":"2026-03-04T01:24:14.023179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.123224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:24:14.023247Z","caller":"traceutil/trace.go:171","msg":"trace[831230783] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:984; }","duration":"343.235746ms","start":"2026-03-04T01:24:13.679996Z","end":"2026-03-04T01:24:14.023232Z","steps":["trace[831230783] 'agreement among raft nodes before linearized reading'  (duration: 343.128443ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:14.023301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:13.679959Z","time spent":"343.327648ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"info","ts":"2026-03-04T01:24:14.023197Z","caller":"traceutil/trace.go:171","msg":"trace[1400642608] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:984; }","duration":"555.839401ms","start":"2026-03-04T01:24:13.467348Z","end":"2026-03-04T01:24:14.023187Z","steps":["trace[1400642608] 'agreement among raft nodes before linearized reading'  (duration: 555.409572ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:14.023409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:13.467329Z","time spent":"556.068875ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-04T01:24:14.361955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.770219ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14680218242746631807 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:976 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-04T01:24:14.362165Z","caller":"traceutil/trace.go:171","msg":"trace[1225352096] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"255.44104ms","start":"2026-03-04T01:24:14.106706Z","end":"2026-03-04T01:24:14.362147Z","steps":["trace[1225352096] 'process raft request'  (duration: 255.348038ms)"],"step_count":1}
{"level":"info","ts":"2026-03-04T01:24:14.363326Z","caller":"traceutil/trace.go:171","msg":"trace[794315621] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"257.677749ms","start":"2026-03-04T01:24:14.105602Z","end":"2026-03-04T01:24:14.36328Z","steps":["trace[794315621] 'process raft request'  (duration: 124.502661ms)","trace[794315621] 'compare'  (duration: 131.484272ms)"],"step_count":2}
{"level":"info","ts":"2026-03-04T01:24:23.514271Z","caller":"traceutil/trace.go:171","msg":"trace[396826345] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"223.965572ms","start":"2026-03-04T01:24:23.290261Z","end":"2026-03-04T01:24:23.514227Z","steps":["trace[396826345] 'process raft request'  (duration: 214.109547ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.682337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074743767s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"}
{"level":"info","ts":"2026-03-04T01:24:24.682441Z","caller":"traceutil/trace.go:171","msg":"trace[381725965] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1052; }","duration":"1.07490772s","start":"2026-03-04T01:24:23.607511Z","end":"2026-03-04T01:24:24.682418Z","steps":["trace[381725965] 'range keys from in-memory index tree'  (duration: 1.074502112s)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.682486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:23.607485Z","time spent":"1.074991743s","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "}
{"level":"warn","ts":"2026-03-04T01:24:24.683048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.314007ms","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-04T01:24:24.683172Z","caller":"traceutil/trace.go:171","msg":"trace[909611756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1052; }","duration":"255.492331ms","start":"2026-03-04T01:24:24.427653Z","end":"2026-03-04T01:24:24.683145Z","steps":["trace[909611756] 'range keys from in-memory index tree'  (duration: 254.909689ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.683446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.202133ms","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-04T01:24:24.683506Z","caller":"traceutil/trace.go:171","msg":"trace[889750147] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1052; }","duration":"574.319265ms","start":"2026-03-04T01:24:24.109172Z","end":"2026-03-04T01:24:24.683492Z","steps":["trace[889750147] 'range keys from in-memory index tree'  (duration: 573.946657ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.683542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:24.109137Z","time spent":"574.396267ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":512,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-04T01:24:24.683491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.442388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-03-04T01:24:24.683622Z","caller":"traceutil/trace.go:171","msg":"trace[573960589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1052; }","duration":"531.616632ms","start":"2026-03-04T01:24:24.15198Z","end":"2026-03-04T01:24:24.683597Z","steps":["trace[573960589] 'range keys from in-memory index tree'  (duration: 531.211723ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.683642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.004614ms","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-04T01:24:24.683683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:24.151955Z","time spent":"531.717125ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-03-04T01:24:24.683696Z","caller":"traceutil/trace.go:171","msg":"trace[1464796871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1052; }","duration":"274.098487ms","start":"2026-03-04T01:24:24.409576Z","end":"2026-03-04T01:24:24.683674Z","steps":["trace[1464796871] 'range keys from in-memory index tree'  (duration: 273.855531ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.683105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.283258ms","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-03-04T01:24:24.683805Z","caller":"traceutil/trace.go:171","msg":"trace[522718440] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1052; }","duration":"533.046175ms","start":"2026-03-04T01:24:24.150749Z","end":"2026-03-04T01:24:24.683795Z","steps":["trace[522718440] 'range keys from in-memory index tree'  (duration: 531.94157ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.683751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.757077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"warn","ts":"2026-03-04T01:24:24.683842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:24.150714Z","time spent":"533.117517ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-04T01:24:24.683901Z","caller":"traceutil/trace.go:171","msg":"trace[1513010821] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1052; }","duration":"244.951341ms","start":"2026-03-04T01:24:24.438894Z","end":"2026-03-04T01:24:24.683845Z","steps":["trace[1513010821] 'range keys from in-memory index tree'  (duration: 244.408898ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.684174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.073689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-04T01:24:24.684226Z","caller":"traceutil/trace.go:171","msg":"trace[20874317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1052; }","duration":"683.712235ms","start":"2026-03-04T01:24:24.000502Z","end":"2026-03-04T01:24:24.684214Z","steps":["trace[20874317] 'range keys from in-memory index tree'  (duration: 681.958066ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-04T01:24:24.684257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T01:24:24.000472Z","time spent":"683.776627ms","remote":"127.0.0.1:42090","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-04T01:27:30.179922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.63629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"}
{"level":"info","ts":"2026-03-04T01:27:30.180008Z","caller":"traceutil/trace.go:171","msg":"trace[1852226906] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1844; }","duration":"125.774753ms","start":"2026-03-04T01:27:30.054213Z","end":"2026-03-04T01:27:30.179988Z","steps":["trace[1852226906] 'range keys from in-memory index tree'  (duration: 125.464186ms)"],"step_count":1}