{"level":"warn","ts":"2026-02-17T02:31:44.647674Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-17T02:31:44.650378Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://192.168.24.223: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://192.168.24.223:2380","--initial-cluster=kube-pbufp-hvtv8-zr8wz=https://192.168.24.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://192.168.24.223:2379","--listen-peer-urls=https://192.168.24.223:2380","--name=kube-pbufp-hvtv8-zr8wz","--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","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--listen-metrics-urls=http://0.0.0.0:2381"]}
{"level":"warn","ts":"2026-02-17T02:31:44.650918Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-17T02:31:44.651034Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["https://192.168.24.223:2380"]}
{"level":"info","ts":"2026-02-17T02:31:44.651118Z","caller":"embed/etcd.go:528","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-02-17T02:31:44.663540Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://192.168.24.223:2379"]}
{"level":"info","ts":"2026-02-17T02:31:44.663878Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.24","git-sha":"e72f3c2","go-version":"go1.24.9","go-os":"linux","go-arch":"amd64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"kube-pbufp-hvtv8-zr8wz","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://192.168.24.223:2380"],"listen-peer-urls":["https://192.168.24.223:2380"],"advertise-client-urls":["https://192.168.24.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://192.168.24.223:2379"],"listen-metrics-urls":["http://0.0.0.0:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"kube-pbufp-hvtv8-zr8wz=https://192.168.24.223: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-02-17T02:31:44.688939Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"24.71541ms"}
{"level":"info","ts":"2026-02-17T02:31:44.716688Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"e150efd79fff46f8","cluster-id":"41bb0e70b7cc8cd7"}
{"level":"info","ts":"2026-02-17T02:31:44.716869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-17T02:31:44.718237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 became follower at term 0"}
{"level":"info","ts":"2026-02-17T02:31:44.718266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e150efd79fff46f8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-17T02:31:44.718280Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 became follower at term 1"}
{"level":"info","ts":"2026-02-17T02:31:44.718344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 switched to configuration voters=(16235740366051952376)"}
{"level":"warn","ts":"2026-02-17T02:31:44.744922Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-17T02:31:44.756643Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-17T02:31:44.756967Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0}
{"level":"info","ts":"2026-02-17T02:31:44.766062Z","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-02-17T02:31:44.774900Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"e150efd79fff46f8","local-server-version":"3.5.24","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-17T02:31:44.775308Z","caller":"etcdserver/server.go:759","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e150efd79fff46f8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-17T02:31:44.775733Z","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-02-17T02:31:44.776057Z","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-02-17T02:31:44.776101Z","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-02-17T02:31:44.777510Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
{"level":"info","ts":"2026-02-17T02:31:44.778382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 switched to configuration voters=(16235740366051952376)"}
{"level":"info","ts":"2026-02-17T02:31:44.778843Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"41bb0e70b7cc8cd7","local-member-id":"e150efd79fff46f8","added-peer-id":"e150efd79fff46f8","added-peer-peer-urls":["https://192.168.24.223:2380"],"added-peer-is-learner":false}
{"level":"info","ts":"2026-02-17T02:31:44.782292Z","caller":"embed/etcd.go:762","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-02-17T02:31:44.782549Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"192.168.24.223:2380"}
{"level":"info","ts":"2026-02-17T02:31:44.783020Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"192.168.24.223:2380"}
{"level":"info","ts":"2026-02-17T02:31:44.784101Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"e150efd79fff46f8","initial-advertise-peer-urls":["https://192.168.24.223:2380"],"listen-peer-urls":["https://192.168.24.223:2380"],"advertise-client-urls":["https://192.168.24.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://192.168.24.223:2379"],"listen-metrics-urls":["http://0.0.0.0:2381"]}
{"level":"info","ts":"2026-02-17T02:31:44.784251Z","caller":"embed/etcd.go:908","msg":"serving metrics","address":"http://0.0.0.0:2381"}
{"level":"info","ts":"2026-02-17T02:31:45.119885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-17T02:31:45.120098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-17T02:31:45.120185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 received MsgPreVoteResp from e150efd79fff46f8 at term 1"}
{"level":"info","ts":"2026-02-17T02:31:45.120219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 became candidate at term 2"}
{"level":"info","ts":"2026-02-17T02:31:45.120278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 received MsgVoteResp from e150efd79fff46f8 at term 2"}
{"level":"info","ts":"2026-02-17T02:31:45.120310Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e150efd79fff46f8 became leader at term 2"}
{"level":"info","ts":"2026-02-17T02:31:45.120339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e150efd79fff46f8 elected leader e150efd79fff46f8 at term 2"}
{"level":"info","ts":"2026-02-17T02:31:45.129179Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-17T02:31:45.131034Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"e150efd79fff46f8","local-member-attributes":"{Name:kube-pbufp-hvtv8-zr8wz ClientURLs:[https://192.168.24.223:2379]}","request-path":"/0/members/e150efd79fff46f8/attributes","cluster-id":"41bb0e70b7cc8cd7","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-17T02:31:45.131117Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-17T02:31:45.132019Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-17T02:31:45.132062Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-17T02:31:45.131084Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-17T02:31:45.133803Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"41bb0e70b7cc8cd7","local-member-id":"e150efd79fff46f8","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-17T02:31:45.133947Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-17T02:31:45.134023Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-17T02:31:45.139246Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
{"level":"info","ts":"2026-02-17T02:31:45.139843Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"}
{"level":"info","ts":"2026-02-17T02:31:45.141023Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"192.168.24.223:2379"}
{"level":"info","ts":"2026-02-17T02:31:45.141480Z","caller":"embed/serve.go:275","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-02-17T02:33:26.077219Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.074380466s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-17T02:33:26.078269Z","caller":"traceutil/trace.go:171","msg":"trace[818782199] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"1.075484161s","start":"2026-02-17T02:33:25.002657Z","end":"2026-02-17T02:33:26.078141Z","steps":["trace[818782199] 'process raft request'  (duration: 1.075045243s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:26.084219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:33:25.002584Z","time spent":"1.078758971s","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13760,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/calico-node-45dft\" mod_revision:603 > success:<request_put:<key:\"/registry/pods/kube-system/calico-node-45dft\" value_size:13708 >> failure:<request_range:<key:\"/registry/pods/kube-system/calico-node-45dft\" > >"}
{"level":"info","ts":"2026-02-17T02:33:26.085495Z","caller":"traceutil/trace.go:171","msg":"trace[877210470] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"684.925573ms","start":"2026-02-17T02:33:25.400552Z","end":"2026-02-17T02:33:26.085478Z","steps":["trace[877210470] 'process raft request'  (duration: 684.868218ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:26.085626Z","caller":"traceutil/trace.go:171","msg":"trace[1604601042] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:685; }","duration":"471.282034ms","start":"2026-02-17T02:33:25.614328Z","end":"2026-02-17T02:33:26.085610Z","steps":["trace[1604601042] 'read index received'  (duration: 463.157078ms)","trace[1604601042] 'applied index is now lower than readState.Index'  (duration: 8.123376ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:26.085634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:33:25.400526Z","time spent":"685.040193ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:650 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:444 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-17T02:33:26.088093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.450078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:33:26.088182Z","caller":"traceutil/trace.go:171","msg":"trace[715870887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"275.543146ms","start":"2026-02-17T02:33:25.812625Z","end":"2026-02-17T02:33:26.088168Z","steps":["trace[715870887] 'agreement among raft nodes before linearized reading'  (duration: 275.433766ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:26.085705Z","caller":"traceutil/trace.go:171","msg":"trace[1207922867] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"945.277387ms","start":"2026-02-17T02:33:25.140382Z","end":"2026-02-17T02:33:26.085660Z","steps":["trace[1207922867] 'process raft request'  (duration: 944.893234ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:26.088348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:33:25.140357Z","time spent":"947.927184ms","remote":"127.0.0.1:55098","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/kube-scheduler\" mod_revision:649 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:425 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-17T02:33:26.086018Z","caller":"traceutil/trace.go:171","msg":"trace[2075269270] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"146.563361ms","start":"2026-02-17T02:33:25.939423Z","end":"2026-02-17T02:33:26.085986Z","steps":["trace[2075269270] 'process raft request'  (duration: 146.027715ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:26.086071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.735523ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:33:26.088573Z","caller":"traceutil/trace.go:171","msg":"trace[1447680466] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:659; }","duration":"474.245138ms","start":"2026-02-17T02:33:25.614316Z","end":"2026-02-17T02:33:26.088562Z","steps":["trace[1447680466] 'agreement among raft nodes before linearized reading'  (duration: 471.723982ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:28.255195Z","caller":"traceutil/trace.go:171","msg":"trace[722908062] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"195.445724ms","start":"2026-02-17T02:33:28.059728Z","end":"2026-02-17T02:33:28.255173Z","steps":["trace[722908062] 'process raft request'  (duration: 195.269889ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:28.261714Z","caller":"traceutil/trace.go:171","msg":"trace[1031394648] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"164.012394ms","start":"2026-02-17T02:33:28.097676Z","end":"2026-02-17T02:33:28.261689Z","steps":["trace[1031394648] 'process raft request'  (duration: 163.96012ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:28.262349Z","caller":"traceutil/trace.go:171","msg":"trace[1566172003] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"165.308732ms","start":"2026-02-17T02:33:28.097028Z","end":"2026-02-17T02:33:28.262337Z","steps":["trace[1566172003] 'process raft request'  (duration: 164.474883ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:34.325587Z","caller":"traceutil/trace.go:171","msg":"trace[832110600] linearizableReadLoop","detail":"{readStateIndex:737; appliedIndex:736; }","duration":"128.228798ms","start":"2026-02-17T02:33:34.197342Z","end":"2026-02-17T02:33:34.325571Z","steps":["trace[832110600] 'read index received'  (duration: 57.773549ms)","trace[832110600] 'applied index is now lower than readState.Index'  (duration: 70.452768ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:34.325717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.362209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/192.168.24.223\" limit:1 ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-17T02:33:34.325742Z","caller":"traceutil/trace.go:171","msg":"trace[419589780] range","detail":"{range_begin:/registry/masterleases/192.168.24.223; range_end:; response_count:1; response_revision:689; }","duration":"128.399671ms","start":"2026-02-17T02:33:34.197335Z","end":"2026-02-17T02:33:34.325735Z","steps":["trace[419589780] 'agreement among raft nodes before linearized reading'  (duration: 128.329236ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:34.325937Z","caller":"traceutil/trace.go:171","msg":"trace[1194480803] transaction","detail":"{read_only:false; number_of_response:0; response_revision:689; }","duration":"143.49329ms","start":"2026-02-17T02:33:34.182435Z","end":"2026-02-17T02:33:34.325929Z","steps":["trace[1194480803] 'process raft request'  (duration: 72.658381ms)","trace[1194480803] 'compare'  (duration: 70.440838ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:33:34.777053Z","caller":"traceutil/trace.go:171","msg":"trace[1199694430] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:744; }","duration":"161.233664ms","start":"2026-02-17T02:33:34.615788Z","end":"2026-02-17T02:33:34.777021Z","steps":["trace[1199694430] 'read index received'  (duration: 160.818541ms)","trace[1199694430] 'applied index is now lower than readState.Index'  (duration: 412.743µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:34.777298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.517866ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:33:34.777422Z","caller":"traceutil/trace.go:171","msg":"trace[374587058] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:692; }","duration":"161.666298ms","start":"2026-02-17T02:33:34.615741Z","end":"2026-02-17T02:33:34.777408Z","steps":["trace[374587058] 'agreement among raft nodes before linearized reading'  (duration: 161.442701ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:34.777873Z","caller":"traceutil/trace.go:171","msg":"trace[1902459752] transaction","detail":"{read_only:false; number_of_response:0; response_revision:692; }","duration":"225.63089ms","start":"2026-02-17T02:33:34.552226Z","end":"2026-02-17T02:33:34.777857Z","steps":["trace[1902459752] 'process raft request'  (duration: 224.663575ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:34.924136Z","caller":"traceutil/trace.go:171","msg":"trace[260704806] linearizableReadLoop","detail":"{readStateIndex:746; appliedIndex:745; }","duration":"106.402695ms","start":"2026-02-17T02:33:34.817712Z","end":"2026-02-17T02:33:34.924115Z","steps":["trace[260704806] 'read index received'  (duration: 106.252203ms)","trace[260704806] 'applied index is now lower than readState.Index'  (duration: 149.392µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:34.924274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.547676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:33:34.924253Z","caller":"traceutil/trace.go:171","msg":"trace[1398765907] transaction","detail":"{read_only:false; number_of_response:0; response_revision:692; }","duration":"121.438318ms","start":"2026-02-17T02:33:34.802734Z","end":"2026-02-17T02:33:34.924172Z","steps":["trace[1398765907] 'process raft request'  (duration: 121.292017ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:34.924298Z","caller":"traceutil/trace.go:171","msg":"trace[298377051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:692; }","duration":"106.587919ms","start":"2026-02-17T02:33:34.817703Z","end":"2026-02-17T02:33:34.924291Z","steps":["trace[298377051] 'agreement among raft nodes before linearized reading'  (duration: 106.527484ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:35.052184Z","caller":"traceutil/trace.go:171","msg":"trace[1763533896] transaction","detail":"{read_only:false; number_of_response:0; response_revision:692; }","duration":"114.73933ms","start":"2026-02-17T02:33:34.937412Z","end":"2026-02-17T02:33:35.052151Z","steps":["trace[1763533896] 'process raft request'  (duration: 114.578298ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:07.115272Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5114009353551697590,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T02:34:07.549171Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.001433198s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-17T02:34:07.550202Z","caller":"traceutil/trace.go:171","msg":"trace[315310335] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"1.002607552s","start":"2026-02-17T02:34:06.547566Z","end":"2026-02-17T02:34:07.550174Z","steps":["trace[315310335] 'process raft request'  (duration: 1.002352373s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:07.552442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:06.547540Z","time spent":"1.002760741s","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:750 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:444 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:34:07.610557Z","caller":"traceutil/trace.go:171","msg":"trace[880169540] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"1.057208826s","start":"2026-02-17T02:34:06.553319Z","end":"2026-02-17T02:34:07.610528Z","steps":["trace[880169540] 'process raft request'  (duration: 1.03868633s)","trace[880169540] 'compare'  (duration: 18.307605ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:34:07.611009Z","caller":"traceutil/trace.go:171","msg":"trace[216487272] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"318.358759ms","start":"2026-02-17T02:34:07.292639Z","end":"2026-02-17T02:34:07.610998Z","steps":["trace[216487272] 'process raft request'  (duration: 317.794972ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:07.611104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:06.553300Z","time spent":"1.057675765s","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:751 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:426 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-17T02:34:07.611174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:07.292577Z","time spent":"318.538143ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":577,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/kube-pbufp-hvtv8-zr8wz\" mod_revision:735 > success:<request_put:<key:\"/registry/leases/kube-node-lease/kube-pbufp-hvtv8-zr8wz\" value_size:514 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/kube-pbufp-hvtv8-zr8wz\" > >"}
{"level":"info","ts":"2026-02-17T02:34:07.610798Z","caller":"traceutil/trace.go:171","msg":"trace[13784798] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:845; }","duration":"996.169697ms","start":"2026-02-17T02:34:06.614601Z","end":"2026-02-17T02:34:07.610771Z","steps":["trace[13784798] 'read index received'  (duration: 935.196995ms)","trace[13784798] 'applied index is now lower than readState.Index'  (duration: 60.970222ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:34:07.610909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.300911ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:07.611337Z","caller":"traceutil/trace.go:171","msg":"trace[1150334984] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:755; }","duration":"996.742746ms","start":"2026-02-17T02:34:06.614586Z","end":"2026-02-17T02:34:07.611329Z","steps":["trace[1150334984] 'agreement among raft nodes before linearized reading'  (duration: 996.262895ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:07.611547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.742964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:07.611570Z","caller":"traceutil/trace.go:171","msg":"trace[542913067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:755; }","duration":"797.768448ms","start":"2026-02-17T02:34:06.813795Z","end":"2026-02-17T02:34:07.611563Z","steps":["trace[542913067] 'agreement among raft nodes before linearized reading'  (duration: 797.72445ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:07.611592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:06.813768Z","time spent":"797.817107ms","remote":"127.0.0.1:54874","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-02-17T02:34:14.116131Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5114009353551697625,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T02:34:14.519053Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.209241658s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-17T02:34:14.519908Z","caller":"traceutil/trace.go:171","msg":"trace[1233828268] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"1.210312042s","start":"2026-02-17T02:34:13.309574Z","end":"2026-02-17T02:34:14.519886Z","steps":["trace[1233828268] 'process raft request'  (duration: 1.210119669s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:14.520428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:13.309545Z","time spent":"1.210527559s","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14287,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/calico-node-45dft\" mod_revision:749 > success:<request_put:<key:\"/registry/pods/kube-system/calico-node-45dft\" value_size:14235 >> failure:<request_range:<key:\"/registry/pods/kube-system/calico-node-45dft\" > >"}
{"level":"info","ts":"2026-02-17T02:34:14.821464Z","caller":"traceutil/trace.go:171","msg":"trace[513043802] linearizableReadLoop","detail":"{readStateIndex:859; appliedIndex:857; }","duration":"1.206394609s","start":"2026-02-17T02:34:13.615049Z","end":"2026-02-17T02:34:14.821444Z","steps":["trace[513043802] 'read index received'  (duration: 905.552702ms)","trace[513043802] 'applied index is now lower than readState.Index'  (duration: 300.840417ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:34:14.821966Z","caller":"traceutil/trace.go:171","msg":"trace[1749776641] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"1.199506263s","start":"2026-02-17T02:34:13.622449Z","end":"2026-02-17T02:34:14.821956Z","steps":["trace[1749776641] 'process raft request'  (duration: 1.19884154s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:14.822080Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:13.622426Z","time spent":"1.199590118s","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:758 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:444 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:34:14.822261Z","caller":"traceutil/trace.go:171","msg":"trace[61850340] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"1.166995304s","start":"2026-02-17T02:34:13.655255Z","end":"2026-02-17T02:34:14.822251Z","steps":["trace[61850340] 'process raft request'  (duration: 1.16615349s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:14.822314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:13.655220Z","time spent":"1.167066276s","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:759 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:426 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-17T02:34:14.822439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.20739226s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:14.822465Z","caller":"traceutil/trace.go:171","msg":"trace[1057171511] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:765; }","duration":"1.207419594s","start":"2026-02-17T02:34:13.615038Z","end":"2026-02-17T02:34:14.822458Z","steps":["trace[1057171511] 'agreement among raft nodes before linearized reading'  (duration: 1.207375777s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:14.822831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008330894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:14.822893Z","caller":"traceutil/trace.go:171","msg":"trace[1336367089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"1.008393775s","start":"2026-02-17T02:34:13.814491Z","end":"2026-02-17T02:34:14.822884Z","steps":["trace[1336367089] 'agreement among raft nodes before linearized reading'  (duration: 1.008309451s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:14.822923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:13.814471Z","time spent":"1.008442003s","remote":"127.0.0.1:54874","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-02-17T02:34:14.823305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.433293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/192.168.24.223\" limit:1 ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-17T02:34:14.823991Z","caller":"traceutil/trace.go:171","msg":"trace[574257357] range","detail":"{range_begin:/registry/masterleases/192.168.24.223; range_end:; response_count:1; response_revision:765; }","duration":"624.1188ms","start":"2026-02-17T02:34:14.199862Z","end":"2026-02-17T02:34:14.823981Z","steps":["trace[574257357] 'agreement among raft nodes before linearized reading'  (duration: 623.408978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:14.824023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:14.199839Z","time spent":"624.174179ms","remote":"127.0.0.1:54894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/192.168.24.223\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:34:14.823347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.933325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:34:14.824218Z","caller":"traceutil/trace.go:171","msg":"trace[816350366] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:765; }","duration":"254.801164ms","start":"2026-02-17T02:34:14.569407Z","end":"2026-02-17T02:34:14.824209Z","steps":["trace[816350366] 'agreement among raft nodes before linearized reading'  (duration: 253.917043ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:14.823478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.431963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipaddresses/\" range_end:\"/registry/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:34:14.824459Z","caller":"traceutil/trace.go:171","msg":"trace[1599705493] range","detail":"{range_begin:/registry/ipaddresses/; range_end:/registry/ipaddresses0; response_count:0; response_revision:765; }","duration":"764.413771ms","start":"2026-02-17T02:34:14.060006Z","end":"2026-02-17T02:34:14.824421Z","steps":["trace[1599705493] 'agreement among raft nodes before linearized reading'  (duration: 763.367372ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:14.824630Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:14.059971Z","time spent":"764.614685ms","remote":"127.0.0.1:55144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":3,"response size":30,"request content":"key:\"/registry/ipaddresses/\" range_end:\"/registry/ipaddresses0\" count_only:true "}
{"level":"warn","ts":"2026-02-17T02:34:15.217382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.919741ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551697633 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:46f89c69707956e0>","response":"size:40"}
{"level":"info","ts":"2026-02-17T02:34:15.217701Z","caller":"traceutil/trace.go:171","msg":"trace[273178128] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"169.848234ms","start":"2026-02-17T02:34:15.047833Z","end":"2026-02-17T02:34:15.217681Z","steps":["trace[273178128] 'process raft request'  (duration: 169.70226ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:34:15.217980Z","caller":"traceutil/trace.go:171","msg":"trace[226263548] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:859; }","duration":"391.983276ms","start":"2026-02-17T02:34:14.825958Z","end":"2026-02-17T02:34:15.217942Z","steps":["trace[226263548] 'read index received'  (duration: 63.179925ms)","trace[226263548] 'applied index is now lower than readState.Index'  (duration: 328.799ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:34:15.217996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:14.825606Z","time spent":"392.382544ms","remote":"127.0.0.1:54894","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-17T02:34:15.218191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.222686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:15.218276Z","caller":"traceutil/trace.go:171","msg":"trace[1132546987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:766; }","duration":"392.30933ms","start":"2026-02-17T02:34:14.825952Z","end":"2026-02-17T02:34:15.218261Z","steps":["trace[1132546987] 'agreement among raft nodes before linearized reading'  (duration: 392.198552ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:15.218314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:14.825943Z","time spent":"392.36094ms","remote":"127.0.0.1:54880","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-02-17T02:34:15.270254Z","caller":"traceutil/trace.go:171","msg":"trace[1692073101] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"102.950002ms","start":"2026-02-17T02:34:15.167282Z","end":"2026-02-17T02:34:15.270232Z","steps":["trace[1692073101] 'process raft request'  (duration: 102.830702ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:34:15.538394Z","caller":"traceutil/trace.go:171","msg":"trace[2059792351] linearizableReadLoop","detail":"{readStateIndex:864; appliedIndex:862; }","duration":"310.335249ms","start":"2026-02-17T02:34:15.228038Z","end":"2026-02-17T02:34:15.538373Z","steps":["trace[2059792351] 'read index received'  (duration: 42.237424ms)","trace[2059792351] 'applied index is now lower than readState.Index'  (duration: 268.096135ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:34:15.538539Z","caller":"traceutil/trace.go:171","msg":"trace[265468212] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"316.616218ms","start":"2026-02-17T02:34:15.221898Z","end":"2026-02-17T02:34:15.538514Z","steps":["trace[265468212] 'process raft request'  (duration: 316.428146ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:15.538799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:15.221872Z","time spent":"316.856289ms","remote":"127.0.0.1:54894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/masterleases/192.168.24.223\" mod_revision:747 > success:<request_put:<key:\"/registry/masterleases/192.168.24.223\" value_size:67 lease:5114009353551697632 >> failure:<request_range:<key:\"/registry/masterleases/192.168.24.223\" > >"}
{"level":"info","ts":"2026-02-17T02:34:15.540186Z","caller":"traceutil/trace.go:171","msg":"trace[1206199404] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"370.17282ms","start":"2026-02-17T02:34:15.168285Z","end":"2026-02-17T02:34:15.538458Z","steps":["trace[1206199404] 'process raft request'  (duration: 369.879591ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:15.540588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:15.168225Z","time spent":"372.089093ms","remote":"127.0.0.1:55040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4944,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/kube-pbufp-hvtv8-zr8wz\" mod_revision:729 > success:<request_put:<key:\"/registry/minions/kube-pbufp-hvtv8-zr8wz\" value_size:4896 >> failure:<request_range:<key:\"/registry/minions/kube-pbufp-hvtv8-zr8wz\" > >"}
{"level":"warn","ts":"2026-02-17T02:34:15.540934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.434603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:15.542712Z","caller":"traceutil/trace.go:171","msg":"trace[2085151506] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:769; }","duration":"314.660158ms","start":"2026-02-17T02:34:15.228032Z","end":"2026-02-17T02:34:15.542692Z","steps":["trace[2085151506] 'agreement among raft nodes before linearized reading'  (duration: 310.506888ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:15.542807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:15.228023Z","time spent":"314.773497ms","remote":"127.0.0.1:54874","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-02-17T02:34:15.849518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.217691ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:15.849626Z","caller":"traceutil/trace.go:171","msg":"trace[1982661304] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:769; }","duration":"234.345703ms","start":"2026-02-17T02:34:15.615262Z","end":"2026-02-17T02:34:15.849608Z","steps":["trace[1982661304] 'range keys from in-memory index tree'  (duration: 234.164093ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:34:15.850026Z","caller":"traceutil/trace.go:171","msg":"trace[174689114] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"296.337718ms","start":"2026-02-17T02:34:15.553678Z","end":"2026-02-17T02:34:15.850015Z","steps":["trace[174689114] 'process raft request'  (duration: 255.285525ms)","trace[174689114] 'compare'  (duration: 40.942715ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:34:32.592590Z","caller":"traceutil/trace.go:171","msg":"trace[161007364] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"202.732622ms","start":"2026-02-17T02:34:32.389826Z","end":"2026-02-17T02:34:32.592559Z","steps":["trace[161007364] 'process raft request'  (duration: 202.381703ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:32.934421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.057436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ipamblocks/\" range_end:\"/registry/crd.projectcalico.org/ipamblocks0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:34:32.934724Z","caller":"traceutil/trace.go:171","msg":"trace[1666854424] range","detail":"{range_begin:/registry/crd.projectcalico.org/ipamblocks/; range_end:/registry/crd.projectcalico.org/ipamblocks0; response_count:0; response_revision:911; }","duration":"121.430178ms","start":"2026-02-17T02:34:32.813266Z","end":"2026-02-17T02:34:32.934696Z","steps":["trace[1666854424] 'count revisions from in-memory index tree'  (duration: 120.798341ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:32.934455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.339879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:32.935919Z","caller":"traceutil/trace.go:171","msg":"trace[1272433216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:911; }","duration":"120.813343ms","start":"2026-02-17T02:34:32.815085Z","end":"2026-02-17T02:34:32.935899Z","steps":["trace[1272433216] 'range keys from in-memory index tree'  (duration: 119.217313ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:34:34.993875Z","caller":"traceutil/trace.go:171","msg":"trace[1103446327] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"165.241318ms","start":"2026-02-17T02:34:34.828599Z","end":"2026-02-17T02:34:34.993841Z","steps":["trace[1103446327] 'process raft request'  (duration: 164.996605ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:34:35.764589Z","caller":"traceutil/trace.go:171","msg":"trace[1388509140] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"125.741577ms","start":"2026-02-17T02:34:35.638818Z","end":"2026-02-17T02:34:35.764560Z","steps":["trace[1388509140] 'process raft request'  (duration: 125.476771ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:36.173883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.865961ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551698012 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/calico-node-pvcvk.1894e80832bfaee4\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/calico-node-pvcvk.1894e80832bfaee4\" value_size:793 lease:5114009353551697555 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:34:36.174069Z","caller":"traceutil/trace.go:171","msg":"trace[2116294910] linearizableReadLoop","detail":"{readStateIndex:1028; appliedIndex:1027; }","duration":"356.372483ms","start":"2026-02-17T02:34:35.817676Z","end":"2026-02-17T02:34:36.174048Z","steps":["trace[2116294910] 'read index received'  (duration: 94.19374ms)","trace[2116294910] 'applied index is now lower than readState.Index'  (duration: 262.175772ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:34:36.174717Z","caller":"traceutil/trace.go:171","msg":"trace[431639001] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"494.745135ms","start":"2026-02-17T02:34:35.679853Z","end":"2026-02-17T02:34:36.174599Z","steps":["trace[431639001] 'process raft request'  (duration: 232.094139ms)","trace[431639001] 'compare'  (duration: 261.660354ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:34:36.174801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:35.679815Z","time spent":"494.953503ms","remote":"127.0.0.1:54958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":874,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/calico-node-pvcvk.1894e80832bfaee4\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/calico-node-pvcvk.1894e80832bfaee4\" value_size:793 lease:5114009353551697555 >> failure:<>"}
{"level":"warn","ts":"2026-02-17T02:34:36.174920Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.710076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/caliconodestatuses/\" range_end:\"/registry/crd.projectcalico.org/caliconodestatuses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:36.175077Z","caller":"traceutil/trace.go:171","msg":"trace[1674388933] range","detail":"{range_begin:/registry/crd.projectcalico.org/caliconodestatuses/; range_end:/registry/crd.projectcalico.org/caliconodestatuses0; response_count:0; response_revision:927; }","duration":"169.88583ms","start":"2026-02-17T02:34:36.005168Z","end":"2026-02-17T02:34:36.175053Z","steps":["trace[1674388933] 'agreement among raft nodes before linearized reading'  (duration: 169.603242ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:36.175722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.257701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:34:36.176910Z","caller":"traceutil/trace.go:171","msg":"trace[1917159760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:927; }","duration":"358.210037ms","start":"2026-02-17T02:34:35.817666Z","end":"2026-02-17T02:34:36.175876Z","steps":["trace[1917159760] 'agreement among raft nodes before linearized reading'  (duration: 357.198543ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:36.177031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:34:35.817637Z","time spent":"359.365401ms","remote":"127.0.0.1:54874","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-02-17T02:34:37.572651Z","caller":"traceutil/trace.go:171","msg":"trace[466348520] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"136.165222ms","start":"2026-02-17T02:34:37.436455Z","end":"2026-02-17T02:34:37.572620Z","steps":["trace[466348520] 'process raft request'  (duration: 135.8458ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:34:37.908974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.220468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" limit:1 ","response":"range_response_count:1 size:3927"}
{"level":"info","ts":"2026-02-17T02:34:37.909111Z","caller":"traceutil/trace.go:171","msg":"trace[92379380] range","detail":"{range_begin:/registry/minions/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf; range_end:; response_count:1; response_revision:936; }","duration":"255.371648ms","start":"2026-02-17T02:34:37.653716Z","end":"2026-02-17T02:34:37.909088Z","steps":["trace[92379380] 'range keys from in-memory index tree'  (duration: 254.966435ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:35:11.736995Z","caller":"traceutil/trace.go:171","msg":"trace[1420164183] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"284.749898ms","start":"2026-02-17T02:35:11.452204Z","end":"2026-02-17T02:35:11.736954Z","steps":["trace[1420164183] 'process raft request'  (duration: 284.416222ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:35:11.980730Z","caller":"traceutil/trace.go:171","msg":"trace[1131609328] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"364.807098ms","start":"2026-02-17T02:35:11.615755Z","end":"2026-02-17T02:35:11.980561Z","steps":["trace[1131609328] 'read index received'  (duration: 123.052249ms)","trace[1131609328] 'applied index is now lower than readState.Index'  (duration: 241.752029ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:35:11.980754Z","caller":"traceutil/trace.go:171","msg":"trace[1784295426] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"443.433154ms","start":"2026-02-17T02:35:11.537278Z","end":"2026-02-17T02:35:11.980711Z","steps":["trace[1784295426] 'process raft request'  (duration: 433.247884ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:35:11.981011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.255987ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:35:11.981046Z","caller":"traceutil/trace.go:171","msg":"trace[467607498] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1051; }","duration":"365.309313ms","start":"2026-02-17T02:35:11.615722Z","end":"2026-02-17T02:35:11.981031Z","steps":["trace[467607498] 'agreement among raft nodes before linearized reading'  (duration: 365.220664ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:35:11.981115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.937698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-17T02:35:11.981150Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:35:11.537250Z","time spent":"443.775291ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1047 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:444 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:35:11.981181Z","caller":"traceutil/trace.go:171","msg":"trace[1555654257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1051; }","duration":"166.036148ms","start":"2026-02-17T02:35:11.815125Z","end":"2026-02-17T02:35:11.981161Z","steps":["trace[1555654257] 'agreement among raft nodes before linearized reading'  (duration: 165.857109ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:35:17.805952Z","caller":"traceutil/trace.go:171","msg":"trace[2118853191] linearizableReadLoop","detail":"{readStateIndex:1174; appliedIndex:1173; }","duration":"191.517017ms","start":"2026-02-17T02:35:17.614410Z","end":"2026-02-17T02:35:17.805927Z","steps":["trace[2118853191] 'read index received'  (duration: 191.35085ms)","trace[2118853191] 'applied index is now lower than readState.Index'  (duration: 163.397µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:35:17.806103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.672184ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:35:17.806133Z","caller":"traceutil/trace.go:171","msg":"trace[665828255] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1063; }","duration":"191.72881ms","start":"2026-02-17T02:35:17.614395Z","end":"2026-02-17T02:35:17.806123Z","steps":["trace[665828255] 'agreement among raft nodes before linearized reading'  (duration: 191.653922ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:35:17.807102Z","caller":"traceutil/trace.go:171","msg":"trace[1255390328] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"295.546641ms","start":"2026-02-17T02:35:17.511542Z","end":"2026-02-17T02:35:17.807089Z","steps":["trace[1255390328] 'process raft request'  (duration: 294.081796ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:35:18.599777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.889749ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551698364 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1057 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:426 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:35:18.600046Z","caller":"traceutil/trace.go:171","msg":"trace[2049241826] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"588.61844ms","start":"2026-02-17T02:35:18.011412Z","end":"2026-02-17T02:35:18.600031Z","steps":["trace[2049241826] 'process raft request'  (duration: 588.477635ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:35:18.600122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:35:18.011383Z","time spent":"588.711431ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":503,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1058 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:443 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:35:18.600512Z","caller":"traceutil/trace.go:171","msg":"trace[965843174] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"833.271024ms","start":"2026-02-17T02:35:17.767232Z","end":"2026-02-17T02:35:18.600503Z","steps":["trace[965843174] 'process raft request'  (duration: 220.374179ms)","trace[965843174] 'compare'  (duration: 578.079463ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:35:18.600616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:35:17.767199Z","time spent":"833.394907ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1057 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:426 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-17T02:35:18.600987Z","caller":"traceutil/trace.go:171","msg":"trace[1927539027] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1174; }","duration":"784.213245ms","start":"2026-02-17T02:35:17.816659Z","end":"2026-02-17T02:35:18.600872Z","steps":["trace[1927539027] 'read index received'  (duration: 171.515301ms)","trace[1927539027] 'applied index is now lower than readState.Index'  (duration: 612.695973ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:35:18.601458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.826839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:35:18.601573Z","caller":"traceutil/trace.go:171","msg":"trace[2139174394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1065; }","duration":"784.861534ms","start":"2026-02-17T02:35:17.816619Z","end":"2026-02-17T02:35:18.601481Z","steps":["trace[2139174394] 'agreement among raft nodes before linearized reading'  (duration: 784.718129ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:35:18.601552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.923472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/kube-pbufp-hvtv8-zr8wz\" limit:1 ","response":"range_response_count:1 size:5706"}
{"level":"info","ts":"2026-02-17T02:35:18.601630Z","caller":"traceutil/trace.go:171","msg":"trace[692497199] range","detail":"{range_begin:/registry/minions/kube-pbufp-hvtv8-zr8wz; range_end:; response_count:1; response_revision:1065; }","duration":"132.013441ms","start":"2026-02-17T02:35:18.469596Z","end":"2026-02-17T02:35:18.601609Z","steps":["trace[692497199] 'agreement among raft nodes before linearized reading'  (duration: 131.847304ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:35:18.601739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:35:17.816588Z","time spent":"785.142373ms","remote":"127.0.0.1:54874","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-02-17T02:35:52.742017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.764514ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:35:52.742174Z","caller":"traceutil/trace.go:171","msg":"trace[725696531] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1167; }","duration":"127.11013ms","start":"2026-02-17T02:35:52.615038Z","end":"2026-02-17T02:35:52.742148Z","steps":["trace[725696531] 'range keys from in-memory index tree'  (duration: 126.696846ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:35:52.976491Z","caller":"traceutil/trace.go:171","msg":"trace[1815238395] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"142.716919ms","start":"2026-02-17T02:35:52.833712Z","end":"2026-02-17T02:35:52.976429Z","steps":["trace[1815238395] 'process raft request'  (duration: 110.46812ms)","trace[1815238395] 'compare'  (duration: 32.138823ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:38:16.492441Z","caller":"traceutil/trace.go:171","msg":"trace[823586861] transaction","detail":"{read_only:false; response_revision:1544; number_of_response:1; }","duration":"168.041832ms","start":"2026-02-17T02:38:16.324318Z","end":"2026-02-17T02:38:16.492360Z","steps":["trace[823586861] 'process raft request'  (duration: 167.841758ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:38:17.553747Z","caller":"traceutil/trace.go:171","msg":"trace[739494024] linearizableReadLoop","detail":"{readStateIndex:1708; appliedIndex:1707; }","duration":"126.934986ms","start":"2026-02-17T02:38:17.426782Z","end":"2026-02-17T02:38:17.553717Z","steps":["trace[739494024] 'read index received'  (duration: 67.278215ms)","trace[739494024] 'applied index is now lower than readState.Index'  (duration: 59.654011ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:38:17.554948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.149509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/kube-pbufp-default-worker-7hjxz-m6tmm-kb8cf\" limit:1 ","response":"range_response_count:1 size:978"}
{"level":"info","ts":"2026-02-17T02:38:17.555046Z","caller":"traceutil/trace.go:171","msg":"trace[648675911] range","detail":"{range_begin:/registry/csinodes/kube-pbufp-default-worker-7hjxz-m6tmm-kb8cf; range_end:; response_count:1; response_revision:1553; }","duration":"128.254396ms","start":"2026-02-17T02:38:17.426774Z","end":"2026-02-17T02:38:17.555028Z","steps":["trace[648675911] 'agreement among raft nodes before linearized reading'  (duration: 127.332733ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:38:17.553914Z","caller":"traceutil/trace.go:171","msg":"trace[1090905980] transaction","detail":"{read_only:false; response_revision:1553; number_of_response:1; }","duration":"144.210284ms","start":"2026-02-17T02:38:17.409669Z","end":"2026-02-17T02:38:17.553879Z","steps":["trace[1090905980] 'process raft request'  (duration: 84.442096ms)","trace[1090905980] 'compare'  (duration: 59.278495ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:38:19.657391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.325437ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551699832 > lease_revoke:<id:46f89c6970795eb0>","response":"size:28"}
{"level":"info","ts":"2026-02-17T02:38:33.578585Z","caller":"traceutil/trace.go:171","msg":"trace[209623886] transaction","detail":"{read_only:false; response_revision:1707; number_of_response:1; }","duration":"108.814235ms","start":"2026-02-17T02:38:33.469733Z","end":"2026-02-17T02:38:33.578547Z","steps":["trace[209623886] 'process raft request'  (duration: 81.898934ms)","trace[209623886] 'compare'  (duration: 26.75674ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:38:33.697003Z","caller":"traceutil/trace.go:171","msg":"trace[1018233196] linearizableReadLoop","detail":"{readStateIndex:1873; appliedIndex:1871; }","duration":"192.31922ms","start":"2026-02-17T02:38:33.504651Z","end":"2026-02-17T02:38:33.696970Z","steps":["trace[1018233196] 'read index received'  (duration: 47.11637ms)","trace[1018233196] 'applied index is now lower than readState.Index'  (duration: 145.20054ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:38:33.697356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.675006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-kube-pbufp-hvtv8-zr8wz\" limit:1 ","response":"range_response_count:1 size:5461"}
{"level":"info","ts":"2026-02-17T02:38:33.697676Z","caller":"traceutil/trace.go:171","msg":"trace[546391321] range","detail":"{range_begin:/registry/pods/kube-system/etcd-kube-pbufp-hvtv8-zr8wz; range_end:; response_count:1; response_revision:1708; }","duration":"193.009429ms","start":"2026-02-17T02:38:33.504640Z","end":"2026-02-17T02:38:33.697650Z","steps":["trace[546391321] 'agreement among raft nodes before linearized reading'  (duration: 192.571538ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:38:33.697363Z","caller":"traceutil/trace.go:171","msg":"trace[1872207568] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"204.035714ms","start":"2026-02-17T02:38:33.493221Z","end":"2026-02-17T02:38:33.697256Z","steps":["trace[1872207568] 'process raft request'  (duration: 200.176003ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:33.704685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.389015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-kube-pbufp-hvtv8-zr8wz\" limit:1 ","response":"range_response_count:1 size:5461"}
{"level":"info","ts":"2026-02-17T02:38:33.704781Z","caller":"traceutil/trace.go:171","msg":"trace[833175778] range","detail":"{range_begin:/registry/pods/kube-system/etcd-kube-pbufp-hvtv8-zr8wz; range_end:; response_count:1; response_revision:1708; }","duration":"197.478074ms","start":"2026-02-17T02:38:33.507284Z","end":"2026-02-17T02:38:33.704762Z","steps":["trace[833175778] 'agreement among raft nodes before linearized reading'  (duration: 190.334922ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:38:45.870081Z","caller":"traceutil/trace.go:171","msg":"trace[1710756728] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"140.846869ms","start":"2026-02-17T02:38:45.729208Z","end":"2026-02-17T02:38:45.870055Z","steps":["trace[1710756728] 'process raft request'  (duration: 140.543757ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:46.989754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.025333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/clusterinformations/default\" limit:1 ","response":"range_response_count:1 size:871"}
{"level":"info","ts":"2026-02-17T02:38:46.989875Z","caller":"traceutil/trace.go:171","msg":"trace[2059545831] range","detail":"{range_begin:/registry/crd.projectcalico.org/clusterinformations/default; range_end:; response_count:1; response_revision:1812; }","duration":"213.210426ms","start":"2026-02-17T02:38:46.776640Z","end":"2026-02-17T02:38:46.989851Z","steps":["trace[2059545831] 'range keys from in-memory index tree'  (duration: 212.729121ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:48.519351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.707833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:38:48.519435Z","caller":"traceutil/trace.go:171","msg":"trace[304954317] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1817; }","duration":"390.8031ms","start":"2026-02-17T02:38:48.128615Z","end":"2026-02-17T02:38:48.519419Z","steps":["trace[304954317] 'count revisions from in-memory index tree'  (duration: 390.637598ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:48.519468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:38:48.128599Z","time spent":"390.860984ms","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-02-17T02:38:48.520111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.015524ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551700393 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1794 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:443 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:38:48.520302Z","caller":"traceutil/trace.go:171","msg":"trace[798288703] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1992; }","duration":"321.239857ms","start":"2026-02-17T02:38:48.199034Z","end":"2026-02-17T02:38:48.520273Z","steps":["trace[798288703] 'read index received'  (duration: 174.863267ms)","trace[798288703] 'applied index is now lower than readState.Index'  (duration: 146.37302ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:38:48.521293Z","caller":"traceutil/trace.go:171","msg":"trace[1733317501] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"379.314221ms","start":"2026-02-17T02:38:48.141937Z","end":"2026-02-17T02:38:48.521252Z","steps":["trace[1733317501] 'process raft request'  (duration: 232.035115ms)","trace[1733317501] 'compare'  (duration: 144.994681ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:38:48.521871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:38:48.141888Z","time spent":"379.708909ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":503,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1794 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:443 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-17T02:38:48.522521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.520642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/clusterinformations/default\" limit:1 ","response":"range_response_count:1 size:871"}
{"level":"info","ts":"2026-02-17T02:38:48.522931Z","caller":"traceutil/trace.go:171","msg":"trace[751248493] range","detail":"{range_begin:/registry/crd.projectcalico.org/clusterinformations/default; range_end:; response_count:1; response_revision:1818; }","duration":"323.932192ms","start":"2026-02-17T02:38:48.198981Z","end":"2026-02-17T02:38:48.522913Z","steps":["trace[751248493] 'agreement among raft nodes before linearized reading'  (duration: 321.456543ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:48.524117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:38:48.198947Z","time spent":"325.107726ms","remote":"127.0.0.1:34752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":894,"request content":"key:\"/registry/crd.projectcalico.org/clusterinformations/default\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:38:50.133315Z","caller":"traceutil/trace.go:171","msg":"trace[151382350] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"231.93361ms","start":"2026-02-17T02:38:49.901308Z","end":"2026-02-17T02:38:50.133242Z","steps":["trace[151382350] 'process raft request'  (duration: 231.751956ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:38:51.355758Z","caller":"traceutil/trace.go:171","msg":"trace[530008300] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"108.953465ms","start":"2026-02-17T02:38:51.246775Z","end":"2026-02-17T02:38:51.355728Z","steps":["trace[530008300] 'process raft request'  (duration: 108.74614ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:38:53.977142Z","caller":"traceutil/trace.go:171","msg":"trace[1024185211] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"346.41349ms","start":"2026-02-17T02:38:53.630588Z","end":"2026-02-17T02:38:53.977002Z","steps":["trace[1024185211] 'process raft request'  (duration: 346.225406ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:53.977349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:38:53.630556Z","time spent":"346.719963ms","remote":"127.0.0.1:54958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":900,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/sonobuoy/sonobuoy-systemd-logs-daemon-set-57fcc64e620f4a71-rmvzv.1894e844535f52c5\" mod_revision:0 > success:<request_put:<key:\"/registry/events/sonobuoy/sonobuoy-systemd-logs-daemon-set-57fcc64e620f4a71-rmvzv.1894e844535f52c5\" value_size:784 lease:5114009353551699949 >> failure:<>"}
{"level":"info","ts":"2026-02-17T02:38:53.979471Z","caller":"traceutil/trace.go:171","msg":"trace[1295638193] linearizableReadLoop","detail":"{readStateIndex:2050; appliedIndex:2050; }","duration":"291.105955ms","start":"2026-02-17T02:38:53.688343Z","end":"2026-02-17T02:38:53.979448Z","steps":["trace[1295638193] 'read index received'  (duration: 291.094214ms)","trace[1295638193] 'applied index is now lower than readState.Index'  (duration: 8.621µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:38:53.980241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.893333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/clusterinformations/default\" limit:1 ","response":"range_response_count:1 size:871"}
{"level":"info","ts":"2026-02-17T02:38:53.980634Z","caller":"traceutil/trace.go:171","msg":"trace[535465602] range","detail":"{range_begin:/registry/crd.projectcalico.org/clusterinformations/default; range_end:; response_count:1; response_revision:1871; }","duration":"292.291332ms","start":"2026-02-17T02:38:53.688311Z","end":"2026-02-17T02:38:53.980602Z","steps":["trace[535465602] 'agreement among raft nodes before linearized reading'  (duration: 291.216374ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:53.982732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.419544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:38:53.983004Z","caller":"traceutil/trace.go:171","msg":"trace[465242368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1872; }","duration":"167.692574ms","start":"2026-02-17T02:38:53.815300Z","end":"2026-02-17T02:38:53.982992Z","steps":["trace[465242368] 'agreement among raft nodes before linearized reading'  (duration: 167.305195ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:38:53.982910Z","caller":"traceutil/trace.go:171","msg":"trace[829256483] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"129.358274ms","start":"2026-02-17T02:38:53.853538Z","end":"2026-02-17T02:38:53.982896Z","steps":["trace[829256483] 'process raft request'  (duration: 128.857897ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:38:56.360536Z","caller":"traceutil/trace.go:171","msg":"trace[991053508] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"179.176965ms","start":"2026-02-17T02:38:56.181336Z","end":"2026-02-17T02:38:56.360513Z","steps":["trace[991053508] 'process raft request'  (duration: 178.990201ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:57.315409Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5114009353551700533,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T02:38:57.816559Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5114009353551700533,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T02:38:58.324294Z","caller":"etcdserver/v3_server.go:920","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5114009353551700533,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T02:38:58.442147Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.82003178s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-17T02:38:58.443695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.828320296s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:38:58.448070Z","caller":"traceutil/trace.go:171","msg":"trace[1179402772] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"1.826053951s","start":"2026-02-17T02:38:56.621991Z","end":"2026-02-17T02:38:58.448046Z","steps":["trace[1179402772] 'process raft request'  (duration: 1.820495624s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:58.448283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:38:56.621959Z","time spent":"1.826186881s","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1881 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:444 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:38:58.448846Z","caller":"traceutil/trace.go:171","msg":"trace[1047644045] linearizableReadLoop","detail":"{readStateIndex:2066; appliedIndex:2064; }","duration":"1.634331899s","start":"2026-02-17T02:38:56.814489Z","end":"2026-02-17T02:38:58.448821Z","steps":["trace[1047644045] 'read index received'  (duration: 1.62860932s)","trace[1047644045] 'applied index is now lower than readState.Index'  (duration: 5.721189ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:38:58.449347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.63488919s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:38:58.449404Z","caller":"traceutil/trace.go:171","msg":"trace[1395206760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1887; }","duration":"1.634954825s","start":"2026-02-17T02:38:56.814438Z","end":"2026-02-17T02:38:58.449393Z","steps":["trace[1395206760] 'agreement among raft nodes before linearized reading'  (duration: 1.634849807s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:58.449490Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:38:56.814406Z","time spent":"1.635074383s","remote":"127.0.0.1:54874","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-02-17T02:38:58.450810Z","caller":"traceutil/trace.go:171","msg":"trace[176206840] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"1.650791422s","start":"2026-02-17T02:38:56.798209Z","end":"2026-02-17T02:38:58.449001Z","steps":["trace[176206840] 'process raft request'  (duration: 1.650438476s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:58.451044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:38:56.798185Z","time spent":"1.652701492s","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cloud-controller-manager\" mod_revision:1882 > success:<request_put:<key:\"/registry/leases/kube-system/cloud-controller-manager\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/kube-system/cloud-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:38:58.451968Z","caller":"traceutil/trace.go:171","msg":"trace[856124202] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1884; }","duration":"1.836602853s","start":"2026-02-17T02:38:56.615342Z","end":"2026-02-17T02:38:58.451945Z","steps":["trace[856124202] 'range keys from in-memory index tree'  (duration: 1.828266502s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:58.452438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.154455637s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/felixconfigurations/\" range_end:\"/registry/crd.projectcalico.org/felixconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:38:58.452474Z","caller":"traceutil/trace.go:171","msg":"trace[1180825266] range","detail":"{range_begin:/registry/crd.projectcalico.org/felixconfigurations/; range_end:/registry/crd.projectcalico.org/felixconfigurations0; response_count:0; response_revision:1887; }","duration":"1.154489019s","start":"2026-02-17T02:38:57.297969Z","end":"2026-02-17T02:38:58.452459Z","steps":["trace[1180825266] 'agreement among raft nodes before linearized reading'  (duration: 1.154429195s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:38:58.452496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:38:57.297949Z","time spent":"1.154540224s","remote":"127.0.0.1:34792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":1,"response size":30,"request content":"key:\"/registry/crd.projectcalico.org/felixconfigurations/\" range_end:\"/registry/crd.projectcalico.org/felixconfigurations0\" count_only:true "}
{"level":"info","ts":"2026-02-17T02:39:00.675537Z","caller":"traceutil/trace.go:171","msg":"trace[1639598859] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"576.075693ms","start":"2026-02-17T02:39:00.099433Z","end":"2026-02-17T02:39:00.675509Z","steps":["trace[1639598859] 'process raft request'  (duration: 575.869318ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:00.675712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:00.099290Z","time spent":"576.346902ms","remote":"127.0.0.1:54958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":898,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/openstack-cinder-csi-controllerplugin-6cc795fb8b-jsgpn.1894e845d4f46a3f\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/openstack-cinder-csi-controllerplugin-6cc795fb8b-jsgpn.1894e845d4f46a3f\" value_size:780 lease:5114009353551699949 >> failure:<>"}
{"level":"info","ts":"2026-02-17T02:39:00.693559Z","caller":"traceutil/trace.go:171","msg":"trace[1350044445] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"369.705947ms","start":"2026-02-17T02:39:00.323825Z","end":"2026-02-17T02:39:00.693531Z","steps":["trace[1350044445] 'process raft request'  (duration: 368.777409ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:00.693731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:00.323793Z","time spent":"369.858859ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":661,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-kb8cf\" mod_revision:1830 > success:<request_put:<key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-kb8cf\" value_size:577 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-kb8cf\" > >"}
{"level":"info","ts":"2026-02-17T02:39:00.694706Z","caller":"traceutil/trace.go:171","msg":"trace[847943585] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"236.951842ms","start":"2026-02-17T02:39:00.457734Z","end":"2026-02-17T02:39:00.694686Z","steps":["trace[847943585] 'process raft request'  (duration: 235.345424ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:00.695818Z","caller":"traceutil/trace.go:171","msg":"trace[745945868] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"237.050949ms","start":"2026-02-17T02:39:00.458755Z","end":"2026-02-17T02:39:00.695806Z","steps":["trace[745945868] 'process raft request'  (duration: 236.333266ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:00.698127Z","caller":"traceutil/trace.go:171","msg":"trace[1160131776] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"238.368066ms","start":"2026-02-17T02:39:00.459747Z","end":"2026-02-17T02:39:00.698115Z","steps":["trace[1160131776] 'process raft request'  (duration: 235.758614ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:00.698847Z","caller":"traceutil/trace.go:171","msg":"trace[1737168951] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"187.818251ms","start":"2026-02-17T02:39:00.511019Z","end":"2026-02-17T02:39:00.698837Z","steps":["trace[1737168951] 'process raft request'  (duration: 187.411121ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:01.877274Z","caller":"traceutil/trace.go:171","msg":"trace[1058615314] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"228.492922ms","start":"2026-02-17T02:39:01.648751Z","end":"2026-02-17T02:39:01.877244Z","steps":["trace[1058615314] 'process raft request'  (duration: 227.765309ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:02.084676Z","caller":"traceutil/trace.go:171","msg":"trace[1797524833] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"186.081329ms","start":"2026-02-17T02:39:01.898566Z","end":"2026-02-17T02:39:02.084648Z","steps":["trace[1797524833] 'process raft request'  (duration: 185.807269ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:02.093462Z","caller":"traceutil/trace.go:171","msg":"trace[1464676138] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"181.948346ms","start":"2026-02-17T02:39:01.911489Z","end":"2026-02-17T02:39:02.093437Z","steps":["trace[1464676138] 'process raft request'  (duration: 181.812316ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:03.280168Z","caller":"traceutil/trace.go:171","msg":"trace[409297056] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"143.327933ms","start":"2026-02-17T02:39:03.136817Z","end":"2026-02-17T02:39:03.280145Z","steps":["trace[409297056] 'process raft request'  (duration: 143.192443ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:05.817412Z","caller":"traceutil/trace.go:171","msg":"trace[539620086] linearizableReadLoop","detail":"{readStateIndex:2135; appliedIndex:2134; }","duration":"257.977427ms","start":"2026-02-17T02:39:05.559410Z","end":"2026-02-17T02:39:05.817388Z","steps":["trace[539620086] 'read index received'  (duration: 257.684576ms)","trace[539620086] 'applied index is now lower than readState.Index'  (duration: 291.541µs)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:05.817660Z","caller":"traceutil/trace.go:171","msg":"trace[1076760688] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"302.609268ms","start":"2026-02-17T02:39:05.515040Z","end":"2026-02-17T02:39:05.817649Z","steps":["trace[1076760688] 'process raft request'  (duration: 302.174905ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:05.818082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.685099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:39:05.818387Z","caller":"traceutil/trace.go:171","msg":"trace[836865067] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1950; }","duration":"258.922706ms","start":"2026-02-17T02:39:05.559372Z","end":"2026-02-17T02:39:05.818295Z","steps":["trace[836865067] 'agreement among raft nodes before linearized reading'  (duration: 258.637545ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:05.818131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:05.515013Z","time spent":"302.672532ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9328,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/sonobuoy/sonobuoy-systemd-logs-daemon-set-57fcc64e620f4a71-2lbr4\" mod_revision:1867 > success:<request_put:<key:\"/registry/pods/sonobuoy/sonobuoy-systemd-logs-daemon-set-57fcc64e620f4a71-2lbr4\" value_size:9241 >> failure:<request_range:<key:\"/registry/pods/sonobuoy/sonobuoy-systemd-logs-daemon-set-57fcc64e620f4a71-2lbr4\" > >"}
{"level":"warn","ts":"2026-02-17T02:39:05.821304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.317863ms","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-02-17T02:39:05.821442Z","caller":"traceutil/trace.go:171","msg":"trace[450662451] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1950; }","duration":"233.458913ms","start":"2026-02-17T02:39:05.587972Z","end":"2026-02-17T02:39:05.821431Z","steps":["trace[450662451] 'agreement among raft nodes before linearized reading'  (duration: 233.110037ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:05.822853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.703145ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:05.825157Z","caller":"traceutil/trace.go:171","msg":"trace[726359563] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1950; }","duration":"209.555346ms","start":"2026-02-17T02:39:05.614821Z","end":"2026-02-17T02:39:05.824376Z","steps":["trace[726359563] 'agreement among raft nodes before linearized reading'  (duration: 206.687274ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:06.564099Z","caller":"traceutil/trace.go:171","msg":"trace[298384181] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"102.302113ms","start":"2026-02-17T02:39:06.461765Z","end":"2026-02-17T02:39:06.564067Z","steps":["trace[298384181] 'process raft request'  (duration: 101.957788ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:07.156975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.564118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:39:07.157458Z","caller":"traceutil/trace.go:171","msg":"trace[454968506] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1955; }","duration":"428.055315ms","start":"2026-02-17T02:39:06.729376Z","end":"2026-02-17T02:39:07.157432Z","steps":["trace[454968506] 'count revisions from in-memory index tree'  (duration: 427.44662ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:07.157946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:06.729349Z","time spent":"428.156322ms","remote":"127.0.0.1:55276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":30,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "}
{"level":"info","ts":"2026-02-17T02:39:07.161099Z","caller":"traceutil/trace.go:171","msg":"trace[2067561819] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"431.019524ms","start":"2026-02-17T02:39:06.730047Z","end":"2026-02-17T02:39:07.161066Z","steps":["trace[2067561819] 'process raft request'  (duration: 430.757555ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:07.161307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:06.730025Z","time spent":"431.176516ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1943 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:426 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-17T02:39:07.235377Z","caller":"traceutil/trace.go:171","msg":"trace[439116661] linearizableReadLoop","detail":"{readStateIndex:2144; appliedIndex:2140; }","duration":"100.773388ms","start":"2026-02-17T02:39:07.134579Z","end":"2026-02-17T02:39:07.235352Z","steps":["trace[439116661] 'read index received'  (duration: 26.201052ms)","trace[439116661] 'applied index is now lower than readState.Index'  (duration: 74.570876ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:07.235473Z","caller":"traceutil/trace.go:171","msg":"trace[145060138] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"502.686586ms","start":"2026-02-17T02:39:06.732758Z","end":"2026-02-17T02:39:07.235444Z","steps":["trace[145060138] 'process raft request'  (duration: 502.258514ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:07.235629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:06.732748Z","time spent":"502.797385ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1944 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:444 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:39:07.235830Z","caller":"traceutil/trace.go:171","msg":"trace[2005189973] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"499.418184ms","start":"2026-02-17T02:39:06.736403Z","end":"2026-02-17T02:39:07.235821Z","steps":["trace[2005189973] 'process raft request'  (duration: 498.836591ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:07.235899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:06.736391Z","time spent":"499.483079ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cloud-controller-manager\" mod_revision:1945 > success:<request_put:<key:\"/registry/leases/kube-system/cloud-controller-manager\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/kube-system/cloud-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:39:07.235972Z","caller":"traceutil/trace.go:171","msg":"trace[1936153842] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"122.049166ms","start":"2026-02-17T02:39:07.113916Z","end":"2026-02-17T02:39:07.235966Z","steps":["trace[1936153842] 'process raft request'  (duration: 121.370935ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:07.236056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.476751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:39:07.236080Z","caller":"traceutil/trace.go:171","msg":"trace[135974172] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1959; }","duration":"101.502903ms","start":"2026-02-17T02:39:07.134571Z","end":"2026-02-17T02:39:07.236074Z","steps":["trace[135974172] 'agreement among raft nodes before linearized reading'  (duration: 101.446639ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:16.543400Z","caller":"traceutil/trace.go:171","msg":"trace[1174576595] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"179.4345ms","start":"2026-02-17T02:39:16.363934Z","end":"2026-02-17T02:39:16.543368Z","steps":["trace[1174576595] 'process raft request'  (duration: 179.273408ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:16.587787Z","caller":"traceutil/trace.go:171","msg":"trace[282672494] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"201.158975ms","start":"2026-02-17T02:39:16.386601Z","end":"2026-02-17T02:39:16.587760Z","steps":["trace[282672494] 'process raft request'  (duration: 201.010274ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:16.760770Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.364555ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:16.760853Z","caller":"traceutil/trace.go:171","msg":"trace[486650233] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2063; }","duration":"146.458252ms","start":"2026-02-17T02:39:16.614378Z","end":"2026-02-17T02:39:16.760837Z","steps":["trace[486650233] 'range keys from in-memory index tree'  (duration: 146.332653ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:16.761845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.215566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/projected-2800/downwardapi-volume-34271a73-bd0b-4dc0-9b00-437e4284541c\" limit:1 ","response":"range_response_count:1 size:3604"}
{"level":"info","ts":"2026-02-17T02:39:16.761871Z","caller":"traceutil/trace.go:171","msg":"trace[1822241326] range","detail":"{range_begin:/registry/pods/projected-2800/downwardapi-volume-34271a73-bd0b-4dc0-9b00-437e4284541c; range_end:; response_count:1; response_revision:2063; }","duration":"138.246858ms","start":"2026-02-17T02:39:16.623617Z","end":"2026-02-17T02:39:16.761865Z","steps":["trace[1822241326] 'range keys from in-memory index tree'  (duration: 137.641632ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:17.631863Z","caller":"traceutil/trace.go:171","msg":"trace[278436710] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2257; }","duration":"166.203612ms","start":"2026-02-17T02:39:17.465634Z","end":"2026-02-17T02:39:17.631838Z","steps":["trace[278436710] 'read index received'  (duration: 95.243125ms)","trace[278436710] 'applied index is now lower than readState.Index'  (duration: 70.957337ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:17.631963Z","caller":"traceutil/trace.go:171","msg":"trace[830874721] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"300.887393ms","start":"2026-02-17T02:39:17.331024Z","end":"2026-02-17T02:39:17.631911Z","steps":["trace[830874721] 'process raft request'  (duration: 229.952008ms)","trace[830874721] 'compare'  (duration: 70.498632ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:17.632494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.84473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mygroup.example.com/foovnk4nas/mytest\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:17.633046Z","caller":"traceutil/trace.go:171","msg":"trace[1167408140] range","detail":"{range_begin:/registry/mygroup.example.com/foovnk4nas/mytest; range_end:; response_count:0; response_revision:2069; }","duration":"167.421693ms","start":"2026-02-17T02:39:17.465606Z","end":"2026-02-17T02:39:17.633028Z","steps":["trace[1167408140] 'agreement among raft nodes before linearized reading'  (duration: 166.461901ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:17.633325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:17.331000Z","time spent":"301.792341ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2050 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:444 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:39:17.633486Z","caller":"traceutil/trace.go:171","msg":"trace[370317092] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"302.180669ms","start":"2026-02-17T02:39:17.331285Z","end":"2026-02-17T02:39:17.633466Z","steps":["trace[370317092] 'process raft request'  (duration: 300.445609ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:17.633671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:17.331272Z","time spent":"302.3242ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cloud-controller-manager\" mod_revision:2051 > success:<request_put:<key:\"/registry/leases/kube-system/cloud-controller-manager\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/kube-system/cloud-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:39:17.921360Z","caller":"traceutil/trace.go:171","msg":"trace[1017074972] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2259; }","duration":"107.085693ms","start":"2026-02-17T02:39:17.814244Z","end":"2026-02-17T02:39:17.921329Z","steps":["trace[1017074972] 'read index received'  (duration: 84.7545ms)","trace[1017074972] 'applied index is now lower than readState.Index'  (duration: 22.328943ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:17.921525Z","caller":"traceutil/trace.go:171","msg":"trace[1746739284] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"275.702955ms","start":"2026-02-17T02:39:17.645805Z","end":"2026-02-17T02:39:17.921507Z","steps":["trace[1746739284] 'process raft request'  (duration: 253.267974ms)","trace[1746739284] 'compare'  (duration: 22.080414ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:17.921636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.371924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:17.921689Z","caller":"traceutil/trace.go:171","msg":"trace[531777497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2070; }","duration":"107.44307ms","start":"2026-02-17T02:39:17.814238Z","end":"2026-02-17T02:39:17.921681Z","steps":["trace[531777497] 'agreement among raft nodes before linearized reading'  (duration: 107.331151ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:18.336009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.88101ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551700921 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/foovnk4nas.mygroup.example.com\" mod_revision:2071 > success:<request_delete_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/foovnk4nas.mygroup.example.com\" > > failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/foovnk4nas.mygroup.example.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-17T02:39:18.336119Z","caller":"traceutil/trace.go:171","msg":"trace[219171112] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2072; }","duration":"330.721542ms","start":"2026-02-17T02:39:18.005380Z","end":"2026-02-17T02:39:18.336101Z","steps":["trace[219171112] 'process raft request'  (duration: 202.636497ms)","trace[219171112] 'compare'  (duration: 127.765221ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:18.336172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:18.005312Z","time spent":"330.837601ms","remote":"127.0.0.1:54922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":91,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/foovnk4nas.mygroup.example.com\" mod_revision:2071 > success:<request_delete_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/foovnk4nas.mygroup.example.com\" > > failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/foovnk4nas.mygroup.example.com\" > >"}
{"level":"warn","ts":"2026-02-17T02:39:18.601145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.190103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/field-validation-2676/deployment\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:18.601296Z","caller":"traceutil/trace.go:171","msg":"trace[1833871194] range","detail":"{range_begin:/registry/deployments/field-validation-2676/deployment; range_end:; response_count:0; response_revision:2074; }","duration":"158.363066ms","start":"2026-02-17T02:39:18.442909Z","end":"2026-02-17T02:39:18.601273Z","steps":["trace[1833871194] 'range keys from in-memory index tree'  (duration: 158.051272ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:24.038718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.362054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:24.038814Z","caller":"traceutil/trace.go:171","msg":"trace[416549481] range","detail":"{range_begin:/registry/serviceaccounts; range_end:; response_count:0; response_revision:2124; }","duration":"117.584641ms","start":"2026-02-17T02:39:23.921209Z","end":"2026-02-17T02:39:24.038793Z","steps":["trace[416549481] 'range keys from in-memory index tree'  (duration: 116.979976ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:24.271603Z","caller":"traceutil/trace.go:171","msg":"trace[1503176201] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"138.45059ms","start":"2026-02-17T02:39:24.133101Z","end":"2026-02-17T02:39:24.271552Z","steps":["trace[1503176201] 'process raft request'  (duration: 138.057731ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:24.570126Z","caller":"traceutil/trace.go:171","msg":"trace[1570880272] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"136.876981ms","start":"2026-02-17T02:39:24.433161Z","end":"2026-02-17T02:39:24.570038Z","steps":["trace[1570880272] 'process raft request'  (duration: 136.662715ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:24.572027Z","caller":"traceutil/trace.go:171","msg":"trace[1944265255] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"290.43816ms","start":"2026-02-17T02:39:24.281546Z","end":"2026-02-17T02:39:24.571985Z","steps":["trace[1944265255] 'read index received'  (duration: 249.745452ms)","trace[1944265255] 'applied index is now lower than readState.Index'  (duration: 40.687948ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:24.572846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.863172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/field-validation-2676\" limit:1 ","response":"range_response_count:1 size:2189"}
{"level":"info","ts":"2026-02-17T02:39:24.572971Z","caller":"traceutil/trace.go:171","msg":"trace[1235044677] range","detail":"{range_begin:/registry/namespaces/field-validation-2676; range_end:; response_count:1; response_revision:2126; }","duration":"291.419104ms","start":"2026-02-17T02:39:24.281537Z","end":"2026-02-17T02:39:24.572956Z","steps":["trace[1235044677] 'agreement among raft nodes before linearized reading'  (duration: 290.749784ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:25.172672Z","caller":"traceutil/trace.go:171","msg":"trace[764496410] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"243.879391ms","start":"2026-02-17T02:39:24.928739Z","end":"2026-02-17T02:39:25.172618Z","steps":["trace[764496410] 'process raft request'  (duration: 243.46642ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:25.325035Z","caller":"traceutil/trace.go:171","msg":"trace[725268640] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"102.766786ms","start":"2026-02-17T02:39:25.222232Z","end":"2026-02-17T02:39:25.324999Z","steps":["trace[725268640] 'process raft request'  (duration: 76.000176ms)","trace[725268640] 'compare'  (duration: 26.164865ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:25.519332Z","caller":"traceutil/trace.go:171","msg":"trace[1336536974] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"140.31543ms","start":"2026-02-17T02:39:25.378961Z","end":"2026-02-17T02:39:25.519277Z","steps":["trace[1336536974] 'process raft request'  (duration: 82.519108ms)","trace[1336536974] 'compare'  (duration: 57.454236ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:26.033218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.785702ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551701367 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008\" mod_revision:2137 > success:<request_put:<key:\"/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008\" value_size:1834 >> failure:<request_range:<key:\"/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:39:26.033332Z","caller":"traceutil/trace.go:171","msg":"trace[1643130652] linearizableReadLoop","detail":"{readStateIndex:2333; appliedIndex:2332; }","duration":"440.368629ms","start":"2026-02-17T02:39:25.592947Z","end":"2026-02-17T02:39:26.033315Z","steps":["trace[1643130652] 'read index received'  (duration: 247.409404ms)","trace[1643130652] 'applied index is now lower than readState.Index'  (duration: 192.957085ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:26.033406Z","caller":"traceutil/trace.go:171","msg":"trace[219908111] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"442.194617ms","start":"2026-02-17T02:39:25.591201Z","end":"2026-02-17T02:39:26.033396Z","steps":["trace[219908111] 'process raft request'  (duration: 249.138705ms)","trace[219908111] 'compare'  (duration: 192.667522ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:26.033471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:25.591089Z","time spent":"442.359219ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1930,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008\" mod_revision:2137 > success:<request_put:<key:\"/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008\" value_size:1834 >> failure:<request_range:<key:\"/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008\" > >"}
{"level":"warn","ts":"2026-02-17T02:39:26.034005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.992275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008\" limit:1 ","response":"range_response_count:1 size:1945"}
{"level":"info","ts":"2026-02-17T02:39:26.034100Z","caller":"traceutil/trace.go:171","msg":"trace[1692702089] range","detail":"{range_begin:/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008; range_end:; response_count:1; response_revision:2138; }","duration":"441.103824ms","start":"2026-02-17T02:39:25.592939Z","end":"2026-02-17T02:39:26.034043Z","steps":["trace[1692702089] 'agreement among raft nodes before linearized reading'  (duration: 440.959003ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:26.034177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:25.592916Z","time spent":"441.251605ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":1968,"request content":"key:\"/registry/pods/downward-api-6505/downwardapi-volume-31d4bd83-78d1-4aae-9933-84a13db8f008\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:39:26.038968Z","caller":"traceutil/trace.go:171","msg":"trace[1551191274] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"318.62572ms","start":"2026-02-17T02:39:25.720317Z","end":"2026-02-17T02:39:26.038943Z","steps":["trace[1551191274] 'process raft request'  (duration: 318.031305ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:26.039304Z","caller":"traceutil/trace.go:171","msg":"trace[1615926367] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"313.074641ms","start":"2026-02-17T02:39:25.726204Z","end":"2026-02-17T02:39:26.039279Z","steps":["trace[1615926367] 'process raft request'  (duration: 312.302703ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:26.039430Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:25.720286Z","time spent":"318.739898ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cloud-controller-manager\" mod_revision:2121 > success:<request_put:<key:\"/registry/leases/kube-system/cloud-controller-manager\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/kube-system/cloud-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-17T02:39:26.039460Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:25.726174Z","time spent":"313.19913ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2122 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:444 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-17T02:39:26.040145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.760361ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:26.040189Z","caller":"traceutil/trace.go:171","msg":"trace[1414102735] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2140; }","duration":"424.803314ms","start":"2026-02-17T02:39:25.615373Z","end":"2026-02-17T02:39:26.040177Z","steps":["trace[1414102735] 'agreement among raft nodes before linearized reading'  (duration: 424.739009ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:27.889498Z","caller":"traceutil/trace.go:171","msg":"trace[452143987] linearizableReadLoop","detail":"{readStateIndex:2354; appliedIndex:2353; }","duration":"275.071524ms","start":"2026-02-17T02:39:27.614317Z","end":"2026-02-17T02:39:27.889389Z","steps":["trace[452143987] 'read index received'  (duration: 262.71461ms)","trace[452143987] 'applied index is now lower than readState.Index'  (duration: 12.353994ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:27.889521Z","caller":"traceutil/trace.go:171","msg":"trace[83324571] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"343.91892ms","start":"2026-02-17T02:39:27.545533Z","end":"2026-02-17T02:39:27.889452Z","steps":["trace[83324571] 'process raft request'  (duration: 331.594569ms)","trace[83324571] 'compare'  (duration: 11.698574ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:27.889768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.430181ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-17T02:39:27.889761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:27.545507Z","time spent":"344.126086ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5625,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-kube-pbufp-hvtv8-zr8wz\" mod_revision:447 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-kube-pbufp-hvtv8-zr8wz\" value_size:5563 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-kube-pbufp-hvtv8-zr8wz\" > >"}
{"level":"warn","ts":"2026-02-17T02:39:27.889889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.415624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/projected-2800/downwardapi-volume-34271a73-bd0b-4dc0-9b00-437e4284541c\" limit:1 ","response":"range_response_count:1 size:3604"}
{"level":"info","ts":"2026-02-17T02:39:27.889946Z","caller":"traceutil/trace.go:171","msg":"trace[462053424] range","detail":"{range_begin:/registry/pods/projected-2800/downwardapi-volume-34271a73-bd0b-4dc0-9b00-437e4284541c; range_end:; response_count:1; response_revision:2159; }","duration":"274.472009ms","start":"2026-02-17T02:39:27.615464Z","end":"2026-02-17T02:39:27.889935Z","steps":["trace[462053424] 'agreement among raft nodes before linearized reading'  (duration: 274.365451ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:27.889804Z","caller":"traceutil/trace.go:171","msg":"trace[1188301206] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2159; }","duration":"275.489486ms","start":"2026-02-17T02:39:27.614304Z","end":"2026-02-17T02:39:27.889793Z","steps":["trace[1188301206] 'agreement among raft nodes before linearized reading'  (duration: 275.392889ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:28.139638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.089974ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551701425 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/projected-2800/downwardapi-volume-34271a73-bd0b-4dc0-9b00-437e4284541c\" mod_revision:2053 > success:<request_put:<key:\"/registry/pods/projected-2800/downwardapi-volume-34271a73-bd0b-4dc0-9b00-437e4284541c\" value_size:3631 >> failure:<request_range:<key:\"/registry/pods/projected-2800/downwardapi-volume-34271a73-bd0b-4dc0-9b00-437e4284541c\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:39:28.139927Z","caller":"traceutil/trace.go:171","msg":"trace[377203056] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"237.829678ms","start":"2026-02-17T02:39:27.902065Z","end":"2026-02-17T02:39:28.139895Z","steps":["trace[377203056] 'process raft request'  (duration: 105.376636ms)","trace[377203056] 'compare'  (duration: 131.878178ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:28.379920Z","caller":"traceutil/trace.go:171","msg":"trace[1550916555] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"223.962805ms","start":"2026-02-17T02:39:28.155928Z","end":"2026-02-17T02:39:28.379891Z","steps":["trace[1550916555] 'process raft request'  (duration: 217.983273ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:30.681872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.321843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:30.682080Z","caller":"traceutil/trace.go:171","msg":"trace[1072276656] range","detail":"{range_begin:/registry/ingress; range_end:; response_count:0; response_revision:2192; }","duration":"119.612345ms","start":"2026-02-17T02:39:30.562439Z","end":"2026-02-17T02:39:30.682051Z","steps":["trace[1072276656] 'range keys from in-memory index tree'  (duration: 119.261888ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.194323Z","caller":"traceutil/trace.go:171","msg":"trace[1460090844] linearizableReadLoop","detail":"{readStateIndex:2403; appliedIndex:2402; }","duration":"104.370737ms","start":"2026-02-17T02:39:31.089921Z","end":"2026-02-17T02:39:31.194292Z","steps":["trace[1460090844] 'read index received'  (duration: 88.490112ms)","trace[1460090844] 'applied index is now lower than readState.Index'  (duration: 15.878815ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:31.195158Z","caller":"traceutil/trace.go:171","msg":"trace[864978402] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"106.758748ms","start":"2026-02-17T02:39:31.088375Z","end":"2026-02-17T02:39:31.195134Z","steps":["trace[864978402] 'process raft request'  (duration: 90.021838ms)","trace[864978402] 'compare'  (duration: 15.737194ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:31.195775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.818116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/nfs-csi-k8s-io\" limit:1 ","response":"range_response_count:1 size:467"}
{"level":"info","ts":"2026-02-17T02:39:31.199561Z","caller":"traceutil/trace.go:171","msg":"trace[1171299437] range","detail":"{range_begin:/registry/leases/kube-system/nfs-csi-k8s-io; range_end:; response_count:1; response_revision:2203; }","duration":"109.615774ms","start":"2026-02-17T02:39:31.089917Z","end":"2026-02-17T02:39:31.199532Z","steps":["trace[1171299437] 'agreement among raft nodes before linearized reading'  (duration: 105.280276ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.367761Z","caller":"traceutil/trace.go:171","msg":"trace[1175565951] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"154.3846ms","start":"2026-02-17T02:39:31.213340Z","end":"2026-02-17T02:39:31.367724Z","steps":["trace[1175565951] 'process raft request'  (duration: 134.194029ms)","trace[1175565951] 'compare'  (duration: 19.570694ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:31.372571Z","caller":"traceutil/trace.go:171","msg":"trace[2040502775] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"158.880892ms","start":"2026-02-17T02:39:31.213670Z","end":"2026-02-17T02:39:31.372551Z","steps":["trace[2040502775] 'process raft request'  (duration: 153.697998ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.372615Z","caller":"traceutil/trace.go:171","msg":"trace[215238843] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"145.529559ms","start":"2026-02-17T02:39:31.227052Z","end":"2026-02-17T02:39:31.372581Z","steps":["trace[215238843] 'process raft request'  (duration: 145.224686ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:31.645093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.342531ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551701616 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" mod_revision:2109 > success:<request_put:<key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" value_size:577 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:39:31.645646Z","caller":"traceutil/trace.go:171","msg":"trace[332770087] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"326.521455ms","start":"2026-02-17T02:39:31.319088Z","end":"2026-02-17T02:39:31.645609Z","steps":["trace[332770087] 'process raft request'  (duration: 194.515983ms)","trace[332770087] 'compare'  (duration: 130.470596ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:31.645754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:31.319054Z","time spent":"326.653746ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":661,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" mod_revision:2109 > success:<request_put:<key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" value_size:577 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" > >"}
{"level":"info","ts":"2026-02-17T02:39:31.646947Z","caller":"traceutil/trace.go:171","msg":"trace[624802104] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"313.40371ms","start":"2026-02-17T02:39:31.333498Z","end":"2026-02-17T02:39:31.646902Z","steps":["trace[624802104] 'process raft request'  (duration: 311.738034ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:31.647498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:31.333468Z","time spent":"313.576243ms","remote":"127.0.0.1:55040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9632,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" mod_revision:1906 > success:<request_put:<key:\"/registry/minions/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" value_size:9563 >> failure:<request_range:<key:\"/registry/minions/kube-pbufp-default-worker-7hjxz-m6tmm-gs7qf\" > >"}
{"level":"info","ts":"2026-02-17T02:39:31.674100Z","caller":"traceutil/trace.go:171","msg":"trace[277906784] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"294.647397ms","start":"2026-02-17T02:39:31.379417Z","end":"2026-02-17T02:39:31.674064Z","steps":["trace[277906784] 'process raft request'  (duration: 294.28906ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.675050Z","caller":"traceutil/trace.go:171","msg":"trace[1296506209] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"290.016106ms","start":"2026-02-17T02:39:31.384997Z","end":"2026-02-17T02:39:31.675012Z","steps":["trace[1296506209] 'process raft request'  (duration: 288.968327ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.675461Z","caller":"traceutil/trace.go:171","msg":"trace[1548628697] linearizableReadLoop","detail":"{readStateIndex:2413; appliedIndex:2407; }","duration":"217.365566ms","start":"2026-02-17T02:39:31.458081Z","end":"2026-02-17T02:39:31.675446Z","steps":["trace[1548628697] 'read index received'  (duration: 55.742308ms)","trace[1548628697] 'applied index is now lower than readState.Index'  (duration: 161.620698ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:31.675702Z","caller":"traceutil/trace.go:171","msg":"trace[1001630997] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"288.47603ms","start":"2026-02-17T02:39:31.387120Z","end":"2026-02-17T02:39:31.675596Z","steps":["trace[1001630997] 'process raft request'  (duration: 286.912251ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.676517Z","caller":"traceutil/trace.go:171","msg":"trace[1286877833] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"218.156866ms","start":"2026-02-17T02:39:31.458340Z","end":"2026-02-17T02:39:31.676497Z","steps":["trace[1286877833] 'process raft request'  (duration: 216.736388ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:31.681578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.432767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook\" limit:1 ","response":"range_response_count:1 size:1668"}
{"level":"info","ts":"2026-02-17T02:39:31.681671Z","caller":"traceutil/trace.go:171","msg":"trace[1738205945] range","detail":"{range_begin:/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook; range_end:; response_count:1; response_revision:2213; }","duration":"223.61656ms","start":"2026-02-17T02:39:31.458038Z","end":"2026-02-17T02:39:31.681655Z","steps":["trace[1738205945] 'agreement among raft nodes before linearized reading'  (duration: 218.421216ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.905649Z","caller":"traceutil/trace.go:171","msg":"trace[1179693857] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"353.186568ms","start":"2026-02-17T02:39:31.552427Z","end":"2026-02-17T02:39:31.905614Z","steps":["trace[1179693857] 'process raft request'  (duration: 291.338617ms)","trace[1179693857] 'compare'  (duration: 61.339682ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:31.905963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:31.552396Z","time spent":"353.398274ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2175 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:426 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-17T02:39:31.906298Z","caller":"traceutil/trace.go:171","msg":"trace[349893447] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"329.34449ms","start":"2026-02-17T02:39:31.576918Z","end":"2026-02-17T02:39:31.906264Z","steps":["trace[349893447] 'process raft request'  (duration: 328.625525ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:31.906489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:31.576826Z","time spent":"329.569277ms","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":549,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-cinder-csi-openstack-org\" mod_revision:2145 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-cinder-csi-openstack-org\" value_size:460 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-cinder-csi-openstack-org\" > >"}
{"level":"info","ts":"2026-02-17T02:39:31.909962Z","caller":"traceutil/trace.go:171","msg":"trace[1142184102] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"272.701903ms","start":"2026-02-17T02:39:31.637245Z","end":"2026-02-17T02:39:31.909948Z","steps":["trace[1142184102] 'process raft request'  (duration: 272.549392ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.910075Z","caller":"traceutil/trace.go:171","msg":"trace[210338884] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"288.159036ms","start":"2026-02-17T02:39:31.621904Z","end":"2026-02-17T02:39:31.910063Z","steps":["trace[210338884] 'process raft request'  (duration: 283.910734ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.909966Z","caller":"traceutil/trace.go:171","msg":"trace[1565035903] linearizableReadLoop","detail":"{readStateIndex:2417; appliedIndex:2413; }","duration":"234.390407ms","start":"2026-02-17T02:39:31.675558Z","end":"2026-02-17T02:39:31.909949Z","steps":["trace[1565035903] 'read index received'  (duration: 168.174225ms)","trace[1565035903] 'applied index is now lower than readState.Index'  (duration: 66.214362ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:31.910439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.400976ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:31.910499Z","caller":"traceutil/trace.go:171","msg":"trace[188501986] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2217; }","duration":"266.46318ms","start":"2026-02-17T02:39:31.644026Z","end":"2026-02-17T02:39:31.910489Z","steps":["trace[188501986] 'agreement among raft nodes before linearized reading'  (duration: 266.014316ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:31.911523Z","caller":"traceutil/trace.go:171","msg":"trace[482893320] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"201.757342ms","start":"2026-02-17T02:39:31.709755Z","end":"2026-02-17T02:39:31.911513Z","steps":["trace[482893320] 'process raft request'  (duration: 200.575902ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:31.916083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.688026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook\" limit:1 ","response":"range_response_count:1 size:1668"}
{"level":"info","ts":"2026-02-17T02:39:31.916149Z","caller":"traceutil/trace.go:171","msg":"trace[580703066] range","detail":"{range_begin:/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook; range_end:; response_count:1; response_revision:2218; }","duration":"170.752921ms","start":"2026-02-17T02:39:31.745383Z","end":"2026-02-17T02:39:31.916136Z","steps":["trace[580703066] 'agreement among raft nodes before linearized reading'  (duration: 170.641732ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:31.916192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.588921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/sonobuoy/sonobuoy-e2e-job-92d2fb919fee49c9\" limit:1 ","response":"range_response_count:1 size:9176"}
{"level":"info","ts":"2026-02-17T02:39:31.916311Z","caller":"traceutil/trace.go:171","msg":"trace[867400128] range","detail":"{range_begin:/registry/pods/sonobuoy/sonobuoy-e2e-job-92d2fb919fee49c9; range_end:; response_count:1; response_revision:2218; }","duration":"196.777325ms","start":"2026-02-17T02:39:31.719517Z","end":"2026-02-17T02:39:31.916295Z","steps":["trace[867400128] 'agreement among raft nodes before linearized reading'  (duration: 196.564159ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:31.916367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.451799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:31.916422Z","caller":"traceutil/trace.go:171","msg":"trace[1495054156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2218; }","duration":"100.504823ms","start":"2026-02-17T02:39:31.815907Z","end":"2026-02-17T02:39:31.916412Z","steps":["trace[1495054156] 'agreement among raft nodes before linearized reading'  (duration: 100.427797ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:32.057345Z","caller":"traceutil/trace.go:171","msg":"trace[936335186] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"103.015016ms","start":"2026-02-17T02:39:31.954295Z","end":"2026-02-17T02:39:32.057310Z","steps":["trace[936335186] 'process raft request'  (duration: 88.750673ms)","trace[936335186] 'compare'  (duration: 13.594002ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:33.021641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.257729ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551701679 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/limitrange-4715/pod-no-resources\" mod_revision:2238 > success:<request_put:<key:\"/registry/pods/limitrange-4715/pod-no-resources\" value_size:1947 >> failure:<request_range:<key:\"/registry/pods/limitrange-4715/pod-no-resources\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:39:33.021970Z","caller":"traceutil/trace.go:171","msg":"trace[369294882] transaction","detail":"{read_only:false; response_revision:2239; number_of_response:1; }","duration":"199.218843ms","start":"2026-02-17T02:39:32.822732Z","end":"2026-02-17T02:39:33.021951Z","steps":["trace[369294882] 'process raft request'  (duration: 90.577525ms)","trace[369294882] 'compare'  (duration: 108.168392ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:33.022699Z","caller":"traceutil/trace.go:171","msg":"trace[573904189] linearizableReadLoop","detail":"{readStateIndex:2442; appliedIndex:2439; }","duration":"140.385448ms","start":"2026-02-17T02:39:32.882290Z","end":"2026-02-17T02:39:33.022676Z","steps":["trace[573904189] 'read index received'  (duration: 31.036086ms)","trace[573904189] 'applied index is now lower than readState.Index'  (duration: 109.346242ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:33.022815Z","caller":"traceutil/trace.go:171","msg":"trace[1344719648] transaction","detail":"{read_only:false; response_revision:2240; number_of_response:1; }","duration":"198.476107ms","start":"2026-02-17T02:39:32.824289Z","end":"2026-02-17T02:39:33.022765Z","steps":["trace[1344719648] 'process raft request'  (duration: 197.59486ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.023028Z","caller":"traceutil/trace.go:171","msg":"trace[945636295] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"195.600279ms","start":"2026-02-17T02:39:32.827410Z","end":"2026-02-17T02:39:33.023010Z","steps":["trace[945636295] 'process raft request'  (duration: 195.09111ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.024031Z","caller":"traceutil/trace.go:171","msg":"trace[747466925] transaction","detail":"{read_only:false; response_revision:2242; number_of_response:1; }","duration":"120.921441ms","start":"2026-02-17T02:39:32.903096Z","end":"2026-02-17T02:39:33.024018Z","steps":["trace[747466925] 'process raft request'  (duration: 119.468781ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:33.027417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.166371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:33.027485Z","caller":"traceutil/trace.go:171","msg":"trace[1955138819] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:2242; }","duration":"145.240386ms","start":"2026-02-17T02:39:32.882232Z","end":"2026-02-17T02:39:33.027472Z","steps":["trace[1955138819] 'agreement among raft nodes before linearized reading'  (duration: 141.143045ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.386727Z","caller":"traceutil/trace.go:171","msg":"trace[1961799381] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"353.079821ms","start":"2026-02-17T02:39:33.033606Z","end":"2026-02-17T02:39:33.386686Z","steps":["trace[1961799381] 'process raft request'  (duration: 274.308637ms)","trace[1961799381] 'compare'  (duration: 77.839913ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:33.386910Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:33.033576Z","time spent":"353.259905ms","remote":"127.0.0.1:54958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":924,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/limitrange-4715/pod-partial-resources.1894e84d806ae7fc\" mod_revision:0 > success:<request_put:<key:\"/registry/events/limitrange-4715/pod-partial-resources.1894e84d806ae7fc\" value_size:835 lease:5114009353551701627 >> failure:<>"}
{"level":"info","ts":"2026-02-17T02:39:33.390340Z","caller":"traceutil/trace.go:171","msg":"trace[1273025684] linearizableReadLoop","detail":"{readStateIndex:2450; appliedIndex:2444; }","duration":"158.812013ms","start":"2026-02-17T02:39:33.231303Z","end":"2026-02-17T02:39:33.390115Z","steps":["trace[1273025684] 'read index received'  (duration: 76.595658ms)","trace[1273025684] 'applied index is now lower than readState.Index'  (duration: 82.214095ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:33.392015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.632432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/stagedglobalnetworkpolicies/\" range_end:\"/registry/crd.projectcalico.org/stagedglobalnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:33.392113Z","caller":"traceutil/trace.go:171","msg":"trace[741286388] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"358.365203ms","start":"2026-02-17T02:39:33.033727Z","end":"2026-02-17T02:39:33.392092Z","steps":["trace[741286388] 'process raft request'  (duration: 352.783169ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.392123Z","caller":"traceutil/trace.go:171","msg":"trace[67080] range","detail":"{range_begin:/registry/crd.projectcalico.org/stagedglobalnetworkpolicies/; range_end:/registry/crd.projectcalico.org/stagedglobalnetworkpolicies0; response_count:0; response_revision:2249; }","duration":"160.814866ms","start":"2026-02-17T02:39:33.231294Z","end":"2026-02-17T02:39:33.392109Z","steps":["trace[67080] 'agreement among raft nodes before linearized reading'  (duration: 160.455209ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:33.392194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:33.033720Z","time spent":"358.424277ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2054,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/limitrange-4715/pod-partial-resources\" mod_revision:2241 > success:<request_put:<key:\"/registry/pods/limitrange-4715/pod-partial-resources\" value_size:1994 >> failure:<request_range:<key:\"/registry/pods/limitrange-4715/pod-partial-resources\" > >"}
{"level":"info","ts":"2026-02-17T02:39:33.392336Z","caller":"traceutil/trace.go:171","msg":"trace[845111559] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"347.959202ms","start":"2026-02-17T02:39:33.044370Z","end":"2026-02-17T02:39:33.392329Z","steps":["trace[845111559] 'process raft request'  (duration: 345.230914ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:33.392394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:33.044333Z","time spent":"348.039378ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8815,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/csi-nfs-node-5smjl\" mod_revision:971 > success:<request_put:<key:\"/registry/pods/kube-system/csi-nfs-node-5smjl\" value_size:8762 >> failure:<request_range:<key:\"/registry/pods/kube-system/csi-nfs-node-5smjl\" > >"}
{"level":"info","ts":"2026-02-17T02:39:33.393102Z","caller":"traceutil/trace.go:171","msg":"trace[823700526] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"270.286992ms","start":"2026-02-17T02:39:33.122806Z","end":"2026-02-17T02:39:33.393093Z","steps":["trace[823700526] 'process raft request'  (duration: 267.060227ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.393085Z","caller":"traceutil/trace.go:171","msg":"trace[628896811] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"263.967592ms","start":"2026-02-17T02:39:33.129084Z","end":"2026-02-17T02:39:33.393052Z","steps":["trace[628896811] 'process raft request'  (duration: 260.842664ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.393296Z","caller":"traceutil/trace.go:171","msg":"trace[1453587057] transaction","detail":"{read_only:false; response_revision:2249; number_of_response:1; }","duration":"216.901386ms","start":"2026-02-17T02:39:33.176384Z","end":"2026-02-17T02:39:33.393286Z","steps":["trace[1453587057] 'process raft request'  (duration: 213.675351ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.584528Z","caller":"traceutil/trace.go:171","msg":"trace[129524045] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"128.857738ms","start":"2026-02-17T02:39:33.455629Z","end":"2026-02-17T02:39:33.584487Z","steps":["trace[129524045] 'process raft request'  (duration: 82.943341ms)","trace[129524045] 'compare'  (duration: 45.476964ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:33.585689Z","caller":"traceutil/trace.go:171","msg":"trace[5321912] transaction","detail":"{read_only:false; response_revision:2253; number_of_response:1; }","duration":"128.121012ms","start":"2026-02-17T02:39:33.457553Z","end":"2026-02-17T02:39:33.585674Z","steps":["trace[5321912] 'process raft request'  (duration: 127.6947ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.584394Z","caller":"traceutil/trace.go:171","msg":"trace[1241490439] linearizableReadLoop","detail":"{readStateIndex:2453; appliedIndex:2452; }","duration":"127.160049ms","start":"2026-02-17T02:39:33.457200Z","end":"2026-02-17T02:39:33.584359Z","steps":["trace[1241490439] 'read index received'  (duration: 81.501721ms)","trace[1241490439] 'applied index is now lower than readState.Index'  (duration: 45.655338ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:33.586754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.528119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:33.586798Z","caller":"traceutil/trace.go:171","msg":"trace[862207908] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:2254; }","duration":"129.593245ms","start":"2026-02-17T02:39:33.457191Z","end":"2026-02-17T02:39:33.586784Z","steps":["trace[862207908] 'agreement among raft nodes before linearized reading'  (duration: 129.043393ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.809230Z","caller":"traceutil/trace.go:171","msg":"trace[9820455] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"124.088417ms","start":"2026-02-17T02:39:33.685110Z","end":"2026-02-17T02:39:33.809198Z","steps":["trace[9820455] 'process raft request'  (duration: 41.469321ms)","trace[9820455] 'compare'  (duration: 82.208415ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:33.809475Z","caller":"traceutil/trace.go:171","msg":"trace[893111396] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"114.775939ms","start":"2026-02-17T02:39:33.694684Z","end":"2026-02-17T02:39:33.809460Z","steps":["trace[893111396] 'process raft request'  (duration: 114.437973ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:33.809487Z","caller":"traceutil/trace.go:171","msg":"trace[793698283] linearizableReadLoop","detail":"{readStateIndex:2462; appliedIndex:2461; }","duration":"120.274006ms","start":"2026-02-17T02:39:33.689181Z","end":"2026-02-17T02:39:33.809455Z","steps":["trace[793698283] 'read index received'  (duration: 37.848885ms)","trace[793698283] 'applied index is now lower than readState.Index'  (duration: 82.421601ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:33.810043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.84248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook\" limit:1 ","response":"range_response_count:1 size:3313"}
{"level":"info","ts":"2026-02-17T02:39:33.810085Z","caller":"traceutil/trace.go:171","msg":"trace[1707420123] range","detail":"{range_begin:/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook; range_end:; response_count:1; response_revision:2262; }","duration":"120.900164ms","start":"2026-02-17T02:39:33.689173Z","end":"2026-02-17T02:39:33.810073Z","steps":["trace[1707420123] 'agreement among raft nodes before linearized reading'  (duration: 120.756233ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:34.164708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.570234ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551701719 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/deployments/webhook-133/sample-webhook-deployment\" mod_revision:2257 > success:<request_put:<key:\"/registry/deployments/webhook-133/sample-webhook-deployment\" value_size:2997 >> failure:<request_range:<key:\"/registry/deployments/webhook-133/sample-webhook-deployment\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:39:34.166347Z","caller":"traceutil/trace.go:171","msg":"trace[344517326] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"330.283768ms","start":"2026-02-17T02:39:33.836042Z","end":"2026-02-17T02:39:34.166325Z","steps":["trace[344517326] 'process raft request'  (duration: 328.85152ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:34.166494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:33.836012Z","time spent":"330.433209ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3377,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook\" mod_revision:2237 > success:<request_put:<key:\"/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook\" value_size:3298 >> failure:<request_range:<key:\"/registry/pods/container-lifecycle-hook-9198/pod-with-prestop-http-hook\" > >"}
{"level":"info","ts":"2026-02-17T02:39:34.166799Z","caller":"traceutil/trace.go:171","msg":"trace[1370399370] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"252.521452ms","start":"2026-02-17T02:39:33.914244Z","end":"2026-02-17T02:39:34.166765Z","steps":["trace[1370399370] 'process raft request'  (duration: 250.796371ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:34.167374Z","caller":"traceutil/trace.go:171","msg":"trace[488401569] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"339.801692ms","start":"2026-02-17T02:39:33.825804Z","end":"2026-02-17T02:39:34.165606Z","steps":["trace[488401569] 'process raft request'  (duration: 150.224762ms)","trace[488401569] 'compare'  (duration: 188.385649ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:34.167523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:33.825791Z","time spent":"341.669374ms","remote":"127.0.0.1:55308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3064,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/webhook-133/sample-webhook-deployment\" mod_revision:2257 > success:<request_put:<key:\"/registry/deployments/webhook-133/sample-webhook-deployment\" value_size:2997 >> failure:<request_range:<key:\"/registry/deployments/webhook-133/sample-webhook-deployment\" > >"}
{"level":"info","ts":"2026-02-17T02:39:34.638152Z","caller":"traceutil/trace.go:171","msg":"trace[1516326826] transaction","detail":"{read_only:false; response_revision:2271; number_of_response:1; }","duration":"101.073804ms","start":"2026-02-17T02:39:34.537039Z","end":"2026-02-17T02:39:34.638112Z","steps":["trace[1516326826] 'process raft request'  (duration: 30.283302ms)","trace[1516326826] 'compare'  (duration: 70.421824ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:34.651638Z","caller":"traceutil/trace.go:171","msg":"trace[636065732] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"107.643033ms","start":"2026-02-17T02:39:34.543963Z","end":"2026-02-17T02:39:34.651606Z","steps":["trace[636065732] 'process raft request'  (duration: 107.342461ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:40.631837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.996281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-dxw2c\" limit:1 ","response":"range_response_count:1 size:4742"}
{"level":"info","ts":"2026-02-17T02:39:40.632013Z","caller":"traceutil/trace.go:171","msg":"trace[146863036] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-dxw2c; range_end:; response_count:1; response_revision:2411; }","duration":"500.183175ms","start":"2026-02-17T02:39:40.131802Z","end":"2026-02-17T02:39:40.631986Z","steps":["trace[146863036] 'range keys from in-memory index tree'  (duration: 499.556777ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:40.632067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:40.131774Z","time spent":"500.279913ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":4765,"request content":"key:\"/registry/pods/kube-system/kube-proxy-dxw2c\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:39:40.633020Z","caller":"traceutil/trace.go:171","msg":"trace[425768938] transaction","detail":"{read_only:false; response_revision:2413; number_of_response:1; }","duration":"270.183515ms","start":"2026-02-17T02:39:40.362812Z","end":"2026-02-17T02:39:40.632996Z","steps":["trace[425768938] 'process raft request'  (duration: 270.058796ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:40.633509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.805768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:40.636039Z","caller":"traceutil/trace.go:171","msg":"trace[1656496557] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2414; }","duration":"299.336961ms","start":"2026-02-17T02:39:40.336669Z","end":"2026-02-17T02:39:40.636006Z","steps":["trace[1656496557] 'agreement among raft nodes before linearized reading'  (duration: 296.780766ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:40.633096Z","caller":"traceutil/trace.go:171","msg":"trace[1171538538] transaction","detail":"{read_only:false; response_revision:2414; number_of_response:1; }","duration":"270.067397ms","start":"2026-02-17T02:39:40.363008Z","end":"2026-02-17T02:39:40.633075Z","steps":["trace[1171538538] 'process raft request'  (duration: 269.953308ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:40.633362Z","caller":"traceutil/trace.go:171","msg":"trace[2142234387] transaction","detail":"{read_only:false; response_revision:2412; number_of_response:1; }","duration":"425.772814ms","start":"2026-02-17T02:39:40.207573Z","end":"2026-02-17T02:39:40.633346Z","steps":["trace[2142234387] 'process raft request'  (duration: 410.008851ms)","trace[2142234387] 'compare'  (duration: 13.993698ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:40.636753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:39:40.207551Z","time spent":"429.11311ms","remote":"127.0.0.1:55098","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/kube-scheduler\" mod_revision:2351 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:425 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-17T02:39:40.633430Z","caller":"traceutil/trace.go:171","msg":"trace[1757872712] linearizableReadLoop","detail":"{readStateIndex:2619; appliedIndex:2618; }","duration":"296.715151ms","start":"2026-02-17T02:39:40.336701Z","end":"2026-02-17T02:39:40.633416Z","steps":["trace[1757872712] 'read index received'  (duration: 280.653475ms)","trace[1757872712] 'applied index is now lower than readState.Index'  (duration: 16.058635ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:40.637569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.907076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:40.637641Z","caller":"traceutil/trace.go:171","msg":"trace[875991679] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:2414; }","duration":"184.980081ms","start":"2026-02-17T02:39:40.452649Z","end":"2026-02-17T02:39:40.637629Z","steps":["trace[875991679] 'agreement among raft nodes before linearized reading'  (duration: 184.708241ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:41.084799Z","caller":"traceutil/trace.go:171","msg":"trace[1595209845] linearizableReadLoop","detail":"{readStateIndex:2633; appliedIndex:2632; }","duration":"111.852643ms","start":"2026-02-17T02:39:40.972920Z","end":"2026-02-17T02:39:41.084773Z","steps":["trace[1595209845] 'read index received'  (duration: 96.24061ms)","trace[1595209845] 'applied index is now lower than readState.Index'  (duration: 15.610243ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:41.084968Z","caller":"traceutil/trace.go:171","msg":"trace[604183622] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"149.683641ms","start":"2026-02-17T02:39:40.935275Z","end":"2026-02-17T02:39:41.084958Z","steps":["trace[604183622] 'process raft request'  (duration: 134.041286ms)","trace[604183622] 'compare'  (duration: 15.296008ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:41.085614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.908113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/container-runtime-8642/termination-message-container424b3fda-59f1-4f16-acf2-1c1dc974a3aa\" limit:1 ","response":"range_response_count:1 size:3236"}
{"level":"info","ts":"2026-02-17T02:39:41.085687Z","caller":"traceutil/trace.go:171","msg":"trace[1183531757] range","detail":"{range_begin:/registry/pods/container-runtime-8642/termination-message-container424b3fda-59f1-4f16-acf2-1c1dc974a3aa; range_end:; response_count:1; response_revision:2426; }","duration":"112.99311ms","start":"2026-02-17T02:39:40.972681Z","end":"2026-02-17T02:39:41.085675Z","steps":["trace[1183531757] 'agreement among raft nodes before linearized reading'  (duration: 112.86924ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:41.202894Z","caller":"traceutil/trace.go:171","msg":"trace[2041767114] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"111.000209ms","start":"2026-02-17T02:39:41.091828Z","end":"2026-02-17T02:39:41.202828Z","steps":["trace[2041767114] 'process raft request'  (duration: 102.144043ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:43.974697Z","caller":"traceutil/trace.go:171","msg":"trace[2093393484] linearizableReadLoop","detail":"{readStateIndex:2703; appliedIndex:2702; }","duration":"126.249917ms","start":"2026-02-17T02:39:43.848344Z","end":"2026-02-17T02:39:43.974594Z","steps":["trace[2093393484] 'read index received'  (duration: 9.170022ms)","trace[2093393484] 'applied index is now lower than readState.Index'  (duration: 117.078205ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:39:43.974747Z","caller":"traceutil/trace.go:171","msg":"trace[641911642] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"129.148219ms","start":"2026-02-17T02:39:43.845560Z","end":"2026-02-17T02:39:43.974708Z","steps":["trace[641911642] 'process raft request'  (duration: 100.897828ms)","trace[641911642] 'compare'  (duration: 27.867301ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:39:43.974892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.528838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:43.974921Z","caller":"traceutil/trace.go:171","msg":"trace[1988799590] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:2495; }","duration":"126.575371ms","start":"2026-02-17T02:39:43.848338Z","end":"2026-02-17T02:39:43.974913Z","steps":["trace[1988799590] 'agreement among raft nodes before linearized reading'  (duration: 126.463703ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:43.978355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.168897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/init-container-9717/pod-init-b5859890-5b57-4765-8d84-8f44960a127e\" limit:1 ","response":"range_response_count:1 size:4716"}
{"level":"info","ts":"2026-02-17T02:39:43.978435Z","caller":"traceutil/trace.go:171","msg":"trace[1399465200] range","detail":"{range_begin:/registry/pods/init-container-9717/pod-init-b5859890-5b57-4765-8d84-8f44960a127e; range_end:; response_count:1; response_revision:2496; }","duration":"127.257744ms","start":"2026-02-17T02:39:43.851163Z","end":"2026-02-17T02:39:43.978420Z","steps":["trace[1399465200] 'agreement among raft nodes before linearized reading'  (duration: 127.116923ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:43.978925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.968801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/fail-closed-namespace-8853\" limit:1 ","response":"range_response_count:1 size:829"}
{"level":"info","ts":"2026-02-17T02:39:43.978968Z","caller":"traceutil/trace.go:171","msg":"trace[1875199320] range","detail":"{range_begin:/registry/namespaces/fail-closed-namespace-8853; range_end:; response_count:1; response_revision:2496; }","duration":"113.013114ms","start":"2026-02-17T02:39:43.865948Z","end":"2026-02-17T02:39:43.978961Z","steps":["trace[1875199320] 'agreement among raft nodes before linearized reading'  (duration: 112.936468ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:39:43.979144Z","caller":"traceutil/trace.go:171","msg":"trace[1410829015] transaction","detail":"{read_only:false; response_revision:2496; number_of_response:1; }","duration":"115.399706ms","start":"2026-02-17T02:39:43.863736Z","end":"2026-02-17T02:39:43.979136Z","steps":["trace[1410829015] 'process raft request'  (duration: 114.425112ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:43.979863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.971646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/webhook-markers-9258\" limit:1 ","response":"range_response_count:1 size:772"}
{"level":"info","ts":"2026-02-17T02:39:43.979905Z","caller":"traceutil/trace.go:171","msg":"trace[1490546096] range","detail":"{range_begin:/registry/namespaces/webhook-markers-9258; range_end:; response_count:1; response_revision:2496; }","duration":"123.017909ms","start":"2026-02-17T02:39:43.856876Z","end":"2026-02-17T02:39:43.979894Z","steps":["trace[1490546096] 'agreement among raft nodes before linearized reading'  (duration: 122.933903ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:39:44.184603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.110619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:39:44.184693Z","caller":"traceutil/trace.go:171","msg":"trace[1192176260] range","detail":"{range_begin:/registry/serviceaccounts; range_end:; response_count:0; response_revision:2500; }","duration":"104.209746ms","start":"2026-02-17T02:39:44.080466Z","end":"2026-02-17T02:39:44.184676Z","steps":["trace[1192176260] 'range keys from in-memory index tree'  (duration: 103.962157ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:01.220294Z","caller":"traceutil/trace.go:171","msg":"trace[956379931] transaction","detail":"{read_only:false; response_revision:2905; number_of_response:1; }","duration":"147.988443ms","start":"2026-02-17T02:40:01.072276Z","end":"2026-02-17T02:40:01.220265Z","steps":["trace[956379931] 'process raft request'  (duration: 140.371135ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:01.377853Z","caller":"traceutil/trace.go:171","msg":"trace[510882604] transaction","detail":"{read_only:false; response_revision:2910; number_of_response:1; }","duration":"118.427249ms","start":"2026-02-17T02:40:01.259384Z","end":"2026-02-17T02:40:01.377811Z","steps":["trace[510882604] 'process raft request'  (duration: 118.297989ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:01.378063Z","caller":"traceutil/trace.go:171","msg":"trace[348581920] linearizableReadLoop","detail":"{readStateIndex:3133; appliedIndex:3130; }","duration":"118.384666ms","start":"2026-02-17T02:40:01.259625Z","end":"2026-02-17T02:40:01.378009Z","steps":["trace[348581920] 'read index received'  (duration: 16.064992ms)","trace[348581920] 'applied index is now lower than readState.Index'  (duration: 102.311404ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:01.379069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.358941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/statefulset-4633/ss-0\" limit:1 ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-02-17T02:40:01.379149Z","caller":"traceutil/trace.go:171","msg":"trace[2079801686] range","detail":"{range_begin:/registry/pods/statefulset-4633/ss-0; range_end:; response_count:1; response_revision:2911; }","duration":"119.515673ms","start":"2026-02-17T02:40:01.259619Z","end":"2026-02-17T02:40:01.379135Z","steps":["trace[2079801686] 'agreement among raft nodes before linearized reading'  (duration: 118.703931ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:01.379734Z","caller":"traceutil/trace.go:171","msg":"trace[1606815238] transaction","detail":"{read_only:false; response_revision:2909; number_of_response:1; }","duration":"126.507454ms","start":"2026-02-17T02:40:01.253199Z","end":"2026-02-17T02:40:01.379706Z","steps":["trace[1606815238] 'process raft request'  (duration: 76.400543ms)","trace[1606815238] 'compare'  (duration: 47.877868ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:04.127746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.593438ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551704761 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/pods-2623/test-pod-2.1894e8527fbd786c\" mod_revision:2796 > success:<request_delete_range:<key:\"/registry/events/pods-2623/test-pod-2.1894e8527fbd786c\" > > failure:<request_range:<key:\"/registry/events/pods-2623/test-pod-2.1894e8527fbd786c\" > >>","response":"size:18"}
{"level":"info","ts":"2026-02-17T02:40:04.128006Z","caller":"traceutil/trace.go:171","msg":"trace[1399274558] transaction","detail":"{read_only:false; number_of_response:1; response_revision:3003; }","duration":"192.560584ms","start":"2026-02-17T02:40:03.935423Z","end":"2026-02-17T02:40:04.127983Z","steps":["trace[1399274558] 'process raft request'  (duration: 42.637402ms)","trace[1399274558] 'compare'  (duration: 149.413676ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:40:05.399088Z","caller":"traceutil/trace.go:171","msg":"trace[930588029] linearizableReadLoop","detail":"{readStateIndex:3251; appliedIndex:3250; }","duration":"132.065518ms","start":"2026-02-17T02:40:05.266988Z","end":"2026-02-17T02:40:05.399053Z","steps":["trace[930588029] 'read index received'  (duration: 131.522743ms)","trace[930588029] 'applied index is now lower than readState.Index'  (duration: 539.916µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:05.399459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.395064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:40:05.399532Z","caller":"traceutil/trace.go:171","msg":"trace[1897202417] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:3024; }","duration":"132.530487ms","start":"2026-02-17T02:40:05.266977Z","end":"2026-02-17T02:40:05.399507Z","steps":["trace[1897202417] 'agreement among raft nodes before linearized reading'  (duration: 132.275549ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:05.400091Z","caller":"traceutil/trace.go:171","msg":"trace[507626105] transaction","detail":"{read_only:false; response_revision:3024; number_of_response:1; }","duration":"262.267863ms","start":"2026-02-17T02:40:05.137794Z","end":"2026-02-17T02:40:05.400062Z","steps":["trace[507626105] 'process raft request'  (duration: 260.958193ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:05.549639Z","caller":"traceutil/trace.go:171","msg":"trace[1594077165] transaction","detail":"{read_only:false; response_revision:3025; number_of_response:1; }","duration":"112.48043ms","start":"2026-02-17T02:40:05.437122Z","end":"2026-02-17T02:40:05.549603Z","steps":["trace[1594077165] 'process raft request'  (duration: 85.959452ms)","trace[1594077165] 'compare'  (duration: 26.294789ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:40:05.938751Z","caller":"traceutil/trace.go:171","msg":"trace[869152851] linearizableReadLoop","detail":"{readStateIndex:3254; appliedIndex:3253; }","duration":"324.343155ms","start":"2026-02-17T02:40:05.614386Z","end":"2026-02-17T02:40:05.938729Z","steps":["trace[869152851] 'read index received'  (duration: 307.358697ms)","trace[869152851] 'applied index is now lower than readState.Index'  (duration: 16.982578ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:05.939188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.594963ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:40:05.939409Z","caller":"traceutil/trace.go:171","msg":"trace[1318840753] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:3027; }","duration":"325.032763ms","start":"2026-02-17T02:40:05.614357Z","end":"2026-02-17T02:40:05.939390Z","steps":["trace[1318840753] 'agreement among raft nodes before linearized reading'  (duration: 324.540105ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:40:05.939843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.630775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:40:05.939907Z","caller":"traceutil/trace.go:171","msg":"trace[1979141328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3027; }","duration":"126.61106ms","start":"2026-02-17T02:40:05.813284Z","end":"2026-02-17T02:40:05.939895Z","steps":["trace[1979141328] 'agreement among raft nodes before linearized reading'  (duration: 125.585608ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:05.940532Z","caller":"traceutil/trace.go:171","msg":"trace[1680795093] transaction","detail":"{read_only:false; response_revision:3027; number_of_response:1; }","duration":"343.55486ms","start":"2026-02-17T02:40:05.596965Z","end":"2026-02-17T02:40:05.940520Z","steps":["trace[1680795093] 'process raft request'  (duration: 324.852521ms)","trace[1680795093] 'compare'  (duration: 16.008083ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:05.940645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:40:05.596954Z","time spent":"343.633937ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1466,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/container-lifecycle-hook-3215/pod-with-prestop-exec-hook\" mod_revision:3026 > success:<request_put:<key:\"/registry/pods/container-lifecycle-hook-3215/pod-with-prestop-exec-hook\" value_size:1387 >> failure:<request_range:<key:\"/registry/pods/container-lifecycle-hook-3215/pod-with-prestop-exec-hook\" > >"}
{"level":"info","ts":"2026-02-17T02:40:06.996599Z","caller":"traceutil/trace.go:171","msg":"trace[1172102569] linearizableReadLoop","detail":"{readStateIndex:3271; appliedIndex:3270; }","duration":"117.764689ms","start":"2026-02-17T02:40:06.878794Z","end":"2026-02-17T02:40:06.996559Z","steps":["trace[1172102569] 'read index received'  (duration: 49.556671ms)","trace[1172102569] 'applied index is now lower than readState.Index'  (duration: 68.205228ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:40:06.997145Z","caller":"traceutil/trace.go:171","msg":"trace[200290711] transaction","detail":"{read_only:false; response_revision:3044; number_of_response:1; }","duration":"118.430139ms","start":"2026-02-17T02:40:06.878689Z","end":"2026-02-17T02:40:06.997119Z","steps":["trace[200290711] 'process raft request'  (duration: 49.761251ms)","trace[200290711] 'compare'  (duration: 67.96238ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:06.997469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.624226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ippools\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:40:06.997525Z","caller":"traceutil/trace.go:171","msg":"trace[1266874380] range","detail":"{range_begin:/registry/crd.projectcalico.org/ippools; range_end:; response_count:0; response_revision:3044; }","duration":"115.694993ms","start":"2026-02-17T02:40:06.881817Z","end":"2026-02-17T02:40:06.997512Z","steps":["trace[1266874380] 'agreement among raft nodes before linearized reading'  (duration: 115.583128ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:40:06.997874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.06996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ippools\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:40:06.998044Z","caller":"traceutil/trace.go:171","msg":"trace[219555811] range","detail":"{range_begin:/registry/crd.projectcalico.org/ippools; range_end:; response_count:0; response_revision:3044; }","duration":"119.230503ms","start":"2026-02-17T02:40:06.878788Z","end":"2026-02-17T02:40:06.998019Z","steps":["trace[219555811] 'agreement among raft nodes before linearized reading'  (duration: 119.035952ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:41:17.352483Z","caller":"traceutil/trace.go:171","msg":"trace[1126646739] transaction","detail":"{read_only:false; response_revision:4433; number_of_response:1; }","duration":"125.064807ms","start":"2026-02-17T02:41:17.227389Z","end":"2026-02-17T02:41:17.352453Z","steps":["trace[1126646739] 'process raft request'  (duration: 93.838953ms)","trace[1126646739] 'compare'  (duration: 30.908493ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:41:17.352828Z","caller":"traceutil/trace.go:171","msg":"trace[1601261123] transaction","detail":"{read_only:false; response_revision:4434; number_of_response:1; }","duration":"125.249358ms","start":"2026-02-17T02:41:17.227547Z","end":"2026-02-17T02:41:17.352797Z","steps":["trace[1601261123] 'process raft request'  (duration: 124.758807ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:27.983767Z","caller":"traceutil/trace.go:171","msg":"trace[2144020128] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"113.669259ms","start":"2026-02-17T02:42:27.870070Z","end":"2026-02-17T02:42:27.983739Z","steps":["trace[2144020128] 'process raft request'  (duration: 58.287211ms)","trace[2144020128] 'compare'  (duration: 55.247484ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:27.984665Z","caller":"traceutil/trace.go:171","msg":"trace[1122936969] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"113.700289ms","start":"2026-02-17T02:42:27.870926Z","end":"2026-02-17T02:42:27.984626Z","steps":["trace[1122936969] 'process raft request'  (duration: 113.422491ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:27.985143Z","caller":"traceutil/trace.go:171","msg":"trace[56511685] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"113.898035ms","start":"2026-02-17T02:42:27.871236Z","end":"2026-02-17T02:42:27.985134Z","steps":["trace[56511685] 'process raft request'  (duration: 113.238846ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:27.985925Z","caller":"traceutil/trace.go:171","msg":"trace[1512114574] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"114.515802ms","start":"2026-02-17T02:42:27.871397Z","end":"2026-02-17T02:42:27.985912Z","steps":["trace[1512114574] 'process raft request'  (duration: 113.165083ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:27.986562Z","caller":"traceutil/trace.go:171","msg":"trace[1446038346] linearizableReadLoop","detail":"{readStateIndex:5167; appliedIndex:5163; }","duration":"108.415557ms","start":"2026-02-17T02:42:27.878131Z","end":"2026-02-17T02:42:27.986547Z","steps":["trace[1446038346] 'read index received'  (duration: 50.142046ms)","trace[1446038346] 'applied index is now lower than readState.Index'  (duration: 58.271731ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:27.986760Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.611042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/statefulset-6523/ss2-2\" limit:1 ","response":"range_response_count:1 size:3796"}
{"level":"info","ts":"2026-02-17T02:42:27.986964Z","caller":"traceutil/trace.go:171","msg":"trace[620923575] range","detail":"{range_begin:/registry/pods/statefulset-6523/ss2-2; range_end:; response_count:1; response_revision:4849; }","duration":"108.827958ms","start":"2026-02-17T02:42:27.878125Z","end":"2026-02-17T02:42:27.986953Z","steps":["trace[620923575] 'agreement among raft nodes before linearized reading'  (duration: 108.561091ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:27.987303Z","caller":"traceutil/trace.go:171","msg":"trace[1037964892] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"107.578292ms","start":"2026-02-17T02:42:27.879713Z","end":"2026-02-17T02:42:27.987291Z","steps":["trace[1037964892] 'process raft request'  (duration: 104.972627ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:27.987837Z","caller":"traceutil/trace.go:171","msg":"trace[814316025] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"109.621442ms","start":"2026-02-17T02:42:27.878205Z","end":"2026-02-17T02:42:27.987826Z","steps":["trace[814316025] 'process raft request'  (duration: 106.43725ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:28.719051Z","caller":"traceutil/trace.go:171","msg":"trace[8662748] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5178; }","duration":"103.489464ms","start":"2026-02-17T02:42:28.615543Z","end":"2026-02-17T02:42:28.719033Z","steps":["trace[8662748] 'read index received'  (duration: 98.498579ms)","trace[8662748] 'applied index is now lower than readState.Index'  (duration: 4.989855ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:28.719191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.70499ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:42:28.719211Z","caller":"traceutil/trace.go:171","msg":"trace[507007412] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4858; }","duration":"103.744441ms","start":"2026-02-17T02:42:28.615460Z","end":"2026-02-17T02:42:28.719205Z","steps":["trace[507007412] 'agreement among raft nodes before linearized reading'  (duration: 103.670439ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:28.719479Z","caller":"traceutil/trace.go:171","msg":"trace[1824677447] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4858; }","duration":"125.429763ms","start":"2026-02-17T02:42:28.594043Z","end":"2026-02-17T02:42:28.719473Z","steps":["trace[1824677447] 'process raft request'  (duration: 120.048477ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:31.556751Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1350}
{"level":"info","ts":"2026-02-17T02:42:31.593386Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":1350,"took":"35.495584ms","hash":969927399,"current-db-size-bytes":12296192,"current-db-size":"12 MB","current-db-size-in-use-bytes":9891840,"current-db-size-in-use":"9.9 MB"}
{"level":"info","ts":"2026-02-17T02:42:31.593573Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":969927399,"revision":1350,"compact-revision":-1}
{"level":"info","ts":"2026-02-17T02:43:06.273165Z","caller":"traceutil/trace.go:171","msg":"trace[614348579] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"145.350754ms","start":"2026-02-17T02:43:06.127772Z","end":"2026-02-17T02:43:06.273123Z","steps":["trace[614348579] 'process raft request'  (duration: 135.144181ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:44:10.573498Z","caller":"traceutil/trace.go:171","msg":"trace[150262831] transaction","detail":"{read_only:false; response_revision:7017; number_of_response:1; }","duration":"112.304447ms","start":"2026-02-17T02:44:10.461169Z","end":"2026-02-17T02:44:10.573473Z","steps":["trace[150262831] 'process raft request'  (duration: 112.249294ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:44:10.574024Z","caller":"traceutil/trace.go:171","msg":"trace[1881719652] transaction","detail":"{read_only:false; response_revision:7016; number_of_response:1; }","duration":"117.052961ms","start":"2026-02-17T02:44:10.456928Z","end":"2026-02-17T02:44:10.573981Z","steps":["trace[1881719652] 'process raft request'  (duration: 80.353148ms)","trace[1881719652] 'compare'  (duration: 35.986008ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:44:47.659484Z","caller":"traceutil/trace.go:171","msg":"trace[602296092] transaction","detail":"{read_only:false; response_revision:7745; number_of_response:1; }","duration":"228.353976ms","start":"2026-02-17T02:44:47.431099Z","end":"2026-02-17T02:44:47.659453Z","steps":["trace[602296092] 'process raft request'  (duration: 228.012037ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:44:47.738152Z","caller":"traceutil/trace.go:171","msg":"trace[775864799] linearizableReadLoop","detail":"{readStateIndex:8182; appliedIndex:8180; }","duration":"123.890456ms","start":"2026-02-17T02:44:47.614227Z","end":"2026-02-17T02:44:47.738118Z","steps":["trace[775864799] 'read index received'  (duration: 44.768554ms)","trace[775864799] 'applied index is now lower than readState.Index'  (duration: 79.118182ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:44:47.738706Z","caller":"traceutil/trace.go:171","msg":"trace[1959354533] transaction","detail":"{read_only:false; response_revision:7746; number_of_response:1; }","duration":"151.507826ms","start":"2026-02-17T02:44:47.587062Z","end":"2026-02-17T02:44:47.738569Z","steps":["trace[1959354533] 'process raft request'  (duration: 150.873002ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:44:47.739021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.762542ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:44:47.739170Z","caller":"traceutil/trace.go:171","msg":"trace[1089941467] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:7746; }","duration":"124.928761ms","start":"2026-02-17T02:44:47.614214Z","end":"2026-02-17T02:44:47.739143Z","steps":["trace[1089941467] 'agreement among raft nodes before linearized reading'  (duration: 124.562761ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:45:35.893022Z","caller":"etcdserver/server.go:1490","msg":"triggering snapshot","local-member-id":"e150efd79fff46f8","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-02-17T02:45:35.914991Z","caller":"etcdserver/server.go:2553","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-02-17T02:45:35.915132Z","caller":"etcdserver/server.go:2583","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-02-17T02:47:31.570586Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4901}
{"level":"info","ts":"2026-02-17T02:47:31.683263Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":4901,"took":"109.859389ms","hash":2079863624,"current-db-size-bytes":21770240,"current-db-size":"22 MB","current-db-size-in-use-bytes":14516224,"current-db-size-in-use":"14 MB"}
{"level":"info","ts":"2026-02-17T02:47:31.683648Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":2079863624,"revision":4901,"compact-revision":1350}
{"level":"info","ts":"2026-02-17T02:50:57.356944Z","caller":"traceutil/trace.go:171","msg":"trace[116987741] transaction","detail":"{read_only:false; response_revision:14285; number_of_response:1; }","duration":"112.956874ms","start":"2026-02-17T02:50:57.243965Z","end":"2026-02-17T02:50:57.356923Z","steps":["trace[116987741] 'process raft request'  (duration: 111.150655ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:51:02.650247Z","caller":"traceutil/trace.go:171","msg":"trace[171812826] transaction","detail":"{read_only:false; response_revision:14440; number_of_response:1; }","duration":"108.22002ms","start":"2026-02-17T02:51:02.541994Z","end":"2026-02-17T02:51:02.650215Z","steps":["trace[171812826] 'process raft request'  (duration: 101.165712ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:51:15.066545Z","caller":"traceutil/trace.go:171","msg":"trace[739338269] transaction","detail":"{read_only:false; response_revision:14551; number_of_response:1; }","duration":"249.364134ms","start":"2026-02-17T02:51:14.817145Z","end":"2026-02-17T02:51:15.066509Z","steps":["trace[739338269] 'process raft request'  (duration: 189.778662ms)","trace[739338269] 'compare'  (duration: 59.41694ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:51:15.164451Z","caller":"traceutil/trace.go:171","msg":"trace[693868922] linearizableReadLoop","detail":"{readStateIndex:15269; appliedIndex:15267; }","duration":"346.908332ms","start":"2026-02-17T02:51:14.817512Z","end":"2026-02-17T02:51:15.164420Z","steps":["trace[693868922] 'read index received'  (duration: 189.442389ms)","trace[693868922] 'applied index is now lower than readState.Index'  (duration: 157.463413ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:51:15.164726Z","caller":"traceutil/trace.go:171","msg":"trace[865502464] transaction","detail":"{read_only:false; response_revision:14552; number_of_response:1; }","duration":"347.215216ms","start":"2026-02-17T02:51:14.817408Z","end":"2026-02-17T02:51:15.164623Z","steps":["trace[865502464] 'process raft request'  (duration: 346.645678ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:51:15.164743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.198716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:51:15.164816Z","caller":"traceutil/trace.go:171","msg":"trace[332383004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14552; }","duration":"347.292107ms","start":"2026-02-17T02:51:14.817508Z","end":"2026-02-17T02:51:15.164800Z","steps":["trace[332383004] 'agreement among raft nodes before linearized reading'  (duration: 347.099604ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:51:15.164865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:51:14.817501Z","time spent":"347.350678ms","remote":"127.0.0.1:54880","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-02-17T02:51:15.164883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:51:14.817384Z","time spent":"347.416758ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kubectl-9806/update-demo-nautilus-9lzns\" mod_revision:14541 > success:<request_put:<key:\"/registry/pods/kubectl-9806/update-demo-nautilus-9lzns\" value_size:3416 >> failure:<request_range:<key:\"/registry/pods/kubectl-9806/update-demo-nautilus-9lzns\" > >"}
{"level":"warn","ts":"2026-02-17T02:51:15.350963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.659783ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5114009353551748353 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:14523 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:443 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:51:15.351286Z","caller":"traceutil/trace.go:171","msg":"trace[1466681974] transaction","detail":"{read_only:false; response_revision:14554; number_of_response:1; }","duration":"122.921195ms","start":"2026-02-17T02:51:15.228344Z","end":"2026-02-17T02:51:15.351265Z","steps":["trace[1466681974] 'process raft request'  (duration: 122.779623ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:51:15.351723Z","caller":"traceutil/trace.go:171","msg":"trace[1689900674] transaction","detail":"{read_only:false; response_revision:14553; number_of_response:1; }","duration":"270.959913ms","start":"2026-02-17T02:51:15.080743Z","end":"2026-02-17T02:51:15.351703Z","steps":["trace[1689900674] 'process raft request'  (duration: 125.182895ms)","trace[1689900674] 'compare'  (duration: 144.45204ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:51:15.351906Z","caller":"traceutil/trace.go:171","msg":"trace[38402197] linearizableReadLoop","detail":"{readStateIndex:15270; appliedIndex:15269; }","duration":"187.340341ms","start":"2026-02-17T02:51:15.164555Z","end":"2026-02-17T02:51:15.351895Z","steps":["trace[38402197] 'read index received'  (duration: 41.313719ms)","trace[38402197] 'applied index is now lower than readState.Index'  (duration: 146.023942ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:51:15.352094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.188537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-17T02:51:15.352169Z","caller":"traceutil/trace.go:171","msg":"trace[630394435] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:14554; }","duration":"235.268018ms","start":"2026-02-17T02:51:15.116889Z","end":"2026-02-17T02:51:15.352157Z","steps":["trace[630394435] 'agreement among raft nodes before linearized reading'  (duration: 235.146796ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:51:15.352157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.164697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:51:15.352267Z","caller":"traceutil/trace.go:171","msg":"trace[1659167794] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:14554; }","duration":"456.283178ms","start":"2026-02-17T02:51:14.895963Z","end":"2026-02-17T02:51:15.352246Z","steps":["trace[1659167794] 'agreement among raft nodes before linearized reading'  (duration: 456.123736ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:51:15.352317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T02:51:14.895937Z","time spent":"456.367469ms","remote":"127.0.0.1:55334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-02-17T02:51:15.352751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.441453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/job-7238/with-max-failed-indexes\" limit:1 ","response":"range_response_count:1 size:2002"}
{"level":"info","ts":"2026-02-17T02:51:15.352828Z","caller":"traceutil/trace.go:171","msg":"trace[394077328] range","detail":"{range_begin:/registry/jobs/job-7238/with-max-failed-indexes; range_end:; response_count:1; response_revision:14554; }","duration":"278.519874ms","start":"2026-02-17T02:51:15.074296Z","end":"2026-02-17T02:51:15.352815Z","steps":["trace[394077328] 'agreement among raft nodes before linearized reading'  (duration: 278.21738ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:51:15.353760Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.502866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:51:15.353816Z","caller":"traceutil/trace.go:171","msg":"trace[1060719398] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:14554; }","duration":"279.561437ms","start":"2026-02-17T02:51:15.074245Z","end":"2026-02-17T02:51:15.353807Z","steps":["trace[1060719398] 'agreement among raft nodes before linearized reading'  (duration: 278.800577ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:52:31.586854Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11539}
{"level":"info","ts":"2026-02-17T02:52:31.752502Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":11539,"took":"160.355386ms","hash":4254061337,"current-db-size-bytes":23166976,"current-db-size":"23 MB","current-db-size-in-use-bytes":11841536,"current-db-size-in-use":"12 MB"}
{"level":"info","ts":"2026-02-17T02:52:31.752626Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":4254061337,"revision":11539,"compact-revision":4901}
{"level":"info","ts":"2026-02-17T02:53:40.538065Z","caller":"etcdserver/server.go:1490","msg":"triggering snapshot","local-member-id":"e150efd79fff46f8","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-02-17T02:53:40.571455Z","caller":"etcdserver/server.go:2553","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-02-17T02:53:40.571650Z","caller":"etcdserver/server.go:2583","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-02-17T02:57:31.599696Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16244}
{"level":"info","ts":"2026-02-17T02:57:31.734503Z","caller":"mvcc/kvstore_compaction.go:72","msg":"finished scheduled compaction","compact-revision":16244,"took":"129.429936ms","hash":3496916025,"current-db-size-bytes":25944064,"current-db-size":"26 MB","current-db-size-in-use-bytes":18706432,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-02-17T02:57:31.735355Z","caller":"mvcc/hash.go:151","msg":"storing new hash","hash":3496916025,"revision":16244,"compact-revision":11539}
{"level":"info","ts":"2026-02-17T02:57:45.474083Z","caller":"traceutil/trace.go:171","msg":"trace[536429752] transaction","detail":"{read_only:false; response_revision:23136; number_of_response:1; }","duration":"113.051013ms","start":"2026-02-17T02:57:45.361018Z","end":"2026-02-17T02:57:45.474069Z","steps":["trace[536429752] 'process raft request'  (duration: 112.808852ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:57:45.474065Z","caller":"traceutil/trace.go:171","msg":"trace[560866169] transaction","detail":"{read_only:false; response_revision:23135; number_of_response:1; }","duration":"124.291094ms","start":"2026-02-17T02:57:45.349753Z","end":"2026-02-17T02:57:45.474044Z","steps":["trace[560866169] 'process raft request'  (duration: 123.709097ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:57:45.616010Z","caller":"traceutil/trace.go:171","msg":"trace[1699001094] transaction","detail":"{read_only:false; response_revision:23138; number_of_response:1; }","duration":"132.454173ms","start":"2026-02-17T02:57:45.483515Z","end":"2026-02-17T02:57:45.615969Z","steps":["trace[1699001094] 'process raft request'  (duration: 108.155896ms)","trace[1699001094] 'compare'  (duration: 23.742532ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:57:45.616159Z","caller":"traceutil/trace.go:171","msg":"trace[1180624712] transaction","detail":"{read_only:false; response_revision:23139; number_of_response:1; }","duration":"110.858811ms","start":"2026-02-17T02:57:45.505276Z","end":"2026-02-17T02:57:45.616136Z","steps":["trace[1180624712] 'process raft request'  (duration: 110.40512ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:59:17.033433Z","caller":"traceutil/trace.go:171","msg":"trace[849824547] transaction","detail":"{read_only:false; response_revision:26431; number_of_response:1; }","duration":"127.192709ms","start":"2026-02-17T02:59:16.906215Z","end":"2026-02-17T02:59:17.033408Z","steps":["trace[849824547] 'process raft request'  (duration: 124.293946ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T03:01:12.222353Z","caller":"etcdserver/server.go:1490","msg":"triggering snapshot","local-member-id":"e150efd79fff46f8","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-02-17T03:01:12.238215Z","caller":"etcdserver/server.go:2553","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-02-17T03:01:12.238392Z","caller":"etcdserver/server.go:2583","msg":"compacted Raft logs","compact-index":25003}
