{"level":"warn","ts":"2026-03-18T08:10:19.773108Z","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-18T08:10:19.773255Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.233:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.233:2380","--initial-cluster=instance=https://199.19.213.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.233: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-18T08:10:19.773361Z","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-18T08:10:19.773381Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.233:2380"]}
{"level":"info","ts":"2026-03-18T08:10:19.773409Z","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-18T08:10:19.774455Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.233:2379"]}
{"level":"info","ts":"2026-03-18T08:10:19.774596Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.233:2380"],"listen-peer-urls":["https://199.19.213.233:2380"],"advertise-client-urls":["https://199.19.213.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.233: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-18T08:10:19.780668Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.789132ms"}
{"level":"info","ts":"2026-03-18T08:10:19.788385Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"de5c2ed1f829ccc5","cluster-id":"1c2360c7fdb72bdb"}
{"level":"info","ts":"2026-03-18T08:10:19.788462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 switched to configuration voters=()"}
{"level":"info","ts":"2026-03-18T08:10:19.788492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 became follower at term 0"}
{"level":"info","ts":"2026-03-18T08:10:19.788506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft de5c2ed1f829ccc5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-18T08:10:19.788514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 became follower at term 1"}
{"level":"info","ts":"2026-03-18T08:10:19.788565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 switched to configuration voters=(16022733053623913669)"}
{"level":"warn","ts":"2026-03-18T08:10:19.795255Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-18T08:10:19.79663Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-18T08:10:19.797802Z","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-18T08:10:19.799706Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"de5c2ed1f829ccc5","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-18T08:10:19.801209Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"de5c2ed1f829ccc5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-18T08:10:19.801914Z","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-18T08:10:19.802827Z","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-18T08:10:19.803068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 switched to configuration voters=(16022733053623913669)"}
{"level":"info","ts":"2026-03-18T08:10:19.80317Z","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-18T08:10:19.807367Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1c2360c7fdb72bdb","local-member-id":"de5c2ed1f829ccc5","added-peer-id":"de5c2ed1f829ccc5","added-peer-peer-urls":["https://199.19.213.233:2380"]}
{"level":"info","ts":"2026-03-18T08:10:19.808397Z","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-18T08:10:19.808607Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.233:2380"}
{"level":"info","ts":"2026-03-18T08:10:19.808655Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.233:2380"}
{"level":"info","ts":"2026-03-18T08:10:19.808893Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"de5c2ed1f829ccc5","initial-advertise-peer-urls":["https://199.19.213.233:2380"],"listen-peer-urls":["https://199.19.213.233:2380"],"advertise-client-urls":["https://199.19.213.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-18T08:10:19.809025Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-18T08:10:19.889031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 is starting a new election at term 1"}
{"level":"info","ts":"2026-03-18T08:10:19.889091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-18T08:10:19.889115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 received MsgPreVoteResp from de5c2ed1f829ccc5 at term 1"}
{"level":"info","ts":"2026-03-18T08:10:19.889211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 became candidate at term 2"}
{"level":"info","ts":"2026-03-18T08:10:19.889238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 received MsgVoteResp from de5c2ed1f829ccc5 at term 2"}
{"level":"info","ts":"2026-03-18T08:10:19.889419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"de5c2ed1f829ccc5 became leader at term 2"}
{"level":"info","ts":"2026-03-18T08:10:19.889447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: de5c2ed1f829ccc5 elected leader de5c2ed1f829ccc5 at term 2"}
{"level":"info","ts":"2026-03-18T08:10:19.890523Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T08:10:19.891515Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"de5c2ed1f829ccc5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.233:2379]}","request-path":"/0/members/de5c2ed1f829ccc5/attributes","cluster-id":"1c2360c7fdb72bdb","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-18T08:10:19.891538Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T08:10:19.892126Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1c2360c7fdb72bdb","local-member-id":"de5c2ed1f829ccc5","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T08:10:19.892413Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T08:10:19.892533Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-18T08:10:19.892728Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-18T08:10:19.892781Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-18T08:10:19.894887Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-18T08:10:19.89964Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-18T08:10:19.901468Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.233:2379"}
{"level":"info","ts":"2026-03-18T08:10:21.710868Z","caller":"traceutil/trace.go:171","msg":"trace[796067155] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"211.001753ms","start":"2026-03-18T08:10:21.499844Z","end":"2026-03-18T08:10:21.710845Z","steps":["trace[796067155] 'process raft request'  (duration: 210.785859ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.95939Z","caller":"traceutil/trace.go:171","msg":"trace[1261712823] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"382.089795ms","start":"2026-03-18T08:10:21.577225Z","end":"2026-03-18T08:10:21.959314Z","steps":["trace[1261712823] 'process raft request'  (duration: 381.987743ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.95951Z","caller":"traceutil/trace.go:171","msg":"trace[1601268296] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"448.237074ms","start":"2026-03-18T08:10:21.511251Z","end":"2026-03-18T08:10:21.959488Z","steps":["trace[1601268296] 'read index received'  (duration: 199.615393ms)","trace[1601268296] 'applied index is now lower than readState.Index'  (duration: 248.620641ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:10:21.959813Z","caller":"traceutil/trace.go:171","msg":"trace[2065803786] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"459.691206ms","start":"2026-03-18T08:10:21.500061Z","end":"2026-03-18T08:10:21.959752Z","steps":["trace[2065803786] 'process raft request'  (duration: 459.040094ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.960044Z","caller":"traceutil/trace.go:171","msg":"trace[811055233] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"369.301127ms","start":"2026-03-18T08:10:21.590724Z","end":"2026-03-18T08:10:21.960025Z","steps":["trace[811055233] 'process raft request'  (duration: 368.695326ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.960136Z","caller":"traceutil/trace.go:171","msg":"trace[1081937365] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"382.38647ms","start":"2026-03-18T08:10:21.577717Z","end":"2026-03-18T08:10:21.960103Z","steps":["trace[1081937365] 'process raft request'  (duration: 381.651906ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.960148Z","caller":"traceutil/trace.go:171","msg":"trace[1536871953] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"363.219249ms","start":"2026-03-18T08:10:21.596911Z","end":"2026-03-18T08:10:21.96013Z","steps":["trace[1536871953] 'process raft request'  (duration: 362.539506ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.960227Z","caller":"traceutil/trace.go:171","msg":"trace[2004887069] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"382.309968ms","start":"2026-03-18T08:10:21.577871Z","end":"2026-03-18T08:10:21.960181Z","steps":["trace[2004887069] 'process raft request'  (duration: 381.522203ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.960331Z","caller":"traceutil/trace.go:171","msg":"trace[1591959256] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"382.603235ms","start":"2026-03-18T08:10:21.577508Z","end":"2026-03-18T08:10:21.960071Z","steps":["trace[1591959256] 'process raft request'  (duration: 381.8374ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:21.96053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.797723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-18T08:10:21.960536Z","caller":"traceutil/trace.go:171","msg":"trace[346059483] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"383.073383ms","start":"2026-03-18T08:10:21.577438Z","end":"2026-03-18T08:10:21.960511Z","steps":["trace[346059483] 'process raft request'  (duration: 381.82461ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.960599Z","caller":"traceutil/trace.go:171","msg":"trace[459939913] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"405.861204ms","start":"2026-03-18T08:10:21.554726Z","end":"2026-03-18T08:10:21.960587Z","steps":["trace[459939913] 'agreement among raft nodes before linearized reading'  (duration: 405.780532ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.960685Z","caller":"traceutil/trace.go:171","msg":"trace[1567496834] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"383.103034ms","start":"2026-03-18T08:10:21.577564Z","end":"2026-03-18T08:10:21.960667Z","steps":["trace[1567496834] 'process raft request'  (duration: 381.727808ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:21.960716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.026482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-18T08:10:21.960636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.554693Z","time spent":"405.934556ms","remote":"127.0.0.1:50502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-03-18T08:10:21.960792Z","caller":"traceutil/trace.go:171","msg":"trace[524168053] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"383.122643ms","start":"2026-03-18T08:10:21.577635Z","end":"2026-03-18T08:10:21.960757Z","steps":["trace[524168053] 'agreement among raft nodes before linearized reading'  (duration: 382.984561ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:21.960805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.577422Z","time spent":"383.294477ms","remote":"127.0.0.1:50974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T08:10:21.960811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.5772Z","time spent":"382.355099ms","remote":"127.0.0.1:50974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T08:10:21.960844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.577627Z","time spent":"383.206986ms","remote":"127.0.0.1:50470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-03-18T08:10:21.960931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.29227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-18T08:10:21.960997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.236835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-18T08:10:21.96099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.577491Z","time spent":"383.216026ms","remote":"127.0.0.1:50974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"info","ts":"2026-03-18T08:10:21.961077Z","caller":"traceutil/trace.go:171","msg":"trace[342250820] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"333.477774ms","start":"2026-03-18T08:10:21.627563Z","end":"2026-03-18T08:10:21.96104Z","steps":["trace[342250820] 'agreement among raft nodes before linearized reading'  (duration: 333.243329ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:21.961099Z","caller":"traceutil/trace.go:171","msg":"trace[1958625644] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"384.699705ms","start":"2026-03-18T08:10:21.576347Z","end":"2026-03-18T08:10:21.961047Z","steps":["trace[1958625644] 'agreement among raft nodes before linearized reading'  (duration: 384.555282ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:21.961141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.627499Z","time spent":"333.631756ms","remote":"127.0.0.1:50502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-18T08:10:21.96044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.150492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-18T08:10:21.961232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.576274Z","time spent":"384.902008ms","remote":"127.0.0.1:50502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-18T08:10:21.961249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.577423Z","time spent":"383.179095ms","remote":"127.0.0.1:50874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"info","ts":"2026-03-18T08:10:21.961259Z","caller":"traceutil/trace.go:171","msg":"trace[981863190] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"450.014748ms","start":"2026-03-18T08:10:21.511223Z","end":"2026-03-18T08:10:21.961238Z","steps":["trace[981863190] 'agreement among raft nodes before linearized reading'  (duration: 449.010609ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:21.961001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.425348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.233\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-03-18T08:10:21.961302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.511199Z","time spent":"450.091229ms","remote":"127.0.0.1:50820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"warn","ts":"2026-03-18T08:10:21.961359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.500056Z","time spent":"459.8884ms","remote":"127.0.0.1:50454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/servicenodeports\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/servicenodeports\" value_size:66 >> failure:<request_range:<key:\"/registry/ranges/servicenodeports\" > >"}
{"level":"warn","ts":"2026-03-18T08:10:21.961419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.590715Z","time spent":"369.371568ms","remote":"127.0.0.1:50552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3125 >> failure:<>"}
{"level":"info","ts":"2026-03-18T08:10:21.961338Z","caller":"traceutil/trace.go:171","msg":"trace[1830576167] range","detail":"{range_begin:/registry/masterleases/199.19.213.233; range_end:; response_count:0; response_revision:11; }","duration":"386.800865ms","start":"2026-03-18T08:10:21.574524Z","end":"2026-03-18T08:10:21.961324Z","steps":["trace[1830576167] 'agreement among raft nodes before linearized reading'  (duration: 386.444818ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:21.961542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.577685Z","time spent":"382.482461ms","remote":"127.0.0.1:50974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T08:10:21.96156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.574498Z","time spent":"387.050341ms","remote":"127.0.0.1:50426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.233\" "}
{"level":"warn","ts":"2026-03-18T08:10:21.961766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.596896Z","time spent":"363.28993ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-vwm4g\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-vwm4g\" value_size:791 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T08:10:21.961837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:21.577859Z","time spent":"382.39923ms","remote":"127.0.0.1:50974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"info","ts":"2026-03-18T08:10:54.973708Z","caller":"traceutil/trace.go:171","msg":"trace[1727774671] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"115.192254ms","start":"2026-03-18T08:10:54.858493Z","end":"2026-03-18T08:10:54.973685Z","steps":["trace[1727774671] 'process raft request'  (duration: 115.018601ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:56.711175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.754347ms","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-18T08:10:56.711215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.194892ms","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-18T08:10:56.711269Z","caller":"traceutil/trace.go:171","msg":"trace[1409900905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:527; }","duration":"395.884609ms","start":"2026-03-18T08:10:56.315364Z","end":"2026-03-18T08:10:56.711249Z","steps":["trace[1409900905] 'range keys from in-memory index tree'  (duration: 395.669545ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:10:56.711281Z","caller":"traceutil/trace.go:171","msg":"trace[1279645347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:527; }","duration":"596.320165ms","start":"2026-03-18T08:10:56.114943Z","end":"2026-03-18T08:10:56.711263Z","steps":["trace[1279645347] 'range keys from in-memory index tree'  (duration: 595.963637ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:56.711273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.665225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-18T08:10:56.711313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:56.114916Z","time spent":"596.391726ms","remote":"127.0.0.1:50658","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-18T08:10:56.711312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:56.315355Z","time spent":"395.945461ms","remote":"127.0.0.1:50658","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-18T08:10:56.711324Z","caller":"traceutil/trace.go:171","msg":"trace[796948408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:527; }","duration":"396.760198ms","start":"2026-03-18T08:10:56.314548Z","end":"2026-03-18T08:10:56.711308Z","steps":["trace[796948408] 'range keys from in-memory index tree'  (duration: 396.387429ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:10:56.71142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:10:56.314518Z","time spent":"396.870319ms","remote":"127.0.0.1:50658","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-18T08:11:01.435794Z","caller":"traceutil/trace.go:171","msg":"trace[1297090515] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"154.891627ms","start":"2026-03-18T08:11:01.28087Z","end":"2026-03-18T08:11:01.435762Z","steps":["trace[1297090515] 'process raft request'  (duration: 154.667413ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:03.048019Z","caller":"traceutil/trace.go:171","msg":"trace[952736818] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"290.092904ms","start":"2026-03-18T08:11:02.757904Z","end":"2026-03-18T08:11:03.047996Z","steps":["trace[952736818] 'process raft request'  (duration: 289.936381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:03.154058Z","caller":"traceutil/trace.go:171","msg":"trace[527448302] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"395.793228ms","start":"2026-03-18T08:11:02.75823Z","end":"2026-03-18T08:11:03.154023Z","steps":["trace[527448302] 'process raft request'  (duration: 395.328659ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:03.154283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:11:02.758211Z","time spent":"395.955201ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:537 > 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-18T08:11:03.154448Z","caller":"traceutil/trace.go:171","msg":"trace[1827072324] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"114.862329ms","start":"2026-03-18T08:11:03.039552Z","end":"2026-03-18T08:11:03.154414Z","steps":["trace[1827072324] 'process raft request'  (duration: 114.41088ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:03.155161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.100303ms","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-18T08:11:03.155226Z","caller":"traceutil/trace.go:171","msg":"trace[1101098126] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:546; }","duration":"396.180075ms","start":"2026-03-18T08:11:02.759026Z","end":"2026-03-18T08:11:03.155206Z","steps":["trace[1101098126] 'agreement among raft nodes before linearized reading'  (duration: 395.998132ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:03.155264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:11:02.759015Z","time spent":"396.241996ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-03-18T08:11:03.155468Z","caller":"traceutil/trace.go:171","msg":"trace[1413792036] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:560; }","duration":"395.164385ms","start":"2026-03-18T08:11:02.759048Z","end":"2026-03-18T08:11:03.154212Z","steps":["trace[1413792036] 'read index received'  (duration: 288.873409ms)","trace[1413792036] 'applied index is now lower than readState.Index'  (duration: 106.289036ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:11:03.155785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.6864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T08:11:03.155868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.07018ms","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-18T08:11:03.155879Z","caller":"traceutil/trace.go:171","msg":"trace[1351233092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:546; }","duration":"142.819173ms","start":"2026-03-18T08:11:03.013037Z","end":"2026-03-18T08:11:03.155856Z","steps":["trace[1351233092] 'agreement among raft nodes before linearized reading'  (duration: 142.590799ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:03.15592Z","caller":"traceutil/trace.go:171","msg":"trace[39496676] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:546; }","duration":"149.186412ms","start":"2026-03-18T08:11:03.006721Z","end":"2026-03-18T08:11:03.155907Z","steps":["trace[39496676] 'agreement among raft nodes before linearized reading'  (duration: 148.828615ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:03.591926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.975153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.233\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-18T08:11:03.592089Z","caller":"traceutil/trace.go:171","msg":"trace[638196400] range","detail":"{range_begin:/registry/masterleases/199.19.213.233; range_end:; response_count:1; response_revision:548; }","duration":"295.173777ms","start":"2026-03-18T08:11:03.296847Z","end":"2026-03-18T08:11:03.592021Z","steps":["trace[638196400] 'range keys from in-memory index tree'  (duration: 294.670197ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:05.630198Z","caller":"traceutil/trace.go:171","msg":"trace[959033982] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"134.29221ms","start":"2026-03-18T08:11:05.495872Z","end":"2026-03-18T08:11:05.630164Z","steps":["trace[959033982] 'process raft request'  (duration: 134.099196ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:23.769971Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755372377456054794,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-18T08:11:23.780148Z","caller":"traceutil/trace.go:171","msg":"trace[531810687] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"511.070355ms","start":"2026-03-18T08:11:23.269046Z","end":"2026-03-18T08:11:23.780117Z","steps":["trace[531810687] 'read index received'  (duration: 505.722467ms)","trace[531810687] 'applied index is now lower than readState.Index'  (duration: 5.346568ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:11:23.780332Z","caller":"traceutil/trace.go:171","msg":"trace[561018757] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"537.204502ms","start":"2026-03-18T08:11:23.243086Z","end":"2026-03-18T08:11:23.780291Z","steps":["trace[561018757] 'process raft request'  (duration: 531.610919ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:23.78041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.358861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-03-18T08:11:23.780474Z","caller":"traceutil/trace.go:171","msg":"trace[123391982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:727; }","duration":"511.429922ms","start":"2026-03-18T08:11:23.269026Z","end":"2026-03-18T08:11:23.780456Z","steps":["trace[123391982] 'agreement among raft nodes before linearized reading'  (duration: 511.244729ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:23.780475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:11:23.243062Z","time spent":"537.336374ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:722 > 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-18T08:11:23.78046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.933926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.233\" ","response":"range_response_count:1 size:135"}
{"level":"warn","ts":"2026-03-18T08:11:23.780508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.050372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-03-18T08:11:23.780509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.807042ms","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-18T08:11:23.780553Z","caller":"traceutil/trace.go:171","msg":"trace[33919307] range","detail":"{range_begin:/registry/masterleases/199.19.213.233; range_end:; response_count:1; response_revision:727; }","duration":"483.066009ms","start":"2026-03-18T08:11:23.297466Z","end":"2026-03-18T08:11:23.780532Z","steps":["trace[33919307] 'agreement among raft nodes before linearized reading'  (duration: 482.909616ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:23.780505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:11:23.268947Z","time spent":"511.552264ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-03-18T08:11:23.78057Z","caller":"traceutil/trace.go:171","msg":"trace[221087305] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:727; }","duration":"505.188915ms","start":"2026-03-18T08:11:23.275362Z","end":"2026-03-18T08:11:23.780551Z","steps":["trace[221087305] 'agreement among raft nodes before linearized reading'  (duration: 504.94769ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:23.780625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:11:23.297453Z","time spent":"483.1475ms","remote":"127.0.0.1:50426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.233\" "}
{"level":"info","ts":"2026-03-18T08:11:23.780654Z","caller":"traceutil/trace.go:171","msg":"trace[767285491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:727; }","duration":"473.975195ms","start":"2026-03-18T08:11:23.306609Z","end":"2026-03-18T08:11:23.780584Z","steps":["trace[767285491] 'agreement among raft nodes before linearized reading'  (duration: 473.705289ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:23.780682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:11:23.27535Z","time spent":"505.316177ms","remote":"127.0.0.1:50658","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-18T08:11:23.780704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:11:23.306595Z","time spent":"474.092648ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-18T08:11:50.158316Z","caller":"traceutil/trace.go:171","msg":"trace[2024995332] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"173.452793ms","start":"2026-03-18T08:11:49.984827Z","end":"2026-03-18T08:11:50.158279Z","steps":["trace[2024995332] 'read index received'  (duration: 173.172277ms)","trace[2024995332] 'applied index is now lower than readState.Index'  (duration: 278.966µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:11:50.158429Z","caller":"traceutil/trace.go:171","msg":"trace[1941758455] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"234.880828ms","start":"2026-03-18T08:11:49.923492Z","end":"2026-03-18T08:11:50.158373Z","steps":["trace[1941758455] 'process raft request'  (duration: 234.525931ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:50.158673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.829157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T08:11:50.158703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.80536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-18T08:11:50.158848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.195286ms","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-18T08:11:50.158752Z","caller":"traceutil/trace.go:171","msg":"trace[729348484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"145.938899ms","start":"2026-03-18T08:11:50.012792Z","end":"2026-03-18T08:11:50.158731Z","steps":["trace[729348484] 'agreement among raft nodes before linearized reading'  (duration: 145.814066ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:11:50.158925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.026273ms","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-18T08:11:50.159038Z","caller":"traceutil/trace.go:171","msg":"trace[1967346500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:807; }","duration":"172.158015ms","start":"2026-03-18T08:11:49.986853Z","end":"2026-03-18T08:11:50.159011Z","steps":["trace[1967346500] 'agreement among raft nodes before linearized reading'  (duration: 171.785608ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:50.159039Z","caller":"traceutil/trace.go:171","msg":"trace[616563010] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:807; }","duration":"172.37968ms","start":"2026-03-18T08:11:49.986567Z","end":"2026-03-18T08:11:50.158947Z","steps":["trace[616563010] 'agreement among raft nodes before linearized reading'  (duration: 171.991202ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:50.158874Z","caller":"traceutil/trace.go:171","msg":"trace[1630456667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:807; }","duration":"174.091286ms","start":"2026-03-18T08:11:49.984766Z","end":"2026-03-18T08:11:50.158857Z","steps":["trace[1630456667] 'agreement among raft nodes before linearized reading'  (duration: 173.687438ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:52.383182Z","caller":"traceutil/trace.go:171","msg":"trace[1431393352] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"141.159217ms","start":"2026-03-18T08:11:52.241985Z","end":"2026-03-18T08:11:52.383145Z","steps":["trace[1431393352] 'process raft request'  (duration: 141.000264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:52.383237Z","caller":"traceutil/trace.go:171","msg":"trace[1209431599] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"142.623999ms","start":"2026-03-18T08:11:52.240572Z","end":"2026-03-18T08:11:52.383196Z","steps":["trace[1209431599] 'process raft request'  (duration: 77.080898ms)","trace[1209431599] 'compare'  (duration: 65.060271ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:11:53.619866Z","caller":"traceutil/trace.go:171","msg":"trace[18016528] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:843; }","duration":"180.669477ms","start":"2026-03-18T08:11:53.43917Z","end":"2026-03-18T08:11:53.61984Z","steps":["trace[18016528] 'read index received'  (duration: 180.430832ms)","trace[18016528] 'applied index is now lower than readState.Index'  (duration: 237.415µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:11:53.619894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:11:53.300865Z","time spent":"319.022035ms","remote":"127.0.0.1:50426","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-18T08:11:53.62017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.975583ms","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-18T08:11:53.620238Z","caller":"traceutil/trace.go:171","msg":"trace[121103039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:815; }","duration":"181.097696ms","start":"2026-03-18T08:11:53.43913Z","end":"2026-03-18T08:11:53.620228Z","steps":["trace[121103039] 'agreement among raft nodes before linearized reading'  (duration: 180.80486ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:11:53.80703Z","caller":"traceutil/trace.go:171","msg":"trace[33136279] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:845; }","duration":"152.949547ms","start":"2026-03-18T08:11:53.654041Z","end":"2026-03-18T08:11:53.80699Z","steps":["trace[33136279] 'read index received'  (duration: 133.410433ms)","trace[33136279] 'applied index is now lower than readState.Index'  (duration: 19.537624ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:11:53.80717Z","caller":"traceutil/trace.go:171","msg":"trace[2102585866] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"182.882954ms","start":"2026-03-18T08:11:53.624237Z","end":"2026-03-18T08:11:53.80712Z","steps":["trace[2102585866] 'process raft request'  (duration: 163.318339ms)","trace[2102585866] 'compare'  (duration: 19.047943ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:11:53.807496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.316026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-03-18T08:11:53.808101Z","caller":"traceutil/trace.go:171","msg":"trace[1483131232] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:817; }","duration":"154.108073ms","start":"2026-03-18T08:11:53.653962Z","end":"2026-03-18T08:11:53.80807Z","steps":["trace[1483131232] 'agreement among raft nodes before linearized reading'  (duration: 153.291066ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:04.961939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.464665ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14755372377456055234 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:843 > 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-18T08:12:04.962393Z","caller":"traceutil/trace.go:171","msg":"trace[1569566555] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"289.027159ms","start":"2026-03-18T08:12:04.673348Z","end":"2026-03-18T08:12:04.962375Z","steps":["trace[1569566555] 'process raft request'  (duration: 288.949687ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:04.962472Z","caller":"traceutil/trace.go:171","msg":"trace[1121561107] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"418.14209ms","start":"2026-03-18T08:12:04.544285Z","end":"2026-03-18T08:12:04.962427Z","steps":["trace[1121561107] 'process raft request'  (duration: 88.914578ms)","trace[1121561107] 'compare'  (duration: 328.338862ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:12:04.962696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:04.544251Z","time spent":"418.320274ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:843 > 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-18T08:12:06.802533Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755372377456055240,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-18T08:12:06.934685Z","caller":"traceutil/trace.go:171","msg":"trace[584883232] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"632.762418ms","start":"2026-03-18T08:12:06.301903Z","end":"2026-03-18T08:12:06.934665Z","steps":["trace[584883232] 'read index received'  (duration: 632.566443ms)","trace[584883232] 'applied index is now lower than readState.Index'  (duration: 192.714µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:12:06.934887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.965792ms","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-18T08:12:06.934883Z","caller":"traceutil/trace.go:171","msg":"trace[1851087041] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"651.843843ms","start":"2026-03-18T08:12:06.282918Z","end":"2026-03-18T08:12:06.934762Z","steps":["trace[1851087041] 'process raft request'  (duration: 651.622048ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:06.934922Z","caller":"traceutil/trace.go:171","msg":"trace[733611691] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:903; }","duration":"633.056104ms","start":"2026-03-18T08:12:06.301856Z","end":"2026-03-18T08:12:06.934912Z","steps":["trace[733611691] 'agreement among raft nodes before linearized reading'  (duration: 632.916451ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:06.934956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:06.301841Z","time spent":"633.108544ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-03-18T08:12:06.935038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:06.282891Z","time spent":"652.059337ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:897 > 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-18T08:12:06.935123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.003225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T08:12:06.935187Z","caller":"traceutil/trace.go:171","msg":"trace[1787188142] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:903; }","duration":"441.122518ms","start":"2026-03-18T08:12:06.494051Z","end":"2026-03-18T08:12:06.935173Z","steps":["trace[1787188142] 'agreement among raft nodes before linearized reading'  (duration: 441.000986ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:06.935215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:06.494024Z","time spent":"441.18567ms","remote":"127.0.0.1:50664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "}
{"level":"warn","ts":"2026-03-18T08:12:06.935343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.407664ms","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-18T08:12:06.935497Z","caller":"traceutil/trace.go:171","msg":"trace[604429146] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:903; }","duration":"392.621617ms","start":"2026-03-18T08:12:06.542845Z","end":"2026-03-18T08:12:06.935467Z","steps":["trace[604429146] 'agreement among raft nodes before linearized reading'  (duration: 392.182638ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:06.935573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:06.542829Z","time spent":"392.73085ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-03-18T08:12:06.935657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.109926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T08:12:06.935698Z","caller":"traceutil/trace.go:171","msg":"trace[223246920] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:903; }","duration":"448.157107ms","start":"2026-03-18T08:12:06.487532Z","end":"2026-03-18T08:12:06.935689Z","steps":["trace[223246920] 'agreement among raft nodes before linearized reading'  (duration: 447.437032ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:06.935718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:06.487481Z","time spent":"448.231958ms","remote":"127.0.0.1:50724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"warn","ts":"2026-03-18T08:12:07.467027Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755372377456055243,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-18T08:12:07.555128Z","caller":"traceutil/trace.go:171","msg":"trace[1690696835] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"615.879268ms","start":"2026-03-18T08:12:06.939229Z","end":"2026-03-18T08:12:07.555108Z","steps":["trace[1690696835] 'process raft request'  (duration: 615.744176ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:07.555275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:06.939211Z","time spent":"615.98372ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:899 > 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-18T08:12:07.555907Z","caller":"traceutil/trace.go:171","msg":"trace[622967694] linearizableReadLoop","detail":"{readStateIndex:939; appliedIndex:936; }","duration":"589.373675ms","start":"2026-03-18T08:12:06.966514Z","end":"2026-03-18T08:12:07.555888Z","steps":["trace[622967694] 'read index received'  (duration: 588.488786ms)","trace[622967694] 'applied index is now lower than readState.Index'  (duration: 883.979µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:12:07.555931Z","caller":"traceutil/trace.go:171","msg":"trace[2011602873] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"616.525502ms","start":"2026-03-18T08:12:06.939387Z","end":"2026-03-18T08:12:07.555913Z","steps":["trace[2011602873] 'process raft request'  (duration: 616.354719ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:07.555994Z","caller":"traceutil/trace.go:171","msg":"trace[933199985] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"214.901213ms","start":"2026-03-18T08:12:07.341084Z","end":"2026-03-18T08:12:07.555985Z","steps":["trace[933199985] 'process raft request'  (duration: 214.77387ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:07.556069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:06.939382Z","time spent":"616.614194ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:898 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-18T08:12:07.556322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.782365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-03-18T08:12:07.556333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.686147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T08:12:07.556351Z","caller":"traceutil/trace.go:171","msg":"trace[901784112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:906; }","duration":"589.854206ms","start":"2026-03-18T08:12:06.966487Z","end":"2026-03-18T08:12:07.556341Z","steps":["trace[901784112] 'agreement among raft nodes before linearized reading'  (duration: 589.725123ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:07.556361Z","caller":"traceutil/trace.go:171","msg":"trace[869449233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:906; }","duration":"543.767118ms","start":"2026-03-18T08:12:07.012585Z","end":"2026-03-18T08:12:07.556352Z","steps":["trace[869449233] 'agreement among raft nodes before linearized reading'  (duration: 543.723847ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:07.556375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:06.966481Z","time spent":"589.889507ms","remote":"127.0.0.1:50658","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-18T08:12:07.556382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:07.012546Z","time spent":"543.8309ms","remote":"127.0.0.1:50400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-18T08:12:09.052317Z","caller":"traceutil/trace.go:171","msg":"trace[1096593837] linearizableReadLoop","detail":"{readStateIndex:942; appliedIndex:941; }","duration":"112.420708ms","start":"2026-03-18T08:12:08.939875Z","end":"2026-03-18T08:12:09.052296Z","steps":["trace[1096593837] 'read index received'  (duration: 58.661385ms)","trace[1096593837] 'applied index is now lower than readState.Index'  (duration: 53.758303ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:12:09.052486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.996304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-18T08:12:09.052514Z","caller":"traceutil/trace.go:171","msg":"trace[932923442] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:908; }","duration":"108.074485ms","start":"2026-03-18T08:12:08.944432Z","end":"2026-03-18T08:12:09.052507Z","steps":["trace[932923442] 'agreement among raft nodes before linearized reading'  (duration: 107.983233ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:09.052616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.732564ms","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-18T08:12:09.052787Z","caller":"traceutil/trace.go:171","msg":"trace[1797552299] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:908; }","duration":"112.975989ms","start":"2026-03-18T08:12:08.939787Z","end":"2026-03-18T08:12:09.052763Z","steps":["trace[1797552299] 'agreement among raft nodes before linearized reading'  (duration: 112.577941ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:19.976849Z","caller":"traceutil/trace.go:171","msg":"trace[970169646] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"170.130402ms","start":"2026-03-18T08:12:19.806691Z","end":"2026-03-18T08:12:19.976821Z","steps":["trace[970169646] 'process raft request'  (duration: 168.895906ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:24.108489Z","caller":"traceutil/trace.go:171","msg":"trace[349113475] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1005; }","duration":"260.617774ms","start":"2026-03-18T08:12:23.847843Z","end":"2026-03-18T08:12:24.108461Z","steps":["trace[349113475] 'read index received'  (duration: 260.43321ms)","trace[349113475] 'applied index is now lower than readState.Index'  (duration: 183.134µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:12:24.108651Z","caller":"traceutil/trace.go:171","msg":"trace[2019325790] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"472.306529ms","start":"2026-03-18T08:12:23.636313Z","end":"2026-03-18T08:12:24.108619Z","steps":["trace[2019325790] 'process raft request'  (duration: 471.771948ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:24.108799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:23.636295Z","time spent":"472.394431ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:951 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-18T08:12:24.109568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.314653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-18T08:12:24.109698Z","caller":"traceutil/trace.go:171","msg":"trace[611609949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:969; }","duration":"103.645971ms","start":"2026-03-18T08:12:24.005999Z","end":"2026-03-18T08:12:24.109645Z","steps":["trace[611609949] 'agreement among raft nodes before linearized reading'  (duration: 102.897914ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:24.110029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.192638ms","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-18T08:12:24.110071Z","caller":"traceutil/trace.go:171","msg":"trace[2000716678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:969; }","duration":"262.28517ms","start":"2026-03-18T08:12:23.847774Z","end":"2026-03-18T08:12:24.110059Z","steps":["trace[2000716678] 'agreement among raft nodes before linearized reading'  (duration: 262.169178ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:24.888003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.546275ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14755372377456055411 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T08:12:24.88826Z","caller":"traceutil/trace.go:171","msg":"trace[777753785] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"773.879475ms","start":"2026-03-18T08:12:24.114358Z","end":"2026-03-18T08:12:24.888238Z","steps":["trace[777753785] 'process raft request'  (duration: 57.015192ms)","trace[777753785] 'compare'  (duration: 716.358181ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:12:24.888377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:24.114332Z","time spent":"774.008497ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:952 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-18T08:12:25.271241Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.100055539s","expected-duration":"1s"}
{"level":"info","ts":"2026-03-18T08:12:25.271688Z","caller":"traceutil/trace.go:171","msg":"trace[1897245870] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"1.1566098s","start":"2026-03-18T08:12:24.115052Z","end":"2026-03-18T08:12:25.271661Z","steps":["trace[1897245870] 'process raft request'  (duration: 1.156382105s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:25.271897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:24.115034Z","time spent":"1.156736433s","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:953 > 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":"info","ts":"2026-03-18T08:12:25.272027Z","caller":"traceutil/trace.go:171","msg":"trace[1526606301] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"1.156809415s","start":"2026-03-18T08:12:24.115191Z","end":"2026-03-18T08:12:25.272Z","steps":["trace[1526606301] 'process raft request'  (duration: 1.156416926s)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:25.27216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:24.11517Z","time spent":"1.156918108s","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:954 > 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-18T08:12:25.288685Z","caller":"traceutil/trace.go:171","msg":"trace[1411434431] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1008; }","duration":"460.117251ms","start":"2026-03-18T08:12:24.828544Z","end":"2026-03-18T08:12:25.288661Z","steps":["trace[1411434431] 'read index received'  (duration: 443.048659ms)","trace[1411434431] 'applied index is now lower than readState.Index'  (duration: 17.067412ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:12:25.288729Z","caller":"traceutil/trace.go:171","msg":"trace[2061485086] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"123.507123ms","start":"2026-03-18T08:12:25.16521Z","end":"2026-03-18T08:12:25.288717Z","steps":["trace[2061485086] 'process raft request'  (duration: 123.38835ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:25.288845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.40082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T08:12:25.288842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.266985ms","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-18T08:12:25.288869Z","caller":"traceutil/trace.go:171","msg":"trace[1713825283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:974; }","duration":"276.470222ms","start":"2026-03-18T08:12:25.01239Z","end":"2026-03-18T08:12:25.288861Z","steps":["trace[1713825283] 'agreement among raft nodes before linearized reading'  (duration: 276.421841ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:25.288882Z","caller":"traceutil/trace.go:171","msg":"trace[584627646] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:974; }","duration":"460.356108ms","start":"2026-03-18T08:12:24.828514Z","end":"2026-03-18T08:12:25.28887Z","steps":["trace[584627646] 'agreement among raft nodes before linearized reading'  (duration: 460.257165ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:25.288882Z","caller":"traceutil/trace.go:171","msg":"trace[357081863] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"919.516797ms","start":"2026-03-18T08:12:24.369342Z","end":"2026-03-18T08:12:25.288859Z","steps":["trace[357081863] 'process raft request'  (duration: 919.128628ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:25.288923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:24.828497Z","time spent":"460.413579ms","remote":"127.0.0.1:50872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-03-18T08:12:25.288983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:24.36932Z","time spent":"919.608529ms","remote":"127.0.0.1:50458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":891,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-dj8x5.189de14be6ea79fa\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-dj8x5.189de14be6ea79fa\" value_size:787 lease:5532000340601279369 >> failure:<>"}
{"level":"warn","ts":"2026-03-18T08:12:25.289066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.983498ms","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-18T08:12:25.289093Z","caller":"traceutil/trace.go:171","msg":"trace[187262397] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:974; }","duration":"119.038688ms","start":"2026-03-18T08:12:25.170047Z","end":"2026-03-18T08:12:25.289085Z","steps":["trace[187262397] 'agreement among raft nodes before linearized reading'  (duration: 118.935606ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:26.616615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.156828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T08:12:26.616746Z","caller":"traceutil/trace.go:171","msg":"trace[1074728662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"603.351283ms","start":"2026-03-18T08:12:26.013372Z","end":"2026-03-18T08:12:26.616723Z","steps":["trace[1074728662] 'range keys from in-memory index tree'  (duration: 603.060526ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:26.616801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:26.013353Z","time spent":"603.434015ms","remote":"127.0.0.1:50400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-18T08:12:26.616837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.689885ms","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-18T08:12:26.61691Z","caller":"traceutil/trace.go:171","msg":"trace[1665645458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:981; }","duration":"501.819677ms","start":"2026-03-18T08:12:26.115072Z","end":"2026-03-18T08:12:26.616891Z","steps":["trace[1665645458] 'range keys from in-memory index tree'  (duration: 501.48035ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:26.616949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:26.115047Z","time spent":"501.893419ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-03-18T08:12:26.964909Z","caller":"traceutil/trace.go:171","msg":"trace[758712224] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"343.243709ms","start":"2026-03-18T08:12:26.621636Z","end":"2026-03-18T08:12:26.964879Z","steps":["trace[758712224] 'process raft request'  (duration: 343.047035ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:26.965104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:26.62162Z","time spent":"343.369392ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:969 > 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-18T08:12:27.72258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.923269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"}
{"level":"info","ts":"2026-03-18T08:12:27.722648Z","caller":"traceutil/trace.go:171","msg":"trace[1531579546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:983; }","duration":"445.063561ms","start":"2026-03-18T08:12:27.27757Z","end":"2026-03-18T08:12:27.722633Z","steps":["trace[1531579546] 'range keys from in-memory index tree'  (duration: 444.725634ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:27.722682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:27.277546Z","time spent":"445.129163ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-03-18T08:12:27.722797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.763273ms","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-18T08:12:27.722873Z","caller":"traceutil/trace.go:171","msg":"trace[700701781] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:983; }","duration":"435.906816ms","start":"2026-03-18T08:12:27.286951Z","end":"2026-03-18T08:12:27.722858Z","steps":["trace[700701781] 'count revisions from in-memory index tree'  (duration: 435.667571ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:27.72291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:27.286931Z","time spent":"435.970257ms","remote":"127.0.0.1:50530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "}
{"level":"warn","ts":"2026-03-18T08:12:27.723002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.870489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-18T08:12:27.723084Z","caller":"traceutil/trace.go:171","msg":"trace[1500631132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:983; }","duration":"445.987731ms","start":"2026-03-18T08:12:27.277073Z","end":"2026-03-18T08:12:27.72306Z","steps":["trace[1500631132] 'range keys from in-memory index tree'  (duration: 445.681275ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:27.723124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:27.277057Z","time spent":"446.058273ms","remote":"127.0.0.1:50658","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-18T08:12:27.763132Z","caller":"traceutil/trace.go:171","msg":"trace[2021330096] linearizableReadLoop","detail":"{readStateIndex:1021; appliedIndex:1020; }","duration":"419.654941ms","start":"2026-03-18T08:12:27.343453Z","end":"2026-03-18T08:12:27.763108Z","steps":["trace[2021330096] 'read index received'  (duration: 419.431937ms)","trace[2021330096] 'applied index is now lower than readState.Index'  (duration: 221.594µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:12:27.763196Z","caller":"traceutil/trace.go:171","msg":"trace[1649400423] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"445.147113ms","start":"2026-03-18T08:12:27.318015Z","end":"2026-03-18T08:12:27.763162Z","steps":["trace[1649400423] 'process raft request'  (duration: 444.875658ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:27.763322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:27.317981Z","time spent":"445.275635ms","remote":"127.0.0.1:50552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5958,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:961 > success:<request_put:<key:\"/registry/minions/instance\" value_size:5924 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-03-18T08:12:27.763553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.063871ms","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-18T08:12:27.763886Z","caller":"traceutil/trace.go:171","msg":"trace[367395367] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:984; }","duration":"420.459889ms","start":"2026-03-18T08:12:27.3434Z","end":"2026-03-18T08:12:27.76386Z","steps":["trace[367395367] 'agreement among raft nodes before linearized reading'  (duration: 419.808905ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:27.763967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:27.343378Z","time spent":"420.572401ms","remote":"127.0.0.1:50658","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":"info","ts":"2026-03-18T08:12:27.878246Z","caller":"traceutil/trace.go:171","msg":"trace[1008563755] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"108.088076ms","start":"2026-03-18T08:12:27.770133Z","end":"2026-03-18T08:12:27.878221Z","steps":["trace[1008563755] 'process raft request'  (duration: 57.156005ms)","trace[1008563755] 'compare'  (duration: 50.832559ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:12:28.821603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.197792ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14755372377456055446 > lease_revoke:<id:4cc59cfffee113f9>","response":"size:28"}
{"level":"info","ts":"2026-03-18T08:12:28.822125Z","caller":"traceutil/trace.go:171","msg":"trace[525511124] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1025; }","duration":"181.243309ms","start":"2026-03-18T08:12:28.640847Z","end":"2026-03-18T08:12:28.822091Z","steps":["trace[525511124] 'read index received'  (duration: 58.041µs)","trace[525511124] 'applied index is now lower than readState.Index'  (duration: 181.182308ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:12:28.822284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.420983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T08:12:28.822352Z","caller":"traceutil/trace.go:171","msg":"trace[1093211208] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:988; }","duration":"181.547866ms","start":"2026-03-18T08:12:28.640787Z","end":"2026-03-18T08:12:28.822335Z","steps":["trace[1093211208] 'agreement among raft nodes before linearized reading'  (duration: 181.411803ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:12:30.166859Z","caller":"traceutil/trace.go:171","msg":"trace[84476319] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"342.114445ms","start":"2026-03-18T08:12:29.824718Z","end":"2026-03-18T08:12:30.166833Z","steps":["trace[84476319] 'process raft request'  (duration: 341.955111ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:30.167112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:29.824688Z","time spent":"342.250958ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:986 > 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-18T08:12:30.477962Z","caller":"traceutil/trace.go:171","msg":"trace[375985357] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1028; }","duration":"595.136208ms","start":"2026-03-18T08:12:29.882803Z","end":"2026-03-18T08:12:30.477939Z","steps":["trace[375985357] 'read index received'  (duration: 283.826137ms)","trace[375985357] 'applied index is now lower than readState.Index'  (duration: 311.308991ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:12:30.478284Z","caller":"traceutil/trace.go:171","msg":"trace[133878965] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"651.927124ms","start":"2026-03-18T08:12:29.826343Z","end":"2026-03-18T08:12:30.47827Z","steps":["trace[133878965] 'process raft request'  (duration: 614.434208ms)","trace[133878965] 'compare'  (duration: 36.947265ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:12:30.478397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:29.826317Z","time spent":"652.006126ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:985 > 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-18T08:12:30.47867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.872714ms","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-18T08:12:30.478712Z","caller":"traceutil/trace.go:171","msg":"trace[1492507497] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:992; }","duration":"595.939475ms","start":"2026-03-18T08:12:29.882761Z","end":"2026-03-18T08:12:30.478701Z","steps":["trace[1492507497] 'agreement among raft nodes before linearized reading'  (duration: 595.807733ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:30.478746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:29.882747Z","time spent":"595.992517ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-18T08:12:30.47889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.014936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T08:12:30.478925Z","caller":"traceutil/trace.go:171","msg":"trace[167264355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:992; }","duration":"466.094978ms","start":"2026-03-18T08:12:30.012821Z","end":"2026-03-18T08:12:30.478916Z","steps":["trace[167264355] 'agreement among raft nodes before linearized reading'  (duration: 466.046877ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:30.478963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:30.012796Z","time spent":"466.159519ms","remote":"127.0.0.1:50400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-18T08:12:40.872869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.915104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T08:12:40.872954Z","caller":"traceutil/trace.go:171","msg":"trace[1947762066] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1059; }","duration":"248.029616ms","start":"2026-03-18T08:12:40.624903Z","end":"2026-03-18T08:12:40.872933Z","steps":["trace[1947762066] 'count revisions from in-memory index tree'  (duration: 247.82246ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:40.87322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.651974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-03-18T08:12:40.873263Z","caller":"traceutil/trace.go:171","msg":"trace[759776887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1059; }","duration":"333.736426ms","start":"2026-03-18T08:12:40.539515Z","end":"2026-03-18T08:12:40.873251Z","steps":["trace[759776887] 'range keys from in-memory index tree'  (duration: 333.543992ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:40.873291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:40.539494Z","time spent":"333.788067ms","remote":"127.0.0.1:50658","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-18T08:12:40.873418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.236874ms","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-18T08:12:40.873453Z","caller":"traceutil/trace.go:171","msg":"trace[2105631165] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1059; }","duration":"332.331626ms","start":"2026-03-18T08:12:40.541113Z","end":"2026-03-18T08:12:40.873445Z","steps":["trace[2105631165] 'range keys from in-memory index tree'  (duration: 332.06756ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:40.873503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:40.541074Z","time spent":"332.421158ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-03-18T08:12:41.513849Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14755372377456055597,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-18T08:12:41.620231Z","caller":"traceutil/trace.go:171","msg":"trace[515958] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"607.411008ms","start":"2026-03-18T08:12:41.012773Z","end":"2026-03-18T08:12:41.620184Z","steps":["trace[515958] 'read index received'  (duration: 607.195674ms)","trace[515958] 'applied index is now lower than readState.Index'  (duration: 211.764µs)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:12:41.620422Z","caller":"traceutil/trace.go:171","msg":"trace[679801433] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"673.592084ms","start":"2026-03-18T08:12:40.946817Z","end":"2026-03-18T08:12:41.620409Z","steps":["trace[679801433] 'process raft request'  (duration: 673.202286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:41.620532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:40.946793Z","time spent":"673.660025ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1042 > 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":"warn","ts":"2026-03-18T08:12:41.620656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.880888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-18T08:12:41.620708Z","caller":"traceutil/trace.go:171","msg":"trace[798707066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1063; }","duration":"607.97842ms","start":"2026-03-18T08:12:41.012717Z","end":"2026-03-18T08:12:41.620695Z","steps":["trace[798707066] 'agreement among raft nodes before linearized reading'  (duration: 607.888468ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:41.620748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:41.012697Z","time spent":"608.038171ms","remote":"127.0.0.1:50402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-03-18T08:12:41.620767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.111835ms","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-18T08:12:41.620862Z","caller":"traceutil/trace.go:171","msg":"trace[893007137] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1063; }","duration":"534.263569ms","start":"2026-03-18T08:12:41.086576Z","end":"2026-03-18T08:12:41.620839Z","steps":["trace[893007137] 'agreement among raft nodes before linearized reading'  (duration: 534.023573ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:41.620913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:41.086552Z","time spent":"534.351732ms","remote":"127.0.0.1:50658","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-18T08:12:41.621031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.329921ms","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-18T08:12:41.621067Z","caller":"traceutil/trace.go:171","msg":"trace[63429502] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1063; }","duration":"522.412023ms","start":"2026-03-18T08:12:41.098645Z","end":"2026-03-18T08:12:41.621057Z","steps":["trace[63429502] 'agreement among raft nodes before linearized reading'  (duration: 522.27186ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:12:41.621099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:12:41.098576Z","time spent":"522.512975ms","remote":"127.0.0.1:50658","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-18T08:15:44.731731Z","caller":"traceutil/trace.go:171","msg":"trace[797543304] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"101.258833ms","start":"2026-03-18T08:15:44.63044Z","end":"2026-03-18T08:15:44.731699Z","steps":["trace[797543304] 'process raft request'  (duration: 101.08587ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:15:45.118837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.074229ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14755372377456057599 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1828 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-18T08:15:45.118992Z","caller":"traceutil/trace.go:171","msg":"trace[1370269028] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"382.892045ms","start":"2026-03-18T08:15:44.736056Z","end":"2026-03-18T08:15:45.118948Z","steps":["trace[1370269028] 'process raft request'  (duration: 124.603562ms)","trace[1370269028] 'compare'  (duration: 257.958016ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:15:45.119277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-18T08:15:44.736027Z","time spent":"383.15228ms","remote":"127.0.0.1:50658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1828 > 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-18T08:15:52.209714Z","caller":"traceutil/trace.go:171","msg":"trace[1477927326] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"203.790608ms","start":"2026-03-18T08:15:52.005894Z","end":"2026-03-18T08:15:52.209685Z","steps":["trace[1477927326] 'read index received'  (duration: 153.08024ms)","trace[1477927326] 'applied index is now lower than readState.Index'  (duration: 50.709238ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:15:52.209805Z","caller":"traceutil/trace.go:171","msg":"trace[1306957039] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"238.990647ms","start":"2026-03-18T08:15:51.970784Z","end":"2026-03-18T08:15:52.209774Z","steps":["trace[1306957039] 'process raft request'  (duration: 188.215967ms)","trace[1306957039] 'compare'  (duration: 50.317398ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:15:52.210132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.264222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-18T08:15:52.210192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.279438ms","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":"info","ts":"2026-03-18T08:15:52.210218Z","caller":"traceutil/trace.go:171","msg":"trace[1439310712] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1872; }","duration":"197.453276ms","start":"2026-03-18T08:15:52.012747Z","end":"2026-03-18T08:15:52.2102Z","steps":["trace[1439310712] 'agreement among raft nodes before linearized reading'  (duration: 197.245831ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:15:52.210246Z","caller":"traceutil/trace.go:171","msg":"trace[757181305] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1872; }","duration":"204.385861ms","start":"2026-03-18T08:15:52.005843Z","end":"2026-03-18T08:15:52.210229Z","steps":["trace[757181305] 'agreement among raft nodes before linearized reading'  (duration: 204.117865ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-18T08:15:52.210803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.345673ms","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-18T08:15:52.210868Z","caller":"traceutil/trace.go:171","msg":"trace[765265048] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1872; }","duration":"148.012207ms","start":"2026-03-18T08:15:52.06284Z","end":"2026-03-18T08:15:52.210852Z","steps":["trace[765265048] 'agreement among raft nodes before linearized reading'  (duration: 147.183519ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:15:52.333273Z","caller":"traceutil/trace.go:171","msg":"trace[367489154] linearizableReadLoop","detail":"{readStateIndex:1953; appliedIndex:1951; }","duration":"102.16698ms","start":"2026-03-18T08:15:52.231079Z","end":"2026-03-18T08:15:52.333246Z","steps":["trace[367489154] 'read index received'  (duration: 23.799964ms)","trace[367489154] 'applied index is now lower than readState.Index'  (duration: 78.365826ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-18T08:15:52.333538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.461076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-03-18T08:15:52.333628Z","caller":"traceutil/trace.go:171","msg":"trace[1433634971] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1874; }","duration":"102.60984ms","start":"2026-03-18T08:15:52.231006Z","end":"2026-03-18T08:15:52.333616Z","steps":["trace[1433634971] 'agreement among raft nodes before linearized reading'  (duration: 102.401395ms)"],"step_count":1}
{"level":"info","ts":"2026-03-18T08:15:52.333613Z","caller":"traceutil/trace.go:171","msg":"trace[2101327467] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"110.897235ms","start":"2026-03-18T08:15:52.222621Z","end":"2026-03-18T08:15:52.333519Z","steps":["trace[2101327467] 'process raft request'  (duration: 92.651836ms)","trace[2101327467] 'compare'  (duration: 17.83488ms)"],"step_count":2}
{"level":"info","ts":"2026-03-18T08:15:55.273415Z","caller":"traceutil/trace.go:171","msg":"trace[1560002269] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"115.642842ms","start":"2026-03-18T08:15:55.157739Z","end":"2026-03-18T08:15:55.273382Z","steps":["trace[1560002269] 'process raft request'  (duration: 115.233313ms)"],"step_count":1}