{"level":"warn","ts":"2026-02-17T02:29:04.157370Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"warn","ts":"2026-02-17T02:29:04.161565Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."}
{"level":"info","ts":"2026-02-17T02:29:04.162404Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://192.168.24.160:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://192.168.24.160:2380","--initial-cluster=kube-e17cw-vl7vr-pzpkv=https://192.168.24.160:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://192.168.24.160:2379","--listen-peer-urls=https://192.168.24.160:2380","--name=kube-e17cw-vl7vr-pzpkv","--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","--watch-progress-notify-interval=5s","--listen-metrics-urls=http://0.0.0.0:2381"]}
{"level":"info","ts":"2026-02-17T02:29:04.162616Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"}
{"level":"warn","ts":"2026-02-17T02:29:04.162696Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-02-17T02:29:04.162730Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://192.168.24.160:2380"]}
{"level":"info","ts":"2026-02-17T02:29:04.162876Z","caller":"embed/etcd.go:544","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:29:04.169103Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://192.168.24.160:2379"]}
{"level":"info","ts":"2026-02-17T02:29:04.169325Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.6","git-sha":"d2809cf","go-version":"go1.24.10","go-os":"linux","go-arch":"amd64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"kube-e17cw-vl7vr-pzpkv","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.160:2380"],"listen-peer-urls":["https://192.168.24.160:2380"],"advertise-client-urls":["https://192.168.24.160:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://192.168.24.160:2379"],"listen-metrics-urls":["http://0.0.0.0:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"kube-e17cw-vl7vr-pzpkv=https://192.168.24.160: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,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"}
{"level":"info","ts":"2026-02-17T02:29:04.179544Z","logger":"bbolt","caller":"backend/backend.go:203","msg":"Opening db file (/var/lib/etcd/member/snap/db) with mode -rw------- and with options: {Timeout: 0s, NoGrowSync: false, NoFreelistSync: true, PreLoadFreelist: false, FreelistType: hashmap, ReadOnly: false, MmapFlags: 8000, InitialMmapSize: 10737418240, PageSize: 0, NoSync: false, OpenFile: 0x0, Mlock: false, Logger: 0xc0000b66b8}"}
{"level":"info","ts":"2026-02-17T02:29:04.195225Z","logger":"bbolt","caller":"bbolt@v1.4.3/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"}
{"level":"info","ts":"2026-02-17T02:29:04.195465Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"24.85621ms"}
{"level":"info","ts":"2026-02-17T02:29:04.195723Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0}
{"level":"info","ts":"2026-02-17T02:29:04.196968Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"}
{"level":"info","ts":"2026-02-17T02:29:04.198181Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"}
{"level":"info","ts":"2026-02-17T02:29:04.217978Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"}
{"level":"info","ts":"2026-02-17T02:29:04.218606Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"2541a250140d68d4","cluster-id":"4bb5081b4762d285"}
{"level":"info","ts":"2026-02-17T02:29:04.219148Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"}
{"level":"info","ts":"2026-02-17T02:29:04.222450Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"2541a250140d68d4 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-17T02:29:04.226530Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"2541a250140d68d4 became follower at term 0"}
{"level":"info","ts":"2026-02-17T02:29:04.226585Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 2541a250140d68d4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-17T02:29:04.226693Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"2541a250140d68d4 became follower at term 1"}
{"level":"info","ts":"2026-02-17T02:29:04.226919Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"2541a250140d68d4 switched to configuration voters=(2684605317707032788)"}
{"level":"warn","ts":"2026-02-17T02:29:04.262499Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-17T02:29:04.271285Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-17T02:29:04.280689Z","caller":"storage/quota.go:93","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:29:04.281561Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"2541a250140d68d4","local-server-version":"3.6.6","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-17T02:29:04.282526Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2541a250140d68d4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-17T02:29:04.283513Z","caller":"embed/etcd.go:766","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:29:04.283987Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"2541a250140d68d4 switched to configuration voters=(2684605317707032788)"}
{"level":"info","ts":"2026-02-17T02:29:04.284331Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"4bb5081b4762d285","local-member-id":"2541a250140d68d4","added-peer-id":"2541a250140d68d4","added-peer-peer-urls":["https://192.168.24.160:2380"],"added-peer-is-learner":false}
{"level":"info","ts":"2026-02-17T02:29:04.283970Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"192.168.24.160:2380"}
{"level":"info","ts":"2026-02-17T02:29:04.284985Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"192.168.24.160:2380"}
{"level":"info","ts":"2026-02-17T02:29:04.285272Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-17T02:29:04.285361Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-17T02:29:04.285376Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-02-17T02:29:04.285366Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"2541a250140d68d4","initial-advertise-peer-urls":["https://192.168.24.160:2380"],"listen-peer-urls":["https://192.168.24.160:2380"],"advertise-client-urls":["https://192.168.24.160:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://192.168.24.160:2379"],"listen-metrics-urls":["http://0.0.0.0:2381"]}
{"level":"info","ts":"2026-02-17T02:29:04.285685Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://0.0.0.0:2381"}
{"level":"info","ts":"2026-02-17T02:29:04.427928Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"2541a250140d68d4 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-17T02:29:04.428008Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"2541a250140d68d4 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-17T02:29:04.428139Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"2541a250140d68d4 received MsgPreVoteResp from 2541a250140d68d4 at term 1"}
{"level":"info","ts":"2026-02-17T02:29:04.428157Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"2541a250140d68d4 has received 1 MsgPreVoteResp votes and 0 vote rejections"}
{"level":"info","ts":"2026-02-17T02:29:04.428204Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"2541a250140d68d4 became candidate at term 2"}
{"level":"info","ts":"2026-02-17T02:29:04.431491Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"2541a250140d68d4 received MsgVoteResp from 2541a250140d68d4 at term 2"}
{"level":"info","ts":"2026-02-17T02:29:04.431564Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"2541a250140d68d4 has received 1 MsgVoteResp votes and 0 vote rejections"}
{"level":"info","ts":"2026-02-17T02:29:04.431596Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"2541a250140d68d4 became leader at term 2"}
{"level":"info","ts":"2026-02-17T02:29:04.431847Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 2541a250140d68d4 elected leader 2541a250140d68d4 at term 2"}
{"level":"info","ts":"2026-02-17T02:29:04.434504Z","caller":"etcdserver/server.go:2420","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"}
{"level":"info","ts":"2026-02-17T02:29:04.437483Z","caller":"etcdserver/server.go:1820","msg":"published local member to cluster through raft","local-member-id":"2541a250140d68d4","local-member-attributes":"{Name:kube-e17cw-vl7vr-pzpkv ClientURLs:[https://192.168.24.160:2379]}","cluster-id":"4bb5081b4762d285","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-17T02:29:04.437526Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-17T02:29:04.438385Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-17T02:29:04.438551Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-17T02:29:04.438640Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-17T02:29:04.440840Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"4bb5081b4762d285","local-member-id":"2541a250140d68d4","cluster-version":"3.6"}
{"level":"info","ts":"2026-02-17T02:29:04.441138Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"}
{"level":"info","ts":"2026-02-17T02:29:04.441296Z","caller":"etcdserver/server.go:2440","msg":"cluster version is updated","cluster-version":"3.6"}
{"level":"info","ts":"2026-02-17T02:29:04.441452Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"}
{"level":"info","ts":"2026-02-17T02:29:04.441872Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"}
{"level":"info","ts":"2026-02-17T02:29:04.464327Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"}
{"level":"info","ts":"2026-02-17T02:29:04.465505Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"}
{"level":"info","ts":"2026-02-17T02:29:04.474329Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-17T02:29:04.474425Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"192.168.24.160:2379"}
{"level":"warn","ts":"2026-02-17T02:29:11.193248Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.01849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-02-17T02:29:11.193349Z","caller":"traceutil/trace.go:172","msg":"trace[1073756589] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:271; }","duration":"106.21303ms","start":"2026-02-17T02:29:11.087115Z","end":"2026-02-17T02:29:11.193328Z","steps":["trace[1073756589] 'range keys from in-memory index tree'  (duration: 105.81234ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:30:48.702107Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"269.75181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/calico-node-749gm\" limit:1 ","response":"range_response_count:1 size:13796"}
{"level":"info","ts":"2026-02-17T02:30:48.702226Z","caller":"traceutil/trace.go:172","msg":"trace[1676684377] range","detail":"{range_begin:/registry/pods/kube-system/calico-node-749gm; range_end:; response_count:1; response_revision:725; }","duration":"269.876946ms","start":"2026-02-17T02:30:48.432329Z","end":"2026-02-17T02:30:48.702206Z","steps":["trace[1676684377] 'range keys from in-memory index tree'  (duration: 269.532892ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:30:50.329116Z","caller":"traceutil/trace.go:172","msg":"trace[1862614048] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"169.600959ms","start":"2026-02-17T02:30:50.159496Z","end":"2026-02-17T02:30:50.329097Z","steps":["trace[1862614048] 'process raft request'  (duration: 169.497906ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:11.309838Z","caller":"traceutil/trace.go:172","msg":"trace[665204591] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"215.374724ms","start":"2026-02-17T02:31:11.094437Z","end":"2026-02-17T02:31:11.309812Z","steps":["trace[665204591] 'process raft request'  (duration: 155.827615ms)","trace[665204591] 'compare'  (duration: 59.24696ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:31:21.374109Z","caller":"traceutil/trace.go:172","msg":"trace[624511203] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"112.299485ms","start":"2026-02-17T02:31:21.261791Z","end":"2026-02-17T02:31:21.374091Z","steps":["trace[624511203] 'process raft request'  (duration: 47.380537ms)","trace[624511203] 'compare'  (duration: 64.618687ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:31:28.559271Z","caller":"traceutil/trace.go:172","msg":"trace[1305882682] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"519.116056ms","start":"2026-02-17T02:31:28.040136Z","end":"2026-02-17T02:31:28.559252Z","steps":["trace[1305882682] 'process raft request'  (duration: 518.971038ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:28.559776Z","caller":"traceutil/trace.go:172","msg":"trace[1347899442] linearizableReadLoop","detail":"{readStateIndex:940; appliedIndex:940; }","duration":"285.970961ms","start":"2026-02-17T02:31:28.273206Z","end":"2026-02-17T02:31:28.559177Z","steps":["trace[1347899442] 'read index received'  (duration: 285.800333ms)","trace[1347899442] 'applied index is now lower than readState.Index'  (duration: 100.319µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:28.559948Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:28.040115Z","time spent":"519.227715ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4916,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-proxy-qwmdh\" mod_revision:881 > success:<request_put:<key:\"/registry/pods/kube-system/kube-proxy-qwmdh\" value_size:4865 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-proxy-qwmdh\" > >"}
{"level":"info","ts":"2026-02-17T02:31:28.560372Z","caller":"traceutil/trace.go:172","msg":"trace[1971585238] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"325.824631ms","start":"2026-02-17T02:31:28.234531Z","end":"2026-02-17T02:31:28.560356Z","steps":["trace[1971585238] 'process raft request'  (duration: 325.683222ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:28.560366Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"287.206708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:28.560686Z","caller":"traceutil/trace.go:172","msg":"trace[1405560339] range","detail":"{range_begin:/registry/endpointslices; range_end:; response_count:0; response_revision:897; }","duration":"287.529754ms","start":"2026-02-17T02:31:28.273142Z","end":"2026-02-17T02:31:28.560672Z","steps":["trace[1405560339] 'agreement among raft nodes before linearized reading'  (duration: 286.799732ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:28.560547Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:28.234511Z","time spent":"325.96443ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":504,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:887 > 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:31:32.707848Z","caller":"traceutil/trace.go:172","msg":"trace[1634673388] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"127.564457ms","start":"2026-02-17T02:31:32.580264Z","end":"2026-02-17T02:31:32.707829Z","steps":["trace[1634673388] 'process raft request'  (duration: 127.456757ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:33.174291Z","caller":"traceutil/trace.go:172","msg":"trace[174680923] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:965; }","duration":"368.674866ms","start":"2026-02-17T02:31:32.805583Z","end":"2026-02-17T02:31:33.174257Z","steps":["trace[174680923] 'read index received'  (duration: 368.663436ms)","trace[174680923] 'applied index is now lower than readState.Index'  (duration: 8.26µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:33.292526Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"294.177837ms","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:31:33.292617Z","caller":"traceutil/trace.go:172","msg":"trace[2049399909] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:920; }","duration":"294.277157ms","start":"2026-02-17T02:31:32.998323Z","end":"2026-02-17T02:31:33.292600Z","steps":["trace[2049399909] 'range keys from in-memory index tree'  (duration: 294.153397ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:33.292886Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.4618ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638578434 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/kube-e17cw-vl7vr-pzpkv.1894e7ddaadc41ed\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/kube-e17cw-vl7vr-pzpkv.1894e7ddaadc41ed\" value_size:610 lease:7553834451638578019 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:31:33.292949Z","caller":"traceutil/trace.go:172","msg":"trace[390609810] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"583.164966ms","start":"2026-02-17T02:31:32.709775Z","end":"2026-02-17T02:31:33.292940Z","steps":["trace[390609810] 'process raft request'  (duration: 464.455956ms)","trace[390609810] 'compare'  (duration: 118.100209ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:33.293061Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:32.709754Z","time spent":"583.268436ms","remote":"127.0.0.1:59182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":692,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/kube-e17cw-vl7vr-pzpkv.1894e7ddaadc41ed\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/kube-e17cw-vl7vr-pzpkv.1894e7ddaadc41ed\" value_size:610 lease:7553834451638578019 >> failure:<>"}
{"level":"warn","ts":"2026-02-17T02:31:33.293155Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"487.072506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/calico-node-749gm\" limit:1 ","response":"range_response_count:1 size:14435"}
{"level":"info","ts":"2026-02-17T02:31:33.293219Z","caller":"traceutil/trace.go:172","msg":"trace[974740015] range","detail":"{range_begin:/registry/pods/kube-system/calico-node-749gm; range_end:; response_count:1; response_revision:920; }","duration":"487.625596ms","start":"2026-02-17T02:31:32.805576Z","end":"2026-02-17T02:31:33.293202Z","steps":["trace[974740015] 'agreement among raft nodes before linearized reading'  (duration: 368.934467ms)","trace[974740015] 'range keys from in-memory index tree'  (duration: 118.049729ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:33.293250Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:32.805555Z","time spent":"487.686426ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":14457,"request content":"key:\"/registry/pods/kube-system/calico-node-749gm\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:31:33.395085Z","caller":"traceutil/trace.go:172","msg":"trace[1574057722] linearizableReadLoop","detail":"{readStateIndex:966; appliedIndex:966; }","duration":"220.586937ms","start":"2026-02-17T02:31:33.174473Z","end":"2026-02-17T02:31:33.395060Z","steps":["trace[1574057722] 'read index received'  (duration: 220.575837ms)","trace[1574057722] 'applied index is now lower than readState.Index'  (duration: 8.46µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:33.479831Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"629.304469ms","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:31:33.479914Z","caller":"traceutil/trace.go:172","msg":"trace[751115941] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:921; }","duration":"629.393679ms","start":"2026-02-17T02:31:32.850504Z","end":"2026-02-17T02:31:33.479898Z","steps":["trace[751115941] 'agreement among raft nodes before linearized reading'  (duration: 544.796612ms)","trace[751115941] 'range keys from in-memory index tree'  (duration: 84.486817ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:33.479944Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:32.850474Z","time spent":"629.461029ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/pods\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:31:33.479843Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"620.636278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:33.480121Z","caller":"traceutil/trace.go:172","msg":"trace[1853243084] range","detail":"{range_begin:/registry/prioritylevelconfigurations; range_end:; response_count:0; response_revision:921; }","duration":"620.930148ms","start":"2026-02-17T02:31:32.859171Z","end":"2026-02-17T02:31:33.480102Z","steps":["trace[1853243084] 'agreement among raft nodes before linearized reading'  (duration: 536.107811ms)","trace[1853243084] 'range keys from in-memory index tree'  (duration: 84.495067ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:33.480183Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:32.859145Z","time spent":"621.025768ms","remote":"127.0.0.1:59910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":27,"request content":"key:\"/registry/prioritylevelconfigurations\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:31:33.480096Z","caller":"traceutil/trace.go:172","msg":"trace[1151065763] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"766.646986ms","start":"2026-02-17T02:31:32.713380Z","end":"2026-02-17T02:31:33.480086Z","steps":["trace[1151065763] 'process raft request'  (duration: 681.923009ms)","trace[1151065763] 'compare'  (duration: 84.210566ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:33.480864Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:32.713360Z","time spent":"767.451427ms","remote":"127.0.0.1:59330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5777,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/minions/kube-e17cw-vl7vr-pzpkv\" mod_revision:812 > success:<request_put:<key:\"/registry/minions/kube-e17cw-vl7vr-pzpkv\" value_size:5729 >> failure:<request_range:<key:\"/registry/minions/kube-e17cw-vl7vr-pzpkv\" > >"}
{"level":"info","ts":"2026-02-17T02:31:33.506646Z","caller":"traceutil/trace.go:172","msg":"trace[1058882889] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:967; }","duration":"111.377691ms","start":"2026-02-17T02:31:33.395248Z","end":"2026-02-17T02:31:33.506626Z","steps":["trace[1058882889] 'read index received'  (duration: 111.368301ms)","trace[1058882889] 'applied index is now lower than readState.Index'  (duration: 6.68µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:33.506959Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"214.29374ms","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:31:33.507084Z","caller":"traceutil/trace.go:172","msg":"trace[495364524] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:922; }","duration":"214.42392ms","start":"2026-02-17T02:31:33.292646Z","end":"2026-02-17T02:31:33.507070Z","steps":["trace[495364524] 'agreement among raft nodes before linearized reading'  (duration: 214.26294ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:33.507968Z","caller":"traceutil/trace.go:172","msg":"trace[656824065] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"198.161299ms","start":"2026-02-17T02:31:33.309732Z","end":"2026-02-17T02:31:33.507893Z","steps":["trace[656824065] 'process raft request'  (duration: 198.019699ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:33.747570Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.277236ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638578439 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:911 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:427 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:31:33.747843Z","caller":"traceutil/trace.go:172","msg":"trace[1260532270] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"273.675126ms","start":"2026-02-17T02:31:33.474147Z","end":"2026-02-17T02:31:33.747822Z","steps":["trace[1260532270] 'process raft request'  (duration: 149.89201ms)","trace[1260532270] 'compare'  (duration: 123.151556ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:31:33.748513Z","caller":"traceutil/trace.go:172","msg":"trace[1313262732] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"256.763584ms","start":"2026-02-17T02:31:33.491740Z","end":"2026-02-17T02:31:33.748504Z","steps":["trace[1313262732] 'process raft request'  (duration: 255.951213ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:34.095726Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"233.698951ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638578443 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/openstack-cloud-controller-manager-sgq4s\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/openstack-cloud-controller-manager-sgq4s\" value_size:4211 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:31:34.095851Z","caller":"traceutil/trace.go:172","msg":"trace[927665288] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:970; }","duration":"137.577258ms","start":"2026-02-17T02:31:33.958259Z","end":"2026-02-17T02:31:34.095836Z","steps":["trace[927665288] 'read index received'  (duration: 51.38µs)","trace[927665288] 'applied index is now lower than readState.Index'  (duration: 137.523298ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:34.097014Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"138.778602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:34.097063Z","caller":"traceutil/trace.go:172","msg":"trace[1933585785] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:926; }","duration":"138.829743ms","start":"2026-02-17T02:31:33.958224Z","end":"2026-02-17T02:31:34.097054Z","steps":["trace[1933585785] 'agreement among raft nodes before linearized reading'  (duration: 138.748472ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:34.097228Z","caller":"traceutil/trace.go:172","msg":"trace[1286610631] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"339.350127ms","start":"2026-02-17T02:31:33.757867Z","end":"2026-02-17T02:31:34.097218Z","steps":["trace[1286610631] 'process raft request'  (duration: 104.105562ms)","trace[1286610631] 'compare'  (duration: 232.836957ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:34.097266Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:33.757844Z","time spent":"339.402347ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4286,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/openstack-cloud-controller-manager-sgq4s\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/openstack-cloud-controller-manager-sgq4s\" value_size:4211 >> failure:<>"}
{"level":"warn","ts":"2026-02-17T02:31:34.097855Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"102.577658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:34.097900Z","caller":"traceutil/trace.go:172","msg":"trace[1885452033] range","detail":"{range_begin:/registry/leases/kube-node-lease/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k; range_end:; response_count:0; response_revision:926; }","duration":"102.623209ms","start":"2026-02-17T02:31:33.995268Z","end":"2026-02-17T02:31:34.097891Z","steps":["trace[1885452033] 'agreement among raft nodes before linearized reading'  (duration: 102.557668ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:38.118721Z","caller":"traceutil/trace.go:172","msg":"trace[1430036915] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1018; }","duration":"173.04765ms","start":"2026-02-17T02:31:37.945562Z","end":"2026-02-17T02:31:38.118610Z","steps":["trace[1430036915] 'read index received'  (duration: 173.03728ms)","trace[1430036915] 'applied index is now lower than readState.Index'  (duration: 7.95µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:38.119317Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"173.740108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:38.119405Z","caller":"traceutil/trace.go:172","msg":"trace[1379380012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"173.834589ms","start":"2026-02-17T02:31:37.945556Z","end":"2026-02-17T02:31:38.119391Z","steps":["trace[1379380012] 'agreement among raft nodes before linearized reading'  (duration: 173.649637ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:38.120002Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"164.894773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:38.120478Z","caller":"traceutil/trace.go:172","msg":"trace[1585618654] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:973; }","duration":"165.328528ms","start":"2026-02-17T02:31:37.955099Z","end":"2026-02-17T02:31:38.120428Z","steps":["trace[1585618654] 'agreement among raft nodes before linearized reading'  (duration: 164.874123ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:38.120936Z","caller":"traceutil/trace.go:172","msg":"trace[1838387709] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"263.333329ms","start":"2026-02-17T02:31:37.857593Z","end":"2026-02-17T02:31:38.120926Z","steps":["trace[1838387709] 'process raft request'  (duration: 261.74394ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:39.880326Z","caller":"traceutil/trace.go:172","msg":"trace[1541509402] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"155.201963ms","start":"2026-02-17T02:31:39.725094Z","end":"2026-02-17T02:31:39.880295Z","steps":["trace[1541509402] 'process raft request'  (duration: 124.25628ms)","trace[1541509402] 'compare'  (duration: 30.365255ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:31:45.517848Z","caller":"traceutil/trace.go:172","msg":"trace[304367345] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1219; }","duration":"161.909966ms","start":"2026-02-17T02:31:45.355914Z","end":"2026-02-17T02:31:45.517824Z","steps":["trace[304367345] 'read index received'  (duration: 161.900026ms)","trace[304367345] 'applied index is now lower than readState.Index'  (duration: 7.19µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:45.518063Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"162.165553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/stagedkubernetesnetworkpolicies\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:45.518099Z","caller":"traceutil/trace.go:172","msg":"trace[599585159] range","detail":"{range_begin:/registry/crd.projectcalico.org/stagedkubernetesnetworkpolicies; range_end:; response_count:0; response_revision:1164; }","duration":"162.216234ms","start":"2026-02-17T02:31:45.355871Z","end":"2026-02-17T02:31:45.518087Z","steps":["trace[599585159] 'agreement among raft nodes before linearized reading'  (duration: 162.119871ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:45.520149Z","caller":"traceutil/trace.go:172","msg":"trace[307084741] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"180.04562ms","start":"2026-02-17T02:31:45.340087Z","end":"2026-02-17T02:31:45.520133Z","steps":["trace[307084741] 'process raft request'  (duration: 178.639996ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:45.521691Z","caller":"traceutil/trace.go:172","msg":"trace[1964483186] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"176.292721ms","start":"2026-02-17T02:31:45.345375Z","end":"2026-02-17T02:31:45.521667Z","steps":["trace[1964483186] 'process raft request'  (duration: 176.087946ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:50.339880Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"250.398822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:50.339973Z","caller":"traceutil/trace.go:172","msg":"trace[359837125] range","detail":"{range_begin:/registry/persistentvolumes; range_end:; response_count:0; response_revision:1216; }","duration":"250.500325ms","start":"2026-02-17T02:31:50.089453Z","end":"2026-02-17T02:31:50.339953Z","steps":["trace[359837125] 'range keys from in-memory index tree'  (duration: 250.235117ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:50.356029Z","caller":"traceutil/trace.go:172","msg":"trace[1114546778] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"259.957989ms","start":"2026-02-17T02:31:50.096056Z","end":"2026-02-17T02:31:50.356013Z","steps":["trace[1114546778] 'process raft request'  (duration: 259.815645ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:50.356528Z","caller":"traceutil/trace.go:172","msg":"trace[2112042726] linearizableReadLoop","detail":"{readStateIndex:1278; appliedIndex:1278; }","duration":"246.050526ms","start":"2026-02-17T02:31:50.110086Z","end":"2026-02-17T02:31:50.355408Z","steps":["trace[2112042726] 'read index received'  (duration: 245.313663ms)","trace[2112042726] 'applied index is now lower than readState.Index'  (duration: 6.06µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:50.357719Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"247.622675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/openstack-cinder-csi-nodeplugin-8zdst\" limit:1 ","response":"range_response_count:1 size:8769"}
{"level":"info","ts":"2026-02-17T02:31:50.361121Z","caller":"traceutil/trace.go:172","msg":"trace[1478228557] range","detail":"{range_begin:/registry/pods/kube-system/openstack-cinder-csi-nodeplugin-8zdst; range_end:; response_count:1; response_revision:1217; }","duration":"251.027651ms","start":"2026-02-17T02:31:50.110080Z","end":"2026-02-17T02:31:50.361108Z","steps":["trace[1478228557] 'agreement among raft nodes before linearized reading'  (duration: 245.614472ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:50.389005Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"277.31433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/calico-kube-controllers-565c89d6df-kkhz2\" limit:1 ","response":"range_response_count:1 size:5288"}
{"level":"info","ts":"2026-02-17T02:31:50.389151Z","caller":"traceutil/trace.go:172","msg":"trace[1853141507] range","detail":"{range_begin:/registry/pods/kube-system/calico-kube-controllers-565c89d6df-kkhz2; range_end:; response_count:1; response_revision:1217; }","duration":"277.468524ms","start":"2026-02-17T02:31:50.111665Z","end":"2026-02-17T02:31:50.389133Z","steps":["trace[1853141507] 'agreement among raft nodes before linearized reading'  (duration: 276.931148ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:50.389180Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"155.486699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ipamblocks\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:50.389246Z","caller":"traceutil/trace.go:172","msg":"trace[1757847638] range","detail":"{range_begin:/registry/crd.projectcalico.org/ipamblocks; range_end:; response_count:0; response_revision:1217; }","duration":"155.567841ms","start":"2026-02-17T02:31:50.233665Z","end":"2026-02-17T02:31:50.389232Z","steps":["trace[1757847638] 'agreement among raft nodes before linearized reading'  (duration: 155.416507ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:50.389995Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"235.87916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ipreservations\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:50.390469Z","caller":"traceutil/trace.go:172","msg":"trace[1956454908] range","detail":"{range_begin:/registry/crd.projectcalico.org/ipreservations; range_end:; response_count:0; response_revision:1218; }","duration":"236.353624ms","start":"2026-02-17T02:31:50.154099Z","end":"2026-02-17T02:31:50.390453Z","steps":["trace[1956454908] 'agreement among raft nodes before linearized reading'  (duration: 235.494438ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:50.517449Z","caller":"traceutil/trace.go:172","msg":"trace[89005865] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"145.961381ms","start":"2026-02-17T02:31:50.371469Z","end":"2026-02-17T02:31:50.517431Z","steps":["trace[89005865] 'process raft request'  (duration: 88.572075ms)","trace[89005865] 'compare'  (duration: 57.252892ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:31:50.519133Z","caller":"traceutil/trace.go:172","msg":"trace[1825427173] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"116.407852ms","start":"2026-02-17T02:31:50.402696Z","end":"2026-02-17T02:31:50.519104Z","steps":["trace[1825427173] 'process raft request'  (duration: 116.216786ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:52.553794Z","caller":"traceutil/trace.go:172","msg":"trace[1076510781] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"106.702663ms","start":"2026-02-17T02:31:52.447067Z","end":"2026-02-17T02:31:52.553770Z","steps":["trace[1076510781] 'process raft request'  (duration: 93.949434ms)","trace[1076510781] 'compare'  (duration: 12.614065ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:31:52.557171Z","caller":"traceutil/trace.go:172","msg":"trace[167629524] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"107.042785ms","start":"2026-02-17T02:31:52.450109Z","end":"2026-02-17T02:31:52.557151Z","steps":["trace[167629524] 'process raft request'  (duration: 106.938312ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:58.006861Z","caller":"traceutil/trace.go:172","msg":"trace[809671925] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"162.984629ms","start":"2026-02-17T02:31:57.843854Z","end":"2026-02-17T02:31:58.006839Z","steps":["trace[809671925] 'process raft request'  (duration: 162.241309ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:58.390906Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"329.161182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/manila-csi-openstack-manila-csi-nodeplugin-m4xxk\" limit:1 ","response":"range_response_count:1 size:7179"}
{"level":"info","ts":"2026-02-17T02:31:58.390971Z","caller":"traceutil/trace.go:172","msg":"trace[1548214001] range","detail":"{range_begin:/registry/pods/kube-system/manila-csi-openstack-manila-csi-nodeplugin-m4xxk; range_end:; response_count:1; response_revision:1295; }","duration":"329.239905ms","start":"2026-02-17T02:31:58.061719Z","end":"2026-02-17T02:31:58.390959Z","steps":["trace[1548214001] 'agreement among raft nodes before linearized reading'  (duration: 79.56831ms)","trace[1548214001] 'range keys from in-memory index tree'  (duration: 249.489028ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:58.391019Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:58.061690Z","time spent":"329.302938ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":7201,"request content":"key:\"/registry/pods/kube-system/manila-csi-openstack-manila-csi-nodeplugin-m4xxk\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:31:58.391691Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"250.271319ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638579235 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/csinodes/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k\" mod_revision:1267 > success:<request_put:<key:\"/registry/csinodes/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k\" value_size:1272 >> failure:<request_range:<key:\"/registry/csinodes/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:31:58.391888Z","caller":"traceutil/trace.go:172","msg":"trace[988399267] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"294.799012ms","start":"2026-02-17T02:31:58.097078Z","end":"2026-02-17T02:31:58.391877Z","steps":["trace[988399267] 'process raft request'  (duration: 294.743569ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:31:58.391907Z","caller":"traceutil/trace.go:172","msg":"trace[449054626] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"361.343555ms","start":"2026-02-17T02:31:58.030554Z","end":"2026-02-17T02:31:58.391897Z","steps":["trace[449054626] 'process raft request'  (duration: 110.805235ms)","trace[449054626] 'compare'  (duration: 249.900165ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:31:58.392157Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"240.875129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:31:58.392174Z","caller":"traceutil/trace.go:172","msg":"trace[518660679] range","detail":"{range_begin:/registry/certificatesigningrequests; range_end:; response_count:0; response_revision:1297; }","duration":"240.89432ms","start":"2026-02-17T02:31:58.151275Z","end":"2026-02-17T02:31:58.392170Z","steps":["trace[518660679] 'agreement among raft nodes before linearized reading'  (duration: 240.860279ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:31:58.392180Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:31:58.030421Z","time spent":"361.732351ms","remote":"127.0.0.1:59848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1342,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/csinodes/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k\" mod_revision:1267 > success:<request_put:<key:\"/registry/csinodes/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k\" value_size:1272 >> failure:<request_range:<key:\"/registry/csinodes/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k\" > >"}
{"level":"info","ts":"2026-02-17T02:31:58.392105Z","caller":"traceutil/trace.go:172","msg":"trace[1000944834] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1359; }","duration":"240.777586ms","start":"2026-02-17T02:31:58.151320Z","end":"2026-02-17T02:31:58.392097Z","steps":["trace[1000944834] 'read index received'  (duration: 182.678284ms)","trace[1000944834] 'applied index is now lower than readState.Index'  (duration: 58.098261ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:31:58.557925Z","caller":"traceutil/trace.go:172","msg":"trace[1008432765] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"100.80058ms","start":"2026-02-17T02:31:58.457106Z","end":"2026-02-17T02:31:58.557907Z","steps":["trace[1008432765] 'process raft request'  (duration: 53.510896ms)","trace[1008432765] 'compare'  (duration: 45.884598ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:31:58.997830Z","caller":"traceutil/trace.go:172","msg":"trace[183905417] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"113.598378ms","start":"2026-02-17T02:31:58.884213Z","end":"2026-02-17T02:31:58.997812Z","steps":["trace[183905417] 'process raft request'  (duration: 111.255993ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:15.244424Z","caller":"traceutil/trace.go:172","msg":"trace[163828755] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"163.747188ms","start":"2026-02-17T02:32:15.080648Z","end":"2026-02-17T02:32:15.244395Z","steps":["trace[163828755] 'process raft request'  (duration: 163.019259ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:20.564378Z","caller":"traceutil/trace.go:172","msg":"trace[2012608842] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"275.057276ms","start":"2026-02-17T02:32:20.289302Z","end":"2026-02-17T02:32:20.564359Z","steps":["trace[2012608842] 'process raft request'  (duration: 274.858775ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:20.572892Z","caller":"traceutil/trace.go:172","msg":"trace[74735117] transaction","detail":"{read_only:false; response_revision:1483; number_of_response:1; }","duration":"208.195633ms","start":"2026-02-17T02:32:20.364630Z","end":"2026-02-17T02:32:20.572825Z","steps":["trace[74735117] 'process raft request'  (duration: 207.758618ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:25.863577Z","caller":"traceutil/trace.go:172","msg":"trace[1280984063] linearizableReadLoop","detail":"{readStateIndex:1588; appliedIndex:1588; }","duration":"205.804474ms","start":"2026-02-17T02:32:25.657754Z","end":"2026-02-17T02:32:25.863558Z","steps":["trace[1280984063] 'read index received'  (duration: 205.798434ms)","trace[1280984063] 'applied index is now lower than readState.Index'  (duration: 4.29µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:32:25.864156Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"206.387368ms","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:32:25.864265Z","caller":"traceutil/trace.go:172","msg":"trace[2138708639] range","detail":"{range_begin:/registry/leases/kube-system/nfs-csi-k8s-io; range_end:; response_count:1; response_revision:1503; }","duration":"206.503025ms","start":"2026-02-17T02:32:25.657749Z","end":"2026-02-17T02:32:25.864252Z","steps":["trace[2138708639] 'agreement among raft nodes before linearized reading'  (duration: 206.127763ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:25.865298Z","caller":"traceutil/trace.go:172","msg":"trace[1174736509] transaction","detail":"{read_only:false; response_revision:1504; number_of_response:1; }","duration":"295.943551ms","start":"2026-02-17T02:32:25.569316Z","end":"2026-02-17T02:32:25.865260Z","steps":["trace[1174736509] 'process raft request'  (duration: 295.268922ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:26.048297Z","caller":"traceutil/trace.go:172","msg":"trace[1185342546] transaction","detail":"{read_only:false; response_revision:1505; number_of_response:1; }","duration":"175.932278ms","start":"2026-02-17T02:32:25.872345Z","end":"2026-02-17T02:32:26.048278Z","steps":["trace[1185342546] 'process raft request'  (duration: 163.508959ms)","trace[1185342546] 'compare'  (duration: 11.999764ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:26.049302Z","caller":"traceutil/trace.go:172","msg":"trace[302938846] transaction","detail":"{read_only:false; response_revision:1508; number_of_response:1; }","duration":"173.959622ms","start":"2026-02-17T02:32:25.875329Z","end":"2026-02-17T02:32:26.049289Z","steps":["trace[302938846] 'process raft request'  (duration: 173.930161ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:26.049643Z","caller":"traceutil/trace.go:172","msg":"trace[1156524882] transaction","detail":"{read_only:false; response_revision:1506; number_of_response:1; }","duration":"176.939288ms","start":"2026-02-17T02:32:25.872694Z","end":"2026-02-17T02:32:26.049634Z","steps":["trace[1156524882] 'process raft request'  (duration: 176.30666ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:26.049838Z","caller":"traceutil/trace.go:172","msg":"trace[1953265934] transaction","detail":"{read_only:false; response_revision:1507; number_of_response:1; }","duration":"176.385626ms","start":"2026-02-17T02:32:25.873443Z","end":"2026-02-17T02:32:26.049829Z","steps":["trace[1953265934] 'process raft request'  (duration: 175.779479ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:31.177488Z","caller":"traceutil/trace.go:172","msg":"trace[1570970724] linearizableReadLoop","detail":"{readStateIndex:1666; appliedIndex:1666; }","duration":"105.840057ms","start":"2026-02-17T02:32:31.071627Z","end":"2026-02-17T02:32:31.177467Z","steps":["trace[1570970724] 'read index received'  (duration: 105.830997ms)","trace[1570970724] 'applied index is now lower than readState.Index'  (duration: 7.1µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:32:31.177908Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.295055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/192.168.24.160\" limit:1 ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-02-17T02:32:31.178012Z","caller":"traceutil/trace.go:172","msg":"trace[645229871] range","detail":"{range_begin:/registry/masterleases/192.168.24.160; range_end:; response_count:1; response_revision:1577; }","duration":"106.412163ms","start":"2026-02-17T02:32:31.071589Z","end":"2026-02-17T02:32:31.178001Z","steps":["trace[645229871] 'agreement among raft nodes before linearized reading'  (duration: 106.113005ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:31.178650Z","caller":"traceutil/trace.go:172","msg":"trace[2118534002] transaction","detail":"{read_only:false; response_revision:1578; number_of_response:1; }","duration":"112.483285ms","start":"2026-02-17T02:32:31.066157Z","end":"2026-02-17T02:32:31.178640Z","steps":["trace[2118534002] 'process raft request'  (duration: 111.929611ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:32:33.226280Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"226.628731ms","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:32:33.226344Z","caller":"traceutil/trace.go:172","msg":"trace[224256453] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1585; }","duration":"226.711276ms","start":"2026-02-17T02:32:32.999619Z","end":"2026-02-17T02:32:33.226331Z","steps":["trace[224256453] 'range keys from in-memory index tree'  (duration: 226.599679ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:32:36.293116Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.46342ms","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:466"}
{"level":"info","ts":"2026-02-17T02:32:36.293467Z","caller":"traceutil/trace.go:172","msg":"trace[1800900735] range","detail":"{range_begin:/registry/leases/kube-system/nfs-csi-k8s-io; range_end:; response_count:1; response_revision:1595; }","duration":"105.821873ms","start":"2026-02-17T02:32:36.187626Z","end":"2026-02-17T02:32:36.293447Z","steps":["trace[1800900735] 'range keys from in-memory index tree'  (duration: 105.273218ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:39.932576Z","caller":"traceutil/trace.go:172","msg":"trace[1950379866] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1625; }","duration":"147.338934ms","start":"2026-02-17T02:32:39.785220Z","end":"2026-02-17T02:32:39.932559Z","steps":["trace[1950379866] 'process raft request'  (duration: 146.902906ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:32:50.132520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"133.689325ms","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:32:50.132665Z","caller":"traceutil/trace.go:172","msg":"trace[1636530787] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1837; }","duration":"133.837765ms","start":"2026-02-17T02:32:49.998804Z","end":"2026-02-17T02:32:50.132641Z","steps":["trace[1636530787] 'agreement among raft nodes before linearized reading'  (duration: 55.928844ms)","trace[1636530787] 'range keys from in-memory index tree'  (duration: 77.734499ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:50.133571Z","caller":"traceutil/trace.go:172","msg":"trace[50475542] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"154.746775ms","start":"2026-02-17T02:32:49.978807Z","end":"2026-02-17T02:32:50.133553Z","steps":["trace[50475542] 'process raft request'  (duration: 76.078534ms)","trace[50475542] 'compare'  (duration: 78.118754ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:50.134218Z","caller":"traceutil/trace.go:172","msg":"trace[961435098] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"107.384274ms","start":"2026-02-17T02:32:50.026817Z","end":"2026-02-17T02:32:50.134201Z","steps":["trace[961435098] 'process raft request'  (duration: 106.674807ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:32:50.134246Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"107.549005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/tiers/default\" limit:1 ","response":"range_response_count:1 size:702"}
{"level":"info","ts":"2026-02-17T02:32:50.134326Z","caller":"traceutil/trace.go:172","msg":"trace[1919744374] range","detail":"{range_begin:/registry/crd.projectcalico.org/tiers/default; range_end:; response_count:1; response_revision:1841; }","duration":"107.638061ms","start":"2026-02-17T02:32:50.026671Z","end":"2026-02-17T02:32:50.134308Z","steps":["trace[1919744374] 'agreement among raft nodes before linearized reading'  (duration: 107.345861ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:32:50.349481Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.015363ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638580363 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/podtemplates/chunking-279/template-0109\" mod_revision:0 > success:<request_put:<key:\"/registry/podtemplates/chunking-279/template-0109\" value_size:651 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:32:50.349587Z","caller":"traceutil/trace.go:172","msg":"trace[340876939] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"123.989771ms","start":"2026-02-17T02:32:50.225584Z","end":"2026-02-17T02:32:50.349573Z","steps":["trace[340876939] 'process raft request'  (duration: 11.829958ms)","trace[340876939] 'compare'  (duration: 111.792978ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:32:50.763775Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"138.136083ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638580370 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/var-expansion-2116/var-expansion-ebf5dee5-69de-412a-9bae-58a0ce972b5c.1894e7efc7611f97\" mod_revision:0 > success:<request_put:<key:\"/registry/events/var-expansion-2116/var-expansion-ebf5dee5-69de-412a-9bae-58a0ce972b5c.1894e7efc7611f97\" value_size:877 lease:7553834451638579245 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:32:50.764575Z","caller":"traceutil/trace.go:172","msg":"trace[53974803] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"140.802091ms","start":"2026-02-17T02:32:50.623755Z","end":"2026-02-17T02:32:50.764557Z","steps":["trace[53974803] 'process raft request'  (duration: 140.760598ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:50.765003Z","caller":"traceutil/trace.go:172","msg":"trace[1357601061] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"258.239665ms","start":"2026-02-17T02:32:50.506730Z","end":"2026-02-17T02:32:50.764970Z","steps":["trace[1357601061] 'process raft request'  (duration: 257.612133ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:50.765185Z","caller":"traceutil/trace.go:172","msg":"trace[547388449] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"263.879811ms","start":"2026-02-17T02:32:50.501270Z","end":"2026-02-17T02:32:50.765149Z","steps":["trace[547388449] 'process raft request'  (duration: 124.288891ms)","trace[547388449] 'compare'  (duration: 138.002284ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:50.766216Z","caller":"traceutil/trace.go:172","msg":"trace[774984277] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"190.036371ms","start":"2026-02-17T02:32:50.576164Z","end":"2026-02-17T02:32:50.766200Z","steps":["trace[774984277] 'process raft request'  (duration: 188.311556ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:50.765590Z","caller":"traceutil/trace.go:172","msg":"trace[1984505437] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"238.935019ms","start":"2026-02-17T02:32:50.526637Z","end":"2026-02-17T02:32:50.765572Z","steps":["trace[1984505437] 'process raft request'  (duration: 237.798153ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:50.895280Z","caller":"traceutil/trace.go:172","msg":"trace[422961228] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1952; }","duration":"120.68227ms","start":"2026-02-17T02:32:50.774569Z","end":"2026-02-17T02:32:50.895251Z","steps":["trace[422961228] 'read index received'  (duration: 120.67156ms)","trace[422961228] 'applied index is now lower than readState.Index'  (duration: 7.58µs)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:50.914723Z","caller":"traceutil/trace.go:172","msg":"trace[1706983228] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"190.083034ms","start":"2026-02-17T02:32:50.724603Z","end":"2026-02-17T02:32:50.914686Z","steps":["trace[1706983228] 'process raft request'  (duration: 189.891391ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:32:50.914727Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"140.127865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/var-expansion-2116/var-expansion-ebf5dee5-69de-412a-9bae-58a0ce972b5c.1894e7efa158dfe7\" limit:1 ","response":"range_response_count:1 size:925"}
{"level":"info","ts":"2026-02-17T02:32:50.915244Z","caller":"traceutil/trace.go:172","msg":"trace[408230400] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"238.985251ms","start":"2026-02-17T02:32:50.676228Z","end":"2026-02-17T02:32:50.915214Z","steps":["trace[408230400] 'process raft request'  (duration: 218.99691ms)","trace[408230400] 'compare'  (duration: 19.174497ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:50.915313Z","caller":"traceutil/trace.go:172","msg":"trace[1161293258] range","detail":"{range_begin:/registry/events/var-expansion-2116/var-expansion-ebf5dee5-69de-412a-9bae-58a0ce972b5c.1894e7efa158dfe7; range_end:; response_count:1; response_revision:1853; }","duration":"140.723835ms","start":"2026-02-17T02:32:50.774561Z","end":"2026-02-17T02:32:50.915284Z","steps":["trace[1161293258] 'agreement among raft nodes before linearized reading'  (duration: 120.917385ms)","trace[1161293258] 'range keys from in-memory index tree'  (duration: 18.866627ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:50.915988Z","caller":"traceutil/trace.go:172","msg":"trace[479145131] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"141.163054ms","start":"2026-02-17T02:32:50.774807Z","end":"2026-02-17T02:32:50.915969Z","steps":["trace[479145131] 'process raft request'  (duration: 139.716538ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:56.675009Z","caller":"traceutil/trace.go:172","msg":"trace[931542360] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"149.134387ms","start":"2026-02-17T02:32:56.525849Z","end":"2026-02-17T02:32:56.674983Z","steps":["trace[931542360] 'process raft request'  (duration: 99.508027ms)","trace[931542360] 'compare'  (duration: 48.930843ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:56.675492Z","caller":"traceutil/trace.go:172","msg":"trace[1643869323] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"100.761271ms","start":"2026-02-17T02:32:56.574661Z","end":"2026-02-17T02:32:56.675423Z","steps":["trace[1643869323] 'process raft request'  (duration: 99.919534ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:32:59.739175Z","caller":"traceutil/trace.go:172","msg":"trace[1823901354] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"138.7853ms","start":"2026-02-17T02:32:59.600367Z","end":"2026-02-17T02:32:59.739152Z","steps":["trace[1823901354] 'process raft request'  (duration: 91.97689ms)","trace[1823901354] 'compare'  (duration: 46.183438ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:32:59.740039Z","caller":"traceutil/trace.go:172","msg":"trace[702417668] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"108.342365ms","start":"2026-02-17T02:32:59.631679Z","end":"2026-02-17T02:32:59.740022Z","steps":["trace[702417668] 'process raft request'  (duration: 106.962221ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:02.246327Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"104.256841ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638580748 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/podtemplates/chunking-279/template-0347\" mod_revision:0 > success:<request_put:<key:\"/registry/podtemplates/chunking-279/template-0347\" value_size:651 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:33:02.246763Z","caller":"traceutil/trace.go:172","msg":"trace[722891586] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"122.30872ms","start":"2026-02-17T02:33:02.124407Z","end":"2026-02-17T02:33:02.246715Z","steps":["trace[722891586] 'process raft request'  (duration: 17.598487ms)","trace[722891586] 'compare'  (duration: 103.712625ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:03.257325Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"111.223213ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638580772 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2109 > 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:33:03.257932Z","caller":"traceutil/trace.go:172","msg":"trace[1081909419] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"209.085648ms","start":"2026-02-17T02:33:03.048788Z","end":"2026-02-17T02:33:03.257874Z","steps":["trace[1081909419] 'process raft request'  (duration: 97.212501ms)","trace[1081909419] 'compare'  (duration: 110.946284ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:33:03.258074Z","caller":"traceutil/trace.go:172","msg":"trace[29268521] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"205.934712ms","start":"2026-02-17T02:33:03.052115Z","end":"2026-02-17T02:33:03.258050Z","steps":["trace[29268521] 'process raft request'  (duration: 205.365972ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:03.258116Z","caller":"traceutil/trace.go:172","msg":"trace[41162810] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"133.765482ms","start":"2026-02-17T02:33:03.124331Z","end":"2026-02-17T02:33:03.258097Z","steps":["trace[41162810] 'process raft request'  (duration: 133.713958ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:03.258590Z","caller":"traceutil/trace.go:172","msg":"trace[717327391] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"183.553874ms","start":"2026-02-17T02:33:03.074995Z","end":"2026-02-17T02:33:03.258548Z","steps":["trace[717327391] 'process raft request'  (duration: 182.583107ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:04.489264Z","caller":"traceutil/trace.go:172","msg":"trace[763544297] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"166.520345ms","start":"2026-02-17T02:33:04.322717Z","end":"2026-02-17T02:33:04.489237Z","steps":["trace[763544297] 'process raft request'  (duration: 127.857473ms)","trace[763544297] 'compare'  (duration: 38.315688ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:33:04.498861Z","caller":"traceutil/trace.go:172","msg":"trace[687791738] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"124.433617ms","start":"2026-02-17T02:33:04.374414Z","end":"2026-02-17T02:33:04.498848Z","steps":["trace[687791738] 'process raft request'  (duration: 124.19201ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:31.922919Z","caller":"traceutil/trace.go:172","msg":"trace[1113587837] transaction","detail":"{read_only:false; response_revision:2454; number_of_response:1; }","duration":"134.060791ms","start":"2026-02-17T02:33:31.788839Z","end":"2026-02-17T02:33:31.922900Z","steps":["trace[1113587837] 'process raft request'  (duration: 134.018322ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:31.923242Z","caller":"traceutil/trace.go:172","msg":"trace[1953698515] transaction","detail":"{read_only:false; response_revision:2452; number_of_response:1; }","duration":"138.229225ms","start":"2026-02-17T02:33:31.784991Z","end":"2026-02-17T02:33:31.923221Z","steps":["trace[1953698515] 'process raft request'  (duration: 41.956548ms)","trace[1953698515] 'compare'  (duration: 95.715103ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:33:31.924017Z","caller":"traceutil/trace.go:172","msg":"trace[1497764218] transaction","detail":"{read_only:false; response_revision:2453; number_of_response:1; }","duration":"138.737479ms","start":"2026-02-17T02:33:31.785269Z","end":"2026-02-17T02:33:31.924007Z","steps":["trace[1497764218] 'process raft request'  (duration: 137.545852ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:38.323747Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7553834451638581519,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T02:33:38.824335Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7553834451638581519,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-17T02:33:39.275552Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"157.550923ms","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:33:39.275711Z","caller":"traceutil/trace.go:172","msg":"trace[756234937] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2477; }","duration":"157.650352ms","start":"2026-02-17T02:33:39.117978Z","end":"2026-02-17T02:33:39.275629Z","steps":["trace[756234937] 'range keys from in-memory index tree'  (duration: 157.499813ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.276012Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"955.689286ms","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:33:39.276193Z","caller":"traceutil/trace.go:172","msg":"trace[57119023] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2477; }","duration":"955.946966ms","start":"2026-02-17T02:33:38.320228Z","end":"2026-02-17T02:33:39.276175Z","steps":["trace[57119023] 'get authentication metadata'  (duration: 20.647473ms)","trace[57119023] 'range keys from in-memory index tree'  (duration: 935.030444ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.325076Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.662951574s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-17T02:33:39.325420Z","caller":"traceutil/trace.go:172","msg":"trace[1955770355] linearizableReadLoop","detail":"{readStateIndex:2599; appliedIndex:2599; }","duration":"2.64995903s","start":"2026-02-17T02:33:36.675438Z","end":"2026-02-17T02:33:39.325397Z","steps":["trace[1955770355] 'read index received'  (duration: 2.64994746s)","trace[1955770355] 'applied index is now lower than readState.Index'  (duration: 9.4µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.325912Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.650456599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:33:39.325938Z","caller":"traceutil/trace.go:172","msg":"trace[1012562921] range","detail":"{range_begin:/registry/deployments; range_end:; response_count:0; response_revision:2477; }","duration":"2.650499499s","start":"2026-02-17T02:33:36.675432Z","end":"2026-02-17T02:33:39.325931Z","steps":["trace[1012562921] 'agreement among raft nodes before linearized reading'  (duration: 2.65019566s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.325965Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:36.675417Z","time spent":"2.650541519s","remote":"127.0.0.1:59924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":27,"request content":"key:\"/registry/deployments\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:33:39.326062Z","caller":"traceutil/trace.go:172","msg":"trace[830214823] transaction","detail":"{read_only:false; response_revision:2478; number_of_response:1; }","duration":"2.66400028s","start":"2026-02-17T02:33:36.662041Z","end":"2026-02-17T02:33:39.326042Z","steps":["trace[830214823] 'process raft request'  (duration: 2.663597402s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.326206Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:36.662021Z","time spent":"2.66411974s","remote":"127.0.0.1:59182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/statefulset-9289/ss-2.1894e7f8e42bc9f7\" mod_revision:2473 > success:<request_put:<key:\"/registry/events/statefulset-9289/ss-2.1894e7f8e42bc9f7\" value_size:717 lease:7553834451638580646 >> failure:<request_range:<key:\"/registry/events/statefulset-9289/ss-2.1894e7f8e42bc9f7\" > >"}
{"level":"info","ts":"2026-02-17T02:33:39.533349Z","caller":"traceutil/trace.go:172","msg":"trace[2106916884] linearizableReadLoop","detail":"{readStateIndex:2600; appliedIndex:2600; }","duration":"207.744723ms","start":"2026-02-17T02:33:39.325575Z","end":"2026-02-17T02:33:39.533320Z","steps":["trace[2106916884] 'read index received'  (duration: 207.729763ms)","trace[2106916884] 'applied index is now lower than readState.Index'  (duration: 12.03µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.585570Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.246163278s","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:39.585729Z","caller":"traceutil/trace.go:172","msg":"trace[337413169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2478; }","duration":"1.246324308s","start":"2026-02-17T02:33:38.339382Z","end":"2026-02-17T02:33:39.585706Z","steps":["trace[337413169] 'agreement among raft nodes before linearized reading'  (duration: 1.194448252s)","trace[337413169] 'range keys from in-memory index tree'  (duration: 51.684906ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.585756Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.246116709s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/var-expansion-2116/var-expansion-ebf5dee5-69de-412a-9bae-58a0ce972b5c\" limit:1 ","response":"range_response_count:1 size:4312"}
{"level":"warn","ts":"2026-02-17T02:33:39.585775Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.339374Z","time spent":"1.246390128s","remote":"127.0.0.1:59078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-17T02:33:39.586087Z","caller":"traceutil/trace.go:172","msg":"trace[1444100513] range","detail":"{range_begin:/registry/pods/var-expansion-2116/var-expansion-ebf5dee5-69de-412a-9bae-58a0ce972b5c; range_end:; response_count:1; response_revision:2478; }","duration":"1.246382688s","start":"2026-02-17T02:33:38.339510Z","end":"2026-02-17T02:33:39.585893Z","steps":["trace[1444100513] 'agreement among raft nodes before linearized reading'  (duration: 1.194297303s)","trace[1444100513] 'range keys from in-memory index tree'  (duration: 51.624767ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.586263Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.339468Z","time spent":"1.246777456s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":4334,"request content":"key:\"/registry/pods/var-expansion-2116/var-expansion-ebf5dee5-69de-412a-9bae-58a0ce972b5c\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.585713Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.261414752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicies\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-17T02:33:39.586735Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.252647665s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:33:39.586831Z","caller":"traceutil/trace.go:172","msg":"trace[2103036059] range","detail":"{range_begin:/registry/daemonsets; range_end:; response_count:0; response_revision:2478; }","duration":"1.252809185s","start":"2026-02-17T02:33:38.333998Z","end":"2026-02-17T02:33:39.586807Z","steps":["trace[2103036059] 'agreement among raft nodes before linearized reading'  (duration: 1.199865632s)","trace[2103036059] 'range keys from in-memory index tree'  (duration: 52.757683ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.586883Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.333983Z","time spent":"1.252887485s","remote":"127.0.0.1:59976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":27,"request content":"key:\"/registry/daemonsets\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:33:39.587013Z","caller":"traceutil/trace.go:172","msg":"trace[534286516] range","detail":"{range_begin:/registry/validatingadmissionpolicies; range_end:; response_count:0; response_revision:2478; }","duration":"1.262571439s","start":"2026-02-17T02:33:38.324179Z","end":"2026-02-17T02:33:39.586750Z","steps":["trace[534286516] 'agreement among raft nodes before linearized reading'  (duration: 1.209694686s)","trace[534286516] 'range keys from in-memory index tree'  (duration: 51.694486ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.587237Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.253002275s","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:33:39.587375Z","caller":"traceutil/trace.go:172","msg":"trace[1840559625] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:2478; }","duration":"1.253131494s","start":"2026-02-17T02:33:38.334223Z","end":"2026-02-17T02:33:39.587354Z","steps":["trace[1840559625] 'agreement among raft nodes before linearized reading'  (duration: 1.199619823s)","trace[1840559625] 'range keys from in-memory index tree'  (duration: 53.363812ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.587429Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.334219Z","time spent":"1.253193824s","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/pods\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.587433Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.248003273s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/kube-e17cw-vl7vr-pzpkv\" limit:1 ","response":"range_response_count:1 size:9935"}
{"level":"info","ts":"2026-02-17T02:33:39.587479Z","caller":"traceutil/trace.go:172","msg":"trace[668209573] range","detail":"{range_begin:/registry/minions/kube-e17cw-vl7vr-pzpkv; range_end:; response_count:1; response_revision:2478; }","duration":"1.248050123s","start":"2026-02-17T02:33:38.339414Z","end":"2026-02-17T02:33:39.587464Z","steps":["trace[668209573] 'agreement among raft nodes before linearized reading'  (duration: 1.194405202s)","trace[668209573] 'range keys from in-memory index tree'  (duration: 53.464251ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.587550Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.339411Z","time spent":"1.248127673s","remote":"127.0.0.1:59330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":9957,"request content":"key:\"/registry/minions/kube-e17cw-vl7vr-pzpkv\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.587255Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.324160Z","time spent":"1.263076538s","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":27,"request content":"key:\"/registry/validatingadmissionpolicies\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.588176Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"310.451788ms","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:39.588262Z","caller":"traceutil/trace.go:172","msg":"trace[466513165] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2478; }","duration":"310.610568ms","start":"2026-02-17T02:33:39.277635Z","end":"2026-02-17T02:33:39.588245Z","steps":["trace[466513165] 'agreement among raft nodes before linearized reading'  (duration: 255.8433ms)","trace[466513165] 'range keys from in-memory index tree'  (duration: 54.495478ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.588366Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.247414906s","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:39.588455Z","caller":"traceutil/trace.go:172","msg":"trace[1647602540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2478; }","duration":"1.247500196s","start":"2026-02-17T02:33:38.340941Z","end":"2026-02-17T02:33:39.588441Z","steps":["trace[1647602540] 'agreement among raft nodes before linearized reading'  (duration: 1.192855578s)","trace[1647602540] 'range keys from in-memory index tree'  (duration: 54.539998ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.588567Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.340934Z","time spent":"1.247546736s","remote":"127.0.0.1:59056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T02:33:39.588862Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"360.760918ms","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:33:39.588933Z","caller":"traceutil/trace.go:172","msg":"trace[1915702390] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:2478; }","duration":"360.830798ms","start":"2026-02-17T02:33:39.228090Z","end":"2026-02-17T02:33:39.588921Z","steps":["trace[1915702390] 'agreement among raft nodes before linearized reading'  (duration: 305.403752ms)","trace[1915702390] 'range keys from in-memory index tree'  (duration: 55.075177ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.588965Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.228072Z","time spent":"360.883988ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/pods\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.588985Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"726.096212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/sonobuoy/sonobuoy-e2e-job-43e35cc779114041\" limit:1 ","response":"range_response_count:1 size:9459"}
{"level":"info","ts":"2026-02-17T02:33:39.589038Z","caller":"traceutil/trace.go:172","msg":"trace[94671907] range","detail":"{range_begin:/registry/pods/sonobuoy/sonobuoy-e2e-job-43e35cc779114041; range_end:; response_count:1; response_revision:2478; }","duration":"726.146271ms","start":"2026-02-17T02:33:38.862874Z","end":"2026-02-17T02:33:39.589020Z","steps":["trace[94671907] 'agreement among raft nodes before linearized reading'  (duration: 670.908915ms)","trace[94671907] 'range keys from in-memory index tree'  (duration: 55.061657ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.589117Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.862853Z","time spent":"726.245451ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":9481,"request content":"key:\"/registry/pods/sonobuoy/sonobuoy-e2e-job-43e35cc779114041\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.587915Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.253749393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e\" limit:1 ","response":"range_response_count:1 size:805"}
{"level":"warn","ts":"2026-02-17T02:33:39.589402Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"520.905434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/statefulset-9289/ss\" limit:1 ","response":"range_response_count:1 size:1755"}
{"level":"info","ts":"2026-02-17T02:33:39.589485Z","caller":"traceutil/trace.go:172","msg":"trace[14073711] range","detail":"{range_begin:/registry/statefulsets/statefulset-9289/ss; range_end:; response_count:1; response_revision:2478; }","duration":"520.985724ms","start":"2026-02-17T02:33:39.068483Z","end":"2026-02-17T02:33:39.589469Z","steps":["trace[14073711] 'agreement among raft nodes before linearized reading'  (duration: 465.286339ms)","trace[14073711] 'range keys from in-memory index tree'  (duration: 55.550696ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.589520Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.068465Z","time spent":"521.044144ms","remote":"127.0.0.1:59948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":1777,"request content":"key:\"/registry/statefulsets/statefulset-9289/ss\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:33:39.589443Z","caller":"traceutil/trace.go:172","msg":"trace[10093445] range","detail":"{range_begin:/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e; range_end:; response_count:1; response_revision:2478; }","duration":"1.255271428s","start":"2026-02-17T02:33:38.334152Z","end":"2026-02-17T02:33:39.589423Z","steps":["trace[10093445] 'agreement among raft nodes before linearized reading'  (duration: 1.199701143s)","trace[10093445] 'range keys from in-memory index tree'  (duration: 53.94291ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.590151Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.334144Z","time spent":"1.255883437s","remote":"127.0.0.1:59182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":827,"request content":"key:\"/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:33:39.589921Z","caller":"traceutil/trace.go:172","msg":"trace[72199286] transaction","detail":"{read_only:false; response_revision:2479; number_of_response:1; }","duration":"1.255870216s","start":"2026-02-17T02:33:38.334034Z","end":"2026-02-17T02:33:39.589904Z","steps":["trace[72199286] 'process raft request'  (duration: 1.200013861s)","trace[72199286] 'compare'  (duration: 54.562859ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.590942Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.334025Z","time spent":"1.256753194s","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-cinder-csi-openstack-org\" mod_revision:2458 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-cinder-csi-openstack-org\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-cinder-csi-openstack-org\" > >"}
{"level":"info","ts":"2026-02-17T02:33:39.591291Z","caller":"traceutil/trace.go:172","msg":"trace[19030614] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"735.988307ms","start":"2026-02-17T02:33:38.855288Z","end":"2026-02-17T02:33:39.591276Z","steps":["trace[19030614] 'process raft request'  (duration: 735.565168ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.591441Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.855264Z","time spent":"736.127757ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":550,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-snapshotter-leader-cinder-csi-openstack-org\" mod_revision:2464 > success:<request_put:<key:\"/registry/leases/kube-system/external-snapshotter-leader-cinder-csi-openstack-org\" value_size:461 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-snapshotter-leader-cinder-csi-openstack-org\" > >"}
{"level":"info","ts":"2026-02-17T02:33:39.591295Z","caller":"traceutil/trace.go:172","msg":"trace[60316501] transaction","detail":"{read_only:false; response_revision:2486; number_of_response:1; }","duration":"366.810181ms","start":"2026-02-17T02:33:39.224470Z","end":"2026-02-17T02:33:39.591280Z","steps":["trace[60316501] 'process raft request'  (duration: 366.427872ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:39.591649Z","caller":"traceutil/trace.go:172","msg":"trace[166121839] transaction","detail":"{read_only:false; response_revision:2482; number_of_response:1; }","duration":"1.247793948s","start":"2026-02-17T02:33:38.343841Z","end":"2026-02-17T02:33:39.591634Z","steps":["trace[166121839] 'process raft request'  (duration: 1.246798771s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.591796Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.77833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-17T02:33:39.591819Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.343826Z","time spent":"1.247949928s","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":478,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2470 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:427 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-17T02:33:39.591833Z","caller":"traceutil/trace.go:172","msg":"trace[1591691888] range","detail":"{range_begin:/registry/persistentvolumeclaims; range_end:; response_count:0; response_revision:2486; }","duration":"129.80892ms","start":"2026-02-17T02:33:39.462008Z","end":"2026-02-17T02:33:39.591817Z","steps":["trace[1591691888] 'agreement among raft nodes before linearized reading'  (duration: 129.74798ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:39.592051Z","caller":"traceutil/trace.go:172","msg":"trace[234848774] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"1.245561436s","start":"2026-02-17T02:33:38.346472Z","end":"2026-02-17T02:33:39.592033Z","steps":["trace[234848774] 'process raft request'  (duration: 1.24429271s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.592162Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.346449Z","time spent":"1.245673166s","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cloud-controller-manager\" mod_revision:2472 > success:<request_put:<key:\"/registry/leases/kube-system/cloud-controller-manager\" value_size:456 >> failure:<request_range:<key:\"/registry/leases/kube-system/cloud-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:33:39.592326Z","caller":"traceutil/trace.go:172","msg":"trace[1327702213] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"1.095263032s","start":"2026-02-17T02:33:38.497050Z","end":"2026-02-17T02:33:39.592313Z","steps":["trace[1327702213] 'process raft request'  (duration: 1.093756997s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.592384Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.497026Z","time spent":"1.095326032s","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-resizer-cinder-csi-openstack-org\" mod_revision:2462 > success:<request_put:<key:\"/registry/leases/kube-system/external-resizer-cinder-csi-openstack-org\" value_size:445 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-resizer-cinder-csi-openstack-org\" > >"}
{"level":"warn","ts":"2026-02-17T02:33:39.592476Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"260.761156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/statefulset-9289/ss-2.1894e7f8e42bc9f7\" limit:1 ","response":"range_response_count:1 size:805"}
{"level":"info","ts":"2026-02-17T02:33:39.591012Z","caller":"traceutil/trace.go:172","msg":"trace[1187701856] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"1.251787573s","start":"2026-02-17T02:33:38.339208Z","end":"2026-02-17T02:33:39.590995Z","steps":["trace[1187701856] 'process raft request'  (duration: 1.250612076s)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:39.591059Z","caller":"traceutil/trace.go:172","msg":"trace[944169000] transaction","detail":"{read_only:false; response_revision:2481; number_of_response:1; }","duration":"1.251782843s","start":"2026-02-17T02:33:38.339265Z","end":"2026-02-17T02:33:39.591048Z","steps":["trace[944169000] 'process raft request'  (duration: 1.250993175s)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.602626Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.339260Z","time spent":"1.263291771s","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":505,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2474 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:445 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-17T02:33:39.592636Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:38.339190Z","time spent":"1.253407818s","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":577,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/kube-e17cw-vl7vr-pzpkv\" mod_revision:2369 > success:<request_put:<key:\"/registry/leases/kube-node-lease/kube-e17cw-vl7vr-pzpkv\" value_size:514 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/kube-e17cw-vl7vr-pzpkv\" > >"}
{"level":"warn","ts":"2026-02-17T02:33:39.591645Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.224448Z","time spent":"367.13412ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":482,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cinder-csi-openstack-org\" mod_revision:2466 > success:<request_put:<key:\"/registry/leases/kube-system/cinder-csi-openstack-org\" value_size:421 >> failure:<request_range:<key:\"/registry/leases/kube-system/cinder-csi-openstack-org\" > >"}
{"level":"info","ts":"2026-02-17T02:33:39.592536Z","caller":"traceutil/trace.go:172","msg":"trace[366593126] range","detail":"{range_begin:/registry/events/statefulset-9289/ss-2.1894e7f8e42bc9f7; range_end:; response_count:1; response_revision:2486; }","duration":"260.782316ms","start":"2026-02-17T02:33:39.331707Z","end":"2026-02-17T02:33:39.592489Z","steps":["trace[366593126] 'agreement among raft nodes before linearized reading'  (duration: 260.715756ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:39.755993Z","caller":"traceutil/trace.go:172","msg":"trace[1286255158] linearizableReadLoop","detail":"{readStateIndex:2608; appliedIndex:2608; }","duration":"150.170893ms","start":"2026-02-17T02:33:39.605789Z","end":"2026-02-17T02:33:39.755960Z","steps":["trace[1286255158] 'read index received'  (duration: 150.156853ms)","trace[1286255158] 'applied index is now lower than readState.Index'  (duration: 11.03µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.933454Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"177.187278ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638581533 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e\" mod_revision:2476 > success:<request_put:<key:\"/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e\" value_size:717 lease:7553834451638580646 >> failure:<request_range:<key:\"/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:33:39.933944Z","caller":"traceutil/trace.go:172","msg":"trace[354530902] transaction","detail":"{read_only:false; response_revision:2488; number_of_response:1; }","duration":"324.433769ms","start":"2026-02-17T02:33:39.609499Z","end":"2026-02-17T02:33:39.933933Z","steps":["trace[354530902] 'process raft request'  (duration: 324.353419ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.933986Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.609487Z","time spent":"324.480249ms","remote":"127.0.0.1:59182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/statefulset-9289/ss-2.1894e7f8e42bc9f7\" mod_revision:2478 > success:<request_put:<key:\"/registry/events/statefulset-9289/ss-2.1894e7f8e42bc9f7\" value_size:717 lease:7553834451638580646 >> failure:<request_range:<key:\"/registry/events/statefulset-9289/ss-2.1894e7f8e42bc9f7\" > >"}
{"level":"warn","ts":"2026-02-17T02:33:39.933057Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"327.254561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/kube-e17cw-vl7vr-pzpkv\" limit:1 ","response":"range_response_count:1 size:9935"}
{"level":"info","ts":"2026-02-17T02:33:39.934171Z","caller":"traceutil/trace.go:172","msg":"trace[582544476] range","detail":"{range_begin:/registry/minions/kube-e17cw-vl7vr-pzpkv; range_end:; response_count:1; response_revision:2486; }","duration":"328.380888ms","start":"2026-02-17T02:33:39.605779Z","end":"2026-02-17T02:33:39.934160Z","steps":["trace[582544476] 'agreement among raft nodes before linearized reading'  (duration: 150.312753ms)","trace[582544476] 'range keys from in-memory index tree'  (duration: 176.856299ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.934196Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.605747Z","time spent":"328.440298ms","remote":"127.0.0.1:59330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":9957,"request content":"key:\"/registry/minions/kube-e17cw-vl7vr-pzpkv\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:33:39.934247Z","caller":"traceutil/trace.go:172","msg":"trace[1382749634] transaction","detail":"{read_only:false; response_revision:2487; number_of_response:1; }","duration":"328.813157ms","start":"2026-02-17T02:33:39.605427Z","end":"2026-02-17T02:33:39.934240Z","steps":["trace[1382749634] 'process raft request'  (duration: 150.742952ms)","trace[1382749634] 'compare'  (duration: 176.736699ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.934277Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.605397Z","time spent":"328.863787ms","remote":"127.0.0.1:59182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e\" mod_revision:2476 > success:<request_put:<key:\"/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e\" value_size:717 lease:7553834451638580646 >> failure:<request_range:<key:\"/registry/events/statefulset-9289/ss-1.1894e7f8d90b697e\" > >"}
{"level":"info","ts":"2026-02-17T02:33:39.934353Z","caller":"traceutil/trace.go:172","msg":"trace[423686388] linearizableReadLoop","detail":"{readStateIndex:2609; appliedIndex:2608; }","duration":"178.287645ms","start":"2026-02-17T02:33:39.756060Z","end":"2026-02-17T02:33:39.934348Z","steps":["trace[423686388] 'read index received'  (duration: 177.171568ms)","trace[423686388] 'applied index is now lower than readState.Index'  (duration: 1.114947ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:39.934418Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"328.537148ms","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:33:39.934431Z","caller":"traceutil/trace.go:172","msg":"trace[526884699] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:2488; }","duration":"328.552338ms","start":"2026-02-17T02:33:39.605875Z","end":"2026-02-17T02:33:39.934427Z","steps":["trace[526884699] 'agreement among raft nodes before linearized reading'  (duration: 328.493088ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.934442Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.605863Z","time spent":"328.576328ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/pods\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.934506Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"316.164552ms","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:33:39.934529Z","caller":"traceutil/trace.go:172","msg":"trace[1104218879] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:2488; }","duration":"316.191772ms","start":"2026-02-17T02:33:39.618330Z","end":"2026-02-17T02:33:39.934522Z","steps":["trace[1104218879] 'agreement among raft nodes before linearized reading'  (duration: 316.149392ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.934545Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.618305Z","time spent":"316.235782ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/pods\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.934574Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"318.827945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/sonobuoy/sonobuoy\" limit:1 ","response":"range_response_count:1 size:5514"}
{"level":"info","ts":"2026-02-17T02:33:39.934589Z","caller":"traceutil/trace.go:172","msg":"trace[1326317355] range","detail":"{range_begin:/registry/pods/sonobuoy/sonobuoy; range_end:; response_count:1; response_revision:2488; }","duration":"318.843745ms","start":"2026-02-17T02:33:39.615741Z","end":"2026-02-17T02:33:39.934584Z","steps":["trace[1326317355] 'agreement among raft nodes before linearized reading'  (duration: 318.788765ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.934600Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.615731Z","time spent":"318.865835ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":5536,"request content":"key:\"/registry/pods/sonobuoy/sonobuoy\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:39.934712Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"321.842216ms","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:39.934726Z","caller":"traceutil/trace.go:172","msg":"trace[1573802021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2488; }","duration":"321.859456ms","start":"2026-02-17T02:33:39.612862Z","end":"2026-02-17T02:33:39.934722Z","steps":["trace[1573802021] 'agreement among raft nodes before linearized reading'  (duration: 321.829866ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.934742Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.612853Z","time spent":"321.885286ms","remote":"127.0.0.1:59078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-17T02:33:39.934771Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"240.477253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/hostendpoints\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:33:39.934792Z","caller":"traceutil/trace.go:172","msg":"trace[1336706433] range","detail":"{range_begin:/registry/crd.projectcalico.org/hostendpoints; range_end:; response_count:0; response_revision:2488; }","duration":"240.500673ms","start":"2026-02-17T02:33:39.694285Z","end":"2026-02-17T02:33:39.934786Z","steps":["trace[1336706433] 'agreement among raft nodes before linearized reading'  (duration: 240.458793ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.934821Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"327.219872ms","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:33:39.934833Z","caller":"traceutil/trace.go:172","msg":"trace[1756440494] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:2488; }","duration":"327.232572ms","start":"2026-02-17T02:33:39.607596Z","end":"2026-02-17T02:33:39.934829Z","steps":["trace[1756440494] 'agreement among raft nodes before linearized reading'  (duration: 327.208162ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:33:39.934843Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:33:39.607586Z","time spent":"327.253781ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/pods\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:33:40.307224Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"178.624931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k\" limit:1 ","response":"range_response_count:1 size:8745"}
{"level":"info","ts":"2026-02-17T02:33:40.307337Z","caller":"traceutil/trace.go:172","msg":"trace[721324309] range","detail":"{range_begin:/registry/minions/kube-e17cw-default-worker-7r88m-ncg6k-n7j7k; range_end:; response_count:1; response_revision:2506; }","duration":"178.74938ms","start":"2026-02-17T02:33:40.128566Z","end":"2026-02-17T02:33:40.307315Z","steps":["trace[721324309] 'agreement among raft nodes before linearized reading'  (duration: 68.494778ms)","trace[721324309] 'range keys from in-memory index tree'  (duration: 110.001843ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:40.308486Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.995614ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638581570 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/statefulset-9289/ss-0.1894e7fb51da9d82\" mod_revision:0 > success:<request_put:<key:\"/registry/events/statefulset-9289/ss-0.1894e7fb51da9d82\" value_size:680 lease:7553834451638580646 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:33:40.309060Z","caller":"traceutil/trace.go:172","msg":"trace[722345679] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"235.441409ms","start":"2026-02-17T02:33:40.073592Z","end":"2026-02-17T02:33:40.309033Z","steps":["trace[722345679] 'process raft request'  (duration: 123.665429ms)","trace[722345679] 'compare'  (duration: 109.662844ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:33:40.309881Z","caller":"traceutil/trace.go:172","msg":"trace[324731193] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"224.828768ms","start":"2026-02-17T02:33:40.085036Z","end":"2026-02-17T02:33:40.309865Z","steps":["trace[324731193] 'process raft request'  (duration: 224.682358ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:40.310007Z","caller":"traceutil/trace.go:172","msg":"trace[568848546] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"224.613219ms","start":"2026-02-17T02:33:40.085371Z","end":"2026-02-17T02:33:40.309984Z","steps":["trace[568848546] 'process raft request'  (duration: 224.451819ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:40.315094Z","caller":"traceutil/trace.go:172","msg":"trace[1660052545] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"185.146288ms","start":"2026-02-17T02:33:40.129933Z","end":"2026-02-17T02:33:40.315079Z","steps":["trace[1660052545] 'process raft request'  (duration: 184.858679ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:40.315101Z","caller":"traceutil/trace.go:172","msg":"trace[637828685] transaction","detail":"{read_only:false; response_revision:2511; number_of_response:1; }","duration":"183.546521ms","start":"2026-02-17T02:33:40.131543Z","end":"2026-02-17T02:33:40.315090Z","steps":["trace[637828685] 'process raft request'  (duration: 183.453641ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:33:40.315974Z","caller":"traceutil/trace.go:172","msg":"trace[1920779563] linearizableReadLoop","detail":"{readStateIndex:2631; appliedIndex:2633; }","duration":"113.476107ms","start":"2026-02-17T02:33:40.202487Z","end":"2026-02-17T02:33:40.315964Z","steps":["trace[1920779563] 'read index received'  (duration: 112.114949ms)","trace[1920779563] 'applied index is now lower than readState.Index'  (duration: 1.359308ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:33:40.316095Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"113.617816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:33:40.316140Z","caller":"traceutil/trace.go:172","msg":"trace[243087263] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:2511; }","duration":"113.675526ms","start":"2026-02-17T02:33:40.202457Z","end":"2026-02-17T02:33:40.316133Z","steps":["trace[243087263] 'agreement among raft nodes before linearized reading'  (duration: 113.592616ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:36:30.117565Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"119.353864ms","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:36:30.117627Z","caller":"traceutil/trace.go:172","msg":"trace[456115143] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4509; }","duration":"119.422348ms","start":"2026-02-17T02:36:29.998191Z","end":"2026-02-17T02:36:30.117614Z","steps":["trace[456115143] 'range keys from in-memory index tree'  (duration: 119.339374ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:36:30.117714Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"128.035521ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638590006 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cinder-csi-openstack-org\" mod_revision:4460 > success:<request_put:<key:\"/registry/leases/kube-system/cinder-csi-openstack-org\" value_size:422 >> failure:<request_range:<key:\"/registry/leases/kube-system/cinder-csi-openstack-org\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:36:30.117747Z","caller":"traceutil/trace.go:172","msg":"trace[203979040] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"169.478703ms","start":"2026-02-17T02:36:29.948260Z","end":"2026-02-17T02:36:30.117739Z","steps":["trace[203979040] 'process raft request'  (duration: 41.378609ms)","trace[203979040] 'compare'  (duration: 127.814978ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:36:30.198674Z","caller":"traceutil/trace.go:172","msg":"trace[351031185] linearizableReadLoop","detail":"{readStateIndex:4739; appliedIndex:4739; }","duration":"209.043085ms","start":"2026-02-17T02:36:29.989613Z","end":"2026-02-17T02:36:30.198656Z","steps":["trace[351031185] 'read index received'  (duration: 209.035015ms)","trace[351031185] 'applied index is now lower than readState.Index'  (duration: 6.45µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:36:30.198942Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"209.31738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/dns-1186/dns-test-327f1909-baac-4066-b329-0d65b0430924\" limit:1 ","response":"range_response_count:1 size:6362"}
{"level":"info","ts":"2026-02-17T02:36:30.198968Z","caller":"traceutil/trace.go:172","msg":"trace[112008481] range","detail":"{range_begin:/registry/pods/dns-1186/dns-test-327f1909-baac-4066-b329-0d65b0430924; range_end:; response_count:1; response_revision:4510; }","duration":"209.354682ms","start":"2026-02-17T02:36:29.989606Z","end":"2026-02-17T02:36:30.198960Z","steps":["trace[112008481] 'agreement among raft nodes before linearized reading'  (duration: 209.149661ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:30.199256Z","caller":"traceutil/trace.go:172","msg":"trace[1300203050] transaction","detail":"{read_only:false; response_revision:4512; number_of_response:1; }","duration":"243.007768ms","start":"2026-02-17T02:36:29.956218Z","end":"2026-02-17T02:36:30.199226Z","steps":["trace[1300203050] 'process raft request'  (duration: 242.69281ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:30.199493Z","caller":"traceutil/trace.go:172","msg":"trace[1943777690] transaction","detail":"{read_only:false; response_revision:4513; number_of_response:1; }","duration":"222.3488ms","start":"2026-02-17T02:36:29.977126Z","end":"2026-02-17T02:36:30.199474Z","steps":["trace[1943777690] 'process raft request'  (duration: 221.8216ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:30.199550Z","caller":"traceutil/trace.go:172","msg":"trace[1409924878] transaction","detail":"{read_only:false; response_revision:4511; number_of_response:1; }","duration":"246.333065ms","start":"2026-02-17T02:36:29.953211Z","end":"2026-02-17T02:36:30.199544Z","steps":["trace[1409924878] 'process raft request'  (duration: 245.54158ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:30.532430Z","caller":"traceutil/trace.go:172","msg":"trace[1361180033] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4520; }","duration":"118.21751ms","start":"2026-02-17T02:36:30.414190Z","end":"2026-02-17T02:36:30.532407Z","steps":["trace[1361180033] 'process raft request'  (duration: 56.079564ms)","trace[1361180033] 'compare'  (duration: 61.926514ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:36:30.532960Z","caller":"traceutil/trace.go:172","msg":"trace[881350095] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4520; }","duration":"111.375066ms","start":"2026-02-17T02:36:30.421572Z","end":"2026-02-17T02:36:30.532946Z","steps":["trace[881350095] 'process raft request'  (duration: 110.941652ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:36:52.956949Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"105.750005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/cronjob-6656/suspended\" limit:1 ","response":"range_response_count:1 size:1283"}
{"level":"info","ts":"2026-02-17T02:36:52.957098Z","caller":"traceutil/trace.go:172","msg":"trace[985491440] range","detail":"{range_begin:/registry/cronjobs/cronjob-6656/suspended; range_end:; response_count:1; response_revision:5632; }","duration":"105.907084ms","start":"2026-02-17T02:36:52.851175Z","end":"2026-02-17T02:36:52.957083Z","steps":["trace[985491440] 'agreement among raft nodes before linearized reading'  (duration: 44.500802ms)","trace[985491440] 'range keys from in-memory index tree'  (duration: 61.064332ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:36:52.957435Z","caller":"traceutil/trace.go:172","msg":"trace[1185101302] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"108.969269ms","start":"2026-02-17T02:36:52.848451Z","end":"2026-02-17T02:36:52.957420Z","steps":["trace[1185101302] 'process raft request'  (duration: 47.341795ms)","trace[1185101302] 'compare'  (duration: 60.956465ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:36:53.274398Z","caller":"traceutil/trace.go:172","msg":"trace[215705459] transaction","detail":"{read_only:false; response_revision:5652; number_of_response:1; }","duration":"114.057637ms","start":"2026-02-17T02:36:53.160308Z","end":"2026-02-17T02:36:53.274366Z","steps":["trace[215705459] 'process raft request'  (duration: 84.026243ms)","trace[215705459] 'compare'  (duration: 29.746517ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:36:53.274761Z","caller":"traceutil/trace.go:172","msg":"trace[2032226599] transaction","detail":"{read_only:false; response_revision:5653; number_of_response:1; }","duration":"113.536316ms","start":"2026-02-17T02:36:53.161209Z","end":"2026-02-17T02:36:53.274746Z","steps":["trace[2032226599] 'process raft request'  (duration: 113.038078ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.558119Z","caller":"traceutil/trace.go:172","msg":"trace[681000955] linearizableReadLoop","detail":"{readStateIndex:5916; appliedIndex:5916; }","duration":"220.193038ms","start":"2026-02-17T02:36:53.337905Z","end":"2026-02-17T02:36:53.558098Z","steps":["trace[681000955] 'read index received'  (duration: 220.183607ms)","trace[681000955] 'applied index is now lower than readState.Index'  (duration: 7.271µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:36:53.694544Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"356.657101ms","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:36:53.694755Z","caller":"traceutil/trace.go:172","msg":"trace[1700731867] range","detail":"{range_begin:/registry/pods; range_end:; response_count:0; response_revision:5661; }","duration":"356.877354ms","start":"2026-02-17T02:36:53.337850Z","end":"2026-02-17T02:36:53.694727Z","steps":["trace[1700731867] 'agreement among raft nodes before linearized reading'  (duration: 220.352328ms)","trace[1700731867] 'range keys from in-memory index tree'  (duration: 136.259241ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:36:53.695855Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:36:53.337833Z","time spent":"357.994487ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/pods\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:36:53.695541Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"136.889637ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638592718 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/specs/svc-latency-2970/latency-svc-b44np\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/svc-latency-2970/latency-svc-b44np\" value_size:571 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:36:53.696349Z","caller":"traceutil/trace.go:172","msg":"trace[878431231] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"363.052828ms","start":"2026-02-17T02:36:53.333278Z","end":"2026-02-17T02:36:53.696330Z","steps":["trace[878431231] 'process raft request'  (duration: 362.808044ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:36:53.696852Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:36:53.333242Z","time spent":"363.573718ms","remote":"127.0.0.1:59602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":597,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/ipaddresses/10.254.164.103\" mod_revision:0 > success:<request_put:<key:\"/registry/ipaddresses/10.254.164.103\" value_size:553 >> failure:<>"}
{"level":"info","ts":"2026-02-17T02:36:53.697312Z","caller":"traceutil/trace.go:172","msg":"trace[1840548811] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"357.004801ms","start":"2026-02-17T02:36:53.340289Z","end":"2026-02-17T02:36:53.697293Z","steps":["trace[1840548811] 'process raft request'  (duration: 355.951641ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:36:53.697448Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:36:53.340275Z","time spent":"357.131948ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1152,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/endpointslices/svc-latency-2970/latency-svc-c9h5d-2c5xx\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/svc-latency-2970/latency-svc-c9h5d-2c5xx\" value_size:1079 >> failure:<>"}
{"level":"info","ts":"2026-02-17T02:36:53.697348Z","caller":"traceutil/trace.go:172","msg":"trace[1858828499] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"360.532453ms","start":"2026-02-17T02:36:53.336795Z","end":"2026-02-17T02:36:53.697327Z","steps":["trace[1858828499] 'process raft request'  (duration: 359.384777ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:36:53.697713Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:36:53.336783Z","time spent":"360.886684ms","remote":"127.0.0.1:59318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/svc-latency-2970/latency-svc-c9h5d\" mod_revision:0 > success:<request_put:<key:\"/registry/services/endpoints/svc-latency-2970/latency-svc-c9h5d\" value_size:682 >> failure:<>"}
{"level":"info","ts":"2026-02-17T02:36:53.698304Z","caller":"traceutil/trace.go:172","msg":"trace[66708197] transaction","detail":"{read_only:false; response_revision:5667; number_of_response:1; }","duration":"295.521332ms","start":"2026-02-17T02:36:53.402764Z","end":"2026-02-17T02:36:53.698285Z","steps":["trace[66708197] 'process raft request'  (duration: 293.587381ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.698990Z","caller":"traceutil/trace.go:172","msg":"trace[1787845535] transaction","detail":"{read_only:false; response_revision:5668; number_of_response:1; }","duration":"293.03388ms","start":"2026-02-17T02:36:53.405864Z","end":"2026-02-17T02:36:53.698970Z","steps":["trace[1787845535] 'process raft request'  (duration: 290.676404ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.699002Z","caller":"traceutil/trace.go:172","msg":"trace[1661263257] transaction","detail":"{read_only:false; response_revision:5662; number_of_response:1; }","duration":"365.057993ms","start":"2026-02-17T02:36:53.331781Z","end":"2026-02-17T02:36:53.696838Z","steps":["trace[1661263257] 'process raft request'  (duration: 226.794447ms)","trace[1661263257] 'compare'  (duration: 136.722158ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:36:53.699297Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:36:53.331763Z","time spent":"367.489003ms","remote":"127.0.0.1:59376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/specs/svc-latency-2970/latency-svc-b44np\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/svc-latency-2970/latency-svc-b44np\" value_size:571 >> failure:<>"}
{"level":"info","ts":"2026-02-17T02:36:53.699085Z","caller":"traceutil/trace.go:172","msg":"trace[2014574275] transaction","detail":"{read_only:false; response_revision:5666; number_of_response:1; }","duration":"297.211419ms","start":"2026-02-17T02:36:53.401857Z","end":"2026-02-17T02:36:53.699069Z","steps":["trace[2014574275] 'process raft request'  (duration: 294.44046ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.700575Z","caller":"traceutil/trace.go:172","msg":"trace[823472891] transaction","detail":"{read_only:false; response_revision:5669; number_of_response:1; }","duration":"260.919596ms","start":"2026-02-17T02:36:53.439635Z","end":"2026-02-17T02:36:53.700554Z","steps":["trace[823472891] 'process raft request'  (duration: 257.028042ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.703244Z","caller":"traceutil/trace.go:172","msg":"trace[908525453] transaction","detail":"{read_only:false; response_revision:5674; number_of_response:1; }","duration":"163.78288ms","start":"2026-02-17T02:36:53.539453Z","end":"2026-02-17T02:36:53.703236Z","steps":["trace[908525453] 'process raft request'  (duration: 163.750069ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.703270Z","caller":"traceutil/trace.go:172","msg":"trace[1981899828] transaction","detail":"{read_only:false; response_revision:5670; number_of_response:1; }","duration":"263.296232ms","start":"2026-02-17T02:36:53.439968Z","end":"2026-02-17T02:36:53.703264Z","steps":["trace[1981899828] 'process raft request'  (duration: 260.683232ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.703352Z","caller":"traceutil/trace.go:172","msg":"trace[1940577555] transaction","detail":"{read_only:false; response_revision:5671; number_of_response:1; }","duration":"212.698139ms","start":"2026-02-17T02:36:53.490647Z","end":"2026-02-17T02:36:53.703345Z","steps":["trace[1940577555] 'process raft request'  (duration: 211.632478ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.703419Z","caller":"traceutil/trace.go:172","msg":"trace[609399810] transaction","detail":"{read_only:false; response_revision:5672; number_of_response:1; }","duration":"212.556381ms","start":"2026-02-17T02:36:53.490856Z","end":"2026-02-17T02:36:53.703413Z","steps":["trace[609399810] 'process raft request'  (duration: 212.282005ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.703439Z","caller":"traceutil/trace.go:172","msg":"trace[973856724] transaction","detail":"{read_only:false; response_revision:5673; number_of_response:1; }","duration":"164.269669ms","start":"2026-02-17T02:36:53.539164Z","end":"2026-02-17T02:36:53.703434Z","steps":["trace[973856724] 'process raft request'  (duration: 164.010184ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.889673Z","caller":"traceutil/trace.go:172","msg":"trace[1586753856] transaction","detail":"{read_only:false; response_revision:5683; number_of_response:1; }","duration":"149.32074ms","start":"2026-02-17T02:36:53.740336Z","end":"2026-02-17T02:36:53.889657Z","steps":["trace[1586753856] 'process raft request'  (duration: 54.346009ms)","trace[1586753856] 'compare'  (duration: 94.616471ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:36:53.889832Z","caller":"traceutil/trace.go:172","msg":"trace[1436889522] transaction","detail":"{read_only:false; response_revision:5686; number_of_response:1; }","duration":"146.308438ms","start":"2026-02-17T02:36:53.743518Z","end":"2026-02-17T02:36:53.889826Z","steps":["trace[1436889522] 'process raft request'  (duration: 146.00064ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.889972Z","caller":"traceutil/trace.go:172","msg":"trace[905818668] transaction","detail":"{read_only:false; response_revision:5687; number_of_response:1; }","duration":"103.617107ms","start":"2026-02-17T02:36:53.786347Z","end":"2026-02-17T02:36:53.889964Z","steps":["trace[905818668] 'process raft request'  (duration: 103.207763ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.890104Z","caller":"traceutil/trace.go:172","msg":"trace[1213915302] transaction","detail":"{read_only:false; response_revision:5688; number_of_response:1; }","duration":"103.634379ms","start":"2026-02-17T02:36:53.786464Z","end":"2026-02-17T02:36:53.890098Z","steps":["trace[1213915302] 'process raft request'  (duration: 103.117119ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.890223Z","caller":"traceutil/trace.go:172","msg":"trace[1843584837] transaction","detail":"{read_only:false; response_revision:5684; number_of_response:1; }","duration":"149.296999ms","start":"2026-02-17T02:36:53.740916Z","end":"2026-02-17T02:36:53.890213Z","steps":["trace[1843584837] 'process raft request'  (duration: 148.498933ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:36:53.889757Z","caller":"traceutil/trace.go:172","msg":"trace[1185618375] transaction","detail":"{read_only:false; response_revision:5685; number_of_response:1; }","duration":"147.384349ms","start":"2026-02-17T02:36:53.742363Z","end":"2026-02-17T02:36:53.889747Z","steps":["trace[1185618375] 'process raft request'  (duration: 147.122454ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:37:35.997250Z","caller":"traceutil/trace.go:172","msg":"trace[1001439884] transaction","detail":"{read_only:false; response_revision:7457; number_of_response:1; }","duration":"362.348154ms","start":"2026-02-17T02:37:35.634845Z","end":"2026-02-17T02:37:35.997227Z","steps":["trace[1001439884] 'process raft request'  (duration: 360.868381ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:37:35.997490Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:37:35.634816Z","time spent":"362.609916ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2591,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/configmap-2870/pod-configmaps-943c34ed-415a-4680-958d-1918644e7edf\" mod_revision:7456 > success:<request_put:<key:\"/registry/pods/configmap-2870/pod-configmaps-943c34ed-415a-4680-958d-1918644e7edf\" value_size:2502 >> failure:<request_range:<key:\"/registry/pods/configmap-2870/pod-configmaps-943c34ed-415a-4680-958d-1918644e7edf\" > >"}
{"level":"info","ts":"2026-02-17T02:39:48.623827Z","caller":"mvcc/index.go:194","msg":"compact tree index","revision":2965}
{"level":"info","ts":"2026-02-17T02:39:48.693856Z","caller":"mvcc/kvstore_compaction.go:70","msg":"finished scheduled compaction","compact-revision":2965,"took":"67.994195ms","hash":2315405833,"current-db-size-bytes":17121280,"current-db-size":"17 MB","current-db-size-in-use-bytes":12836864,"current-db-size-in-use":"13 MB"}
{"level":"info","ts":"2026-02-17T02:39:48.693990Z","caller":"mvcc/hash.go:157","msg":"storing new hash","hash":2315405833,"revision":2965,"compact-revision":-1}
{"level":"info","ts":"2026-02-17T02:40:01.987567Z","caller":"traceutil/trace.go:172","msg":"trace[155968074] linearizableReadLoop","detail":"{readStateIndex:9449; appliedIndex:9449; }","duration":"193.285355ms","start":"2026-02-17T02:40:01.794252Z","end":"2026-02-17T02:40:01.987538Z","steps":["trace[155968074] 'read index received'  (duration: 193.271914ms)","trace[155968074] 'applied index is now lower than readState.Index'  (duration: 9.651µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:01.987878Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"193.634503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ipamconfigs\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:40:01.988040Z","caller":"traceutil/trace.go:172","msg":"trace[264465276] transaction","detail":"{read_only:false; response_revision:9075; number_of_response:1; }","duration":"270.953017ms","start":"2026-02-17T02:40:01.717068Z","end":"2026-02-17T02:40:01.988020Z","steps":["trace[264465276] 'process raft request'  (duration: 270.781733ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:01.987987Z","caller":"traceutil/trace.go:172","msg":"trace[1595435321] range","detail":"{range_begin:/registry/crd.projectcalico.org/ipamconfigs; range_end:; response_count:0; response_revision:9074; }","duration":"193.715875ms","start":"2026-02-17T02:40:01.794209Z","end":"2026-02-17T02:40:01.987925Z","steps":["trace[1595435321] 'agreement among raft nodes before linearized reading'  (duration: 193.571141ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:02.096912Z","caller":"traceutil/trace.go:172","msg":"trace[1006154471] linearizableReadLoop","detail":"{readStateIndex:9450; appliedIndex:9450; }","duration":"109.142407ms","start":"2026-02-17T02:40:01.987745Z","end":"2026-02-17T02:40:02.096888Z","steps":["trace[1006154471] 'read index received'  (duration: 109.133137ms)","trace[1006154471] 'applied index is now lower than readState.Index'  (duration: 6.55µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:02.196562Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"364.428313ms","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:40:02.196900Z","caller":"traceutil/trace.go:172","msg":"trace[1833631972] range","detail":"{range_begin:/registry/crd.projectcalico.org/clusterinformations/default; range_end:; response_count:1; response_revision:9075; }","duration":"364.817522ms","start":"2026-02-17T02:40:01.832054Z","end":"2026-02-17T02:40:02.196871Z","steps":["trace[1833631972] 'agreement among raft nodes before linearized reading'  (duration: 264.964624ms)","trace[1833631972] 'range keys from in-memory index tree'  (duration: 99.325246ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:02.196968Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:40:01.832032Z","time spent":"364.917015ms","remote":"127.0.0.1:41218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":893,"request content":"key:\"/registry/crd.projectcalico.org/clusterinformations/default\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:40:02.197520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"100.106565ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638604359 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cloud-controller-manager\" mod_revision:9069 > success:<request_put:<key:\"/registry/leases/kube-system/cloud-controller-manager\" value_size:456 >> failure:<request_range:<key:\"/registry/leases/kube-system/cloud-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:40:02.197706Z","caller":"traceutil/trace.go:172","msg":"trace[810024105] linearizableReadLoop","detail":"{readStateIndex:9452; appliedIndex:9450; }","duration":"100.707909ms","start":"2026-02-17T02:40:02.096987Z","end":"2026-02-17T02:40:02.197695Z","steps":["trace[810024105] 'read index received'  (duration: 52.691µs)","trace[810024105] 'applied index is now lower than readState.Index'  (duration: 100.653468ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:02.197758Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"199.791398ms","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:02.197776Z","caller":"traceutil/trace.go:172","msg":"trace[1569000900] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:9077; }","duration":"199.810429ms","start":"2026-02-17T02:40:01.997957Z","end":"2026-02-17T02:40:02.197768Z","steps":["trace[1569000900] 'agreement among raft nodes before linearized reading'  (duration: 199.773048ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:02.198048Z","caller":"traceutil/trace.go:172","msg":"trace[976586346] transaction","detail":"{read_only:false; response_revision:9076; number_of_response:1; }","duration":"449.754348ms","start":"2026-02-17T02:40:01.748254Z","end":"2026-02-17T02:40:02.198008Z","steps":["trace[976586346] 'process raft request'  (duration: 349.094109ms)","trace[976586346] 'compare'  (duration: 99.800158ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:40:02.198868Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:40:01.748223Z","time spent":"450.552096ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cloud-controller-manager\" mod_revision:9069 > success:<request_put:<key:\"/registry/leases/kube-system/cloud-controller-manager\" value_size:456 >> failure:<request_range:<key:\"/registry/leases/kube-system/cloud-controller-manager\" > >"}
{"level":"info","ts":"2026-02-17T02:40:02.198400Z","caller":"traceutil/trace.go:172","msg":"trace[734610710] transaction","detail":"{read_only:false; response_revision:9077; number_of_response:1; }","duration":"449.994853ms","start":"2026-02-17T02:40:01.748392Z","end":"2026-02-17T02:40:02.198387Z","steps":["trace[734610710] 'process raft request'  (duration: 449.248925ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:40:02.199073Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:40:01.748356Z","time spent":"450.636838ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":505,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:9068 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:445 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-17T02:40:02.198450Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"182.65889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:40:02.199417Z","caller":"traceutil/trace.go:172","msg":"trace[1197384006] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:9077; }","duration":"183.625383ms","start":"2026-02-17T02:40:02.015782Z","end":"2026-02-17T02:40:02.199407Z","steps":["trace[1197384006] 'agreement among raft nodes before linearized reading'  (duration: 182.63666ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:40:14.943369Z","caller":"etcdserver/server.go:2201","msg":"triggering snapshot","local-member-id":"2541a250140d68d4","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000,"snapshot-forced":false}
{"level":"info","ts":"2026-02-17T02:40:14.963699Z","caller":"etcdserver/server.go:2246","msg":"saved snapshot to disk","snapshot-index":10001}
{"level":"info","ts":"2026-02-17T02:42:17.116149Z","caller":"traceutil/trace.go:172","msg":"trace[936308950] linearizableReadLoop","detail":"{readStateIndex:13076; appliedIndex:13076; }","duration":"117.592607ms","start":"2026-02-17T02:42:16.998522Z","end":"2026-02-17T02:42:17.116114Z","steps":["trace[936308950] 'read index received'  (duration: 117.576586ms)","trace[936308950] 'applied index is now lower than readState.Index'  (duration: 12.461µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:17.122553Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.017277ms","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:17.122590Z","caller":"traceutil/trace.go:172","msg":"trace[551239495] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:12607; }","duration":"124.069139ms","start":"2026-02-17T02:42:16.998512Z","end":"2026-02-17T02:42:17.122581Z","steps":["trace[551239495] 'agreement among raft nodes before linearized reading'  (duration: 117.778514ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:17.123515Z","caller":"traceutil/trace.go:172","msg":"trace[402340323] transaction","detail":"{read_only:false; response_revision:12608; number_of_response:1; }","duration":"161.196065ms","start":"2026-02-17T02:42:16.962151Z","end":"2026-02-17T02:42:17.123346Z","steps":["trace[402340323] 'process raft request'  (duration: 154.970183ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:17.426713Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.521877ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638614909 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" mod_revision:12608 > success:<request_put:<key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" value_size:3432 >> failure:<request_range:<key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:42:17.426968Z","caller":"traceutil/trace.go:172","msg":"trace[387116286] transaction","detail":"{read_only:false; response_revision:12609; number_of_response:1; }","duration":"291.278744ms","start":"2026-02-17T02:42:17.135659Z","end":"2026-02-17T02:42:17.426938Z","steps":["trace[387116286] 'process raft request'  (duration: 184.318639ms)","trace[387116286] 'compare'  (duration: 106.229236ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:17.427570Z","caller":"traceutil/trace.go:172","msg":"trace[25998900] transaction","detail":"{read_only:false; response_revision:12610; number_of_response:1; }","duration":"223.9794ms","start":"2026-02-17T02:42:17.203568Z","end":"2026-02-17T02:42:17.427547Z","steps":["trace[25998900] 'process raft request'  (duration: 223.781142ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:17.428246Z","caller":"traceutil/trace.go:172","msg":"trace[572990631] linearizableReadLoop","detail":"{readStateIndex:13078; appliedIndex:13077; }","duration":"101.293326ms","start":"2026-02-17T02:42:17.326937Z","end":"2026-02-17T02:42:17.428230Z","steps":["trace[572990631] 'read index received'  (duration: 99.829906ms)","trace[572990631] 'applied index is now lower than readState.Index'  (duration: 1.46062ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:17.428852Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.89829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:42:17.428930Z","caller":"traceutil/trace.go:172","msg":"trace[1324003810] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices; range_end:; response_count:0; response_revision:12610; }","duration":"101.989474ms","start":"2026-02-17T02:42:17.326927Z","end":"2026-02-17T02:42:17.428917Z","steps":["trace[1324003810] 'agreement among raft nodes before linearized reading'  (duration: 101.505514ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:17.557731Z","caller":"traceutil/trace.go:172","msg":"trace[1470590453] transaction","detail":"{read_only:false; response_revision:12613; number_of_response:1; }","duration":"119.936152ms","start":"2026-02-17T02:42:17.437780Z","end":"2026-02-17T02:42:17.557717Z","steps":["trace[1470590453] 'process raft request'  (duration: 119.89648ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:17.557965Z","caller":"traceutil/trace.go:172","msg":"trace[1041204559] transaction","detail":"{read_only:false; response_revision:12612; number_of_response:1; }","duration":"120.651341ms","start":"2026-02-17T02:42:17.437303Z","end":"2026-02-17T02:42:17.557955Z","steps":["trace[1041204559] 'process raft request'  (duration: 120.334838ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:17.558609Z","caller":"traceutil/trace.go:172","msg":"trace[490042683] transaction","detail":"{read_only:false; response_revision:12611; number_of_response:1; }","duration":"123.000117ms","start":"2026-02-17T02:42:17.435597Z","end":"2026-02-17T02:42:17.558597Z","steps":["trace[490042683] 'process raft request'  (duration: 96.125216ms)","trace[490042683] 'compare'  (duration: 25.790497ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:17.774582Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"179.077665ms","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:42:17.774669Z","caller":"traceutil/trace.go:172","msg":"trace[2029747898] range","detail":"{range_begin:/registry/crd.projectcalico.org/clusterinformations/default; range_end:; response_count:1; response_revision:12613; }","duration":"179.167009ms","start":"2026-02-17T02:42:17.595482Z","end":"2026-02-17T02:42:17.774648Z","steps":["trace[2029747898] 'agreement among raft nodes before linearized reading'  (duration: 70.067626ms)","trace[2029747898] 'range keys from in-memory index tree'  (duration: 108.922185ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:17.775466Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.753469ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638614916 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/job-5604/with-backoff-limit-per-index-1-nplgf.1894e873cf60b3f0\" mod_revision:0 > success:<request_put:<key:\"/registry/events/job-5604/with-backoff-limit-per-index-1-nplgf.1894e873cf60b3f0\" value_size:695 lease:7553834451638610209 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:42:17.776156Z","caller":"traceutil/trace.go:172","msg":"trace[1501834464] linearizableReadLoop","detail":"{readStateIndex:13083; appliedIndex:13082; }","duration":"110.623815ms","start":"2026-02-17T02:42:17.665513Z","end":"2026-02-17T02:42:17.776137Z","steps":["trace[1501834464] 'read index received'  (duration: 54.853µs)","trace[1501834464] 'applied index is now lower than readState.Index'  (duration: 110.565552ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:17.776179Z","caller":"traceutil/trace.go:172","msg":"trace[2097858033] transaction","detail":"{read_only:false; response_revision:12614; number_of_response:1; }","duration":"209.379465ms","start":"2026-02-17T02:42:17.566783Z","end":"2026-02-17T02:42:17.776163Z","steps":["trace[2097858033] 'process raft request'  (duration: 98.769601ms)","trace[2097858033] 'compare'  (duration: 109.432306ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:17.776256Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"130.495102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/networksets/\" range_end:\"/registry/crd.projectcalico.org/networksets0\" limit:10000 revision:12589 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:42:17.776916Z","caller":"traceutil/trace.go:172","msg":"trace[1324359219] range","detail":"{range_begin:/registry/crd.projectcalico.org/networksets/; range_end:/registry/crd.projectcalico.org/networksets0; response_count:0; response_revision:12614; }","duration":"131.154699ms","start":"2026-02-17T02:42:17.645748Z","end":"2026-02-17T02:42:17.776903Z","steps":["trace[1324359219] 'agreement among raft nodes before linearized reading'  (duration: 130.463051ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:17.776340Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"144.620036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" limit:1 ","response":"range_response_count:1 size:3532"}
{"level":"info","ts":"2026-02-17T02:42:17.777611Z","caller":"traceutil/trace.go:172","msg":"trace[392892916] range","detail":"{range_begin:/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52; range_end:; response_count:1; response_revision:12614; }","duration":"145.883307ms","start":"2026-02-17T02:42:17.631713Z","end":"2026-02-17T02:42:17.777596Z","steps":["trace[392892916] 'agreement among raft nodes before linearized reading'  (duration: 144.563684ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:17.964184Z","caller":"traceutil/trace.go:172","msg":"trace[1225721855] transaction","detail":"{read_only:false; response_revision:12615; number_of_response:1; }","duration":"178.46592ms","start":"2026-02-17T02:42:17.785702Z","end":"2026-02-17T02:42:17.964168Z","steps":["trace[1225721855] 'process raft request'  (duration: 113.131426ms)","trace[1225721855] 'compare'  (duration: 65.248791ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:17.965373Z","caller":"traceutil/trace.go:172","msg":"trace[1770976391] transaction","detail":"{read_only:false; response_revision:12617; number_of_response:1; }","duration":"174.156406ms","start":"2026-02-17T02:42:17.791198Z","end":"2026-02-17T02:42:17.965355Z","steps":["trace[1770976391] 'process raft request'  (duration: 174.108324ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:17.965462Z","caller":"traceutil/trace.go:172","msg":"trace[612871683] transaction","detail":"{read_only:false; response_revision:12616; number_of_response:1; }","duration":"176.915628ms","start":"2026-02-17T02:42:17.788534Z","end":"2026-02-17T02:42:17.965449Z","steps":["trace[612871683] 'process raft request'  (duration: 176.649468ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:18.223302Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"129.720308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" limit:10000 revision:12582 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:42:18.223727Z","caller":"traceutil/trace.go:172","msg":"trace[1411918775] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:12618; }","duration":"129.919656ms","start":"2026-02-17T02:42:18.093540Z","end":"2026-02-17T02:42:18.223459Z","steps":["trace[1411918775] 'agreement among raft nodes before linearized reading'  (duration: 70.78491ms)","trace[1411918775] 'range keys from in-memory index tree'  (duration: 58.886156ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:18.225303Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"131.270982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.0123d51c86809a35b4c2350abd2813356ef89dfb5d491a8b5a14f28d6a3c6ab2\" limit:1 ","response":"range_response_count:1 size:984"}
{"level":"info","ts":"2026-02-17T02:42:18.225480Z","caller":"traceutil/trace.go:172","msg":"trace[85259353] range","detail":"{range_begin:/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.0123d51c86809a35b4c2350abd2813356ef89dfb5d491a8b5a14f28d6a3c6ab2; range_end:; response_count:1; response_revision:12619; }","duration":"131.362675ms","start":"2026-02-17T02:42:18.094015Z","end":"2026-02-17T02:42:18.225378Z","steps":["trace[85259353] 'agreement among raft nodes before linearized reading'  (duration: 131.159637ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:18.226209Z","caller":"traceutil/trace.go:172","msg":"trace[1626274545] transaction","detail":"{read_only:false; response_revision:12619; number_of_response:1; }","duration":"175.534363ms","start":"2026-02-17T02:42:18.050641Z","end":"2026-02-17T02:42:18.226175Z","steps":["trace[1626274545] 'process raft request'  (duration: 113.687916ms)","trace[1626274545] 'compare'  (duration: 60.160728ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:18.468181Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.098923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.0123d51c86809a35b4c2350abd2813356ef89dfb5d491a8b5a14f28d6a3c6ab2\" limit:1 ","response":"range_response_count:1 size:984"}
{"level":"info","ts":"2026-02-17T02:42:18.468985Z","caller":"traceutil/trace.go:172","msg":"trace[1895362090] range","detail":"{range_begin:/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.0123d51c86809a35b4c2350abd2813356ef89dfb5d491a8b5a14f28d6a3c6ab2; range_end:; response_count:1; response_revision:12621; }","duration":"142.863695ms","start":"2026-02-17T02:42:18.326054Z","end":"2026-02-17T02:42:18.468918Z","steps":["trace[1895362090] 'range keys from in-memory index tree'  (duration: 141.941716ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:18.818097Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.799043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/blockaffinities/kube-e17cw-default-worker-7r88m-ncg6k-8ckqv-10-100-242-192-26\" limit:1 ","response":"range_response_count:1 size:1432"}
{"level":"info","ts":"2026-02-17T02:42:18.818582Z","caller":"traceutil/trace.go:172","msg":"trace[663587261] transaction","detail":"{read_only:false; response_revision:12628; number_of_response:1; }","duration":"160.697661ms","start":"2026-02-17T02:42:18.657862Z","end":"2026-02-17T02:42:18.818560Z","steps":["trace[663587261] 'process raft request'  (duration: 98.143976ms)","trace[663587261] 'compare'  (duration: 61.802935ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:18.818598Z","caller":"traceutil/trace.go:172","msg":"trace[1785164337] range","detail":"{range_begin:/registry/crd.projectcalico.org/blockaffinities/kube-e17cw-default-worker-7r88m-ncg6k-8ckqv-10-100-242-192-26; range_end:; response_count:1; response_revision:12627; }","duration":"143.303613ms","start":"2026-02-17T02:42:18.675258Z","end":"2026-02-17T02:42:18.818561Z","steps":["trace[1785164337] 'agreement among raft nodes before linearized reading'  (duration: 80.706266ms)","trace[1785164337] 'range keys from in-memory index tree'  (duration: 61.947091ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:18.819213Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"139.863392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/job-5604/with-backoff-limit-per-index\" limit:1 ","response":"range_response_count:1 size:2401"}
{"level":"info","ts":"2026-02-17T02:42:18.819361Z","caller":"traceutil/trace.go:172","msg":"trace[1066967048] range","detail":"{range_begin:/registry/jobs/job-5604/with-backoff-limit-per-index; range_end:; response_count:1; response_revision:12628; }","duration":"140.024329ms","start":"2026-02-17T02:42:18.679317Z","end":"2026-02-17T02:42:18.819341Z","steps":["trace[1066967048] 'agreement among raft nodes before linearized reading'  (duration: 139.341641ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:19.031551Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"168.846524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/sonobuoy/sonobuoy-e2e-job-43e35cc779114041\" limit:1 ","response":"range_response_count:1 size:9459"}
{"level":"info","ts":"2026-02-17T02:42:19.031660Z","caller":"traceutil/trace.go:172","msg":"trace[1220132433] range","detail":"{range_begin:/registry/pods/sonobuoy/sonobuoy-e2e-job-43e35cc779114041; range_end:; response_count:1; response_revision:12629; }","duration":"168.966619ms","start":"2026-02-17T02:42:18.862672Z","end":"2026-02-17T02:42:19.031639Z","steps":["trace[1220132433] 'agreement among raft nodes before linearized reading'  (duration: 96.452916ms)","trace[1220132433] 'range keys from in-memory index tree'  (duration: 72.208861ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:19.032621Z","caller":"traceutil/trace.go:172","msg":"trace[943774333] transaction","detail":"{read_only:false; response_revision:12630; number_of_response:1; }","duration":"144.975872ms","start":"2026-02-17T02:42:18.887608Z","end":"2026-02-17T02:42:19.032584Z","steps":["trace[943774333] 'process raft request'  (duration: 71.49842ms)","trace[943774333] 'compare'  (duration: 72.167089ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:19.032876Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"128.534192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.7da641bfb4e40d1fca02005cb053b09e0700e2741236ceb41dda4aa501035901\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:42:19.032921Z","caller":"traceutil/trace.go:172","msg":"trace[1215821759] range","detail":"{range_begin:/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.7da641bfb4e40d1fca02005cb053b09e0700e2741236ceb41dda4aa501035901; range_end:; response_count:0; response_revision:12631; }","duration":"128.583634ms","start":"2026-02-17T02:42:18.904326Z","end":"2026-02-17T02:42:19.032909Z","steps":["trace[1215821759] 'agreement among raft nodes before linearized reading'  (duration: 128.501971ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:19.249084Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.727762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/job-5604/with-backoff-limit-per-index-3-h5mfg\" limit:1 ","response":"range_response_count:1 size:5141"}
{"level":"info","ts":"2026-02-17T02:42:19.249190Z","caller":"traceutil/trace.go:172","msg":"trace[1831748207] range","detail":"{range_begin:/registry/pods/job-5604/with-backoff-limit-per-index-3-h5mfg; range_end:; response_count:1; response_revision:12633; }","duration":"121.844337ms","start":"2026-02-17T02:42:19.127325Z","end":"2026-02-17T02:42:19.249170Z","steps":["trace[1831748207] 'agreement among raft nodes before linearized reading'  (duration: 50.035809ms)","trace[1831748207] 'range keys from in-memory index tree'  (duration: 71.470614ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:19.249624Z","caller":"traceutil/trace.go:172","msg":"trace[1781318866] transaction","detail":"{read_only:false; number_of_response:1; response_revision:12634; }","duration":"164.538168ms","start":"2026-02-17T02:42:19.085029Z","end":"2026-02-17T02:42:19.249567Z","steps":["trace[1781318866] 'process raft request'  (duration: 164.473245ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:19.249866Z","caller":"traceutil/trace.go:172","msg":"trace[1096220844] transaction","detail":"{read_only:false; response_revision:12634; number_of_response:1; }","duration":"168.238279ms","start":"2026-02-17T02:42:19.081576Z","end":"2026-02-17T02:42:19.249814Z","steps":["trace[1096220844] 'process raft request'  (duration: 95.933522ms)","trace[1096220844] 'compare'  (duration: 71.452642ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:19.704224Z","caller":"traceutil/trace.go:172","msg":"trace[2016880638] linearizableReadLoop","detail":"{readStateIndex:13106; appliedIndex:13106; }","duration":"125.027407ms","start":"2026-02-17T02:42:19.579171Z","end":"2026-02-17T02:42:19.704198Z","steps":["trace[2016880638] 'read index received'  (duration: 125.019717ms)","trace[2016880638] 'applied index is now lower than readState.Index'  (duration: 5.91µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:19.704377Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.183423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/bgpconfigurations\" limit:1 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:42:19.704396Z","caller":"traceutil/trace.go:172","msg":"trace[1620879622] range","detail":"{range_begin:/registry/crd.projectcalico.org/bgpconfigurations; range_end:; response_count:0; response_revision:12636; }","duration":"125.224215ms","start":"2026-02-17T02:42:19.579167Z","end":"2026-02-17T02:42:19.704391Z","steps":["trace[1620879622] 'agreement among raft nodes before linearized reading'  (duration: 125.142752ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:19.704501Z","caller":"traceutil/trace.go:172","msg":"trace[922141895] transaction","detail":"{read_only:false; response_revision:12637; number_of_response:1; }","duration":"125.763797ms","start":"2026-02-17T02:42:19.578643Z","end":"2026-02-17T02:42:19.704406Z","steps":["trace[922141895] 'process raft request'  (duration: 125.615371ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:22.148400Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"149.40051ms","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:42:22.148643Z","caller":"traceutil/trace.go:172","msg":"trace[376590352] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:12657; }","duration":"149.65355ms","start":"2026-02-17T02:42:21.998963Z","end":"2026-02-17T02:42:22.148616Z","steps":["trace[376590352] 'range keys from in-memory index tree'  (duration: 149.338778ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:22.148782Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"357.256642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/job-9643/evicted-pod-ignore-on-disruption-condition\" limit:1 ","response":"range_response_count:1 size:2908"}
{"level":"info","ts":"2026-02-17T02:42:22.148892Z","caller":"traceutil/trace.go:172","msg":"trace[578090165] range","detail":"{range_begin:/registry/jobs/job-9643/evicted-pod-ignore-on-disruption-condition; range_end:; response_count:1; response_revision:12657; }","duration":"357.477591ms","start":"2026-02-17T02:42:21.791392Z","end":"2026-02-17T02:42:22.148869Z","steps":["trace[578090165] 'agreement among raft nodes before linearized reading'  (duration: 56.601695ms)","trace[578090165] 'range keys from in-memory index tree'  (duration: 300.411437ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:22.149171Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:42:21.791374Z","time spent":"357.780983ms","remote":"127.0.0.1:59452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":2930,"request content":"key:\"/registry/jobs/job-9643/evicted-pod-ignore-on-disruption-condition\" limit:1 "}
{"level":"warn","ts":"2026-02-17T02:42:22.150510Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"302.364976ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638615038 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" mod_revision:12655 > success:<request_put:<key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" value_size:3432 >> failure:<request_range:<key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-17T02:42:22.150614Z","caller":"traceutil/trace.go:172","msg":"trace[1187438184] linearizableReadLoop","detail":"{readStateIndex:13129; appliedIndex:13128; }","duration":"302.652739ms","start":"2026-02-17T02:42:21.847952Z","end":"2026-02-17T02:42:22.150605Z","steps":["trace[1187438184] 'read index received'  (duration: 49.592µs)","trace[1187438184] 'applied index is now lower than readState.Index'  (duration: 302.601427ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:22.150715Z","caller":"traceutil/trace.go:172","msg":"trace[1635810855] transaction","detail":"{read_only:false; response_revision:12658; number_of_response:1; }","duration":"368.273753ms","start":"2026-02-17T02:42:21.782410Z","end":"2026-02-17T02:42:22.150684Z","steps":["trace[1635810855] 'process raft request'  (duration: 65.580163ms)","trace[1635810855] 'compare'  (duration: 300.166977ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:22.150893Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:42:21.782385Z","time spent":"368.43139ms","remote":"127.0.0.1:59352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3516,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" mod_revision:12655 > success:<request_put:<key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" value_size:3432 >> failure:<request_range:<key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" > >"}
{"level":"warn","ts":"2026-02-17T02:42:22.151335Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"187.04788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-17T02:42:22.154581Z","caller":"traceutil/trace.go:172","msg":"trace[764261036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12658; }","duration":"190.295423ms","start":"2026-02-17T02:42:21.964272Z","end":"2026-02-17T02:42:22.154568Z","steps":["trace[764261036] 'agreement among raft nodes before linearized reading'  (duration: 187.010419ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:22.153700Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"309.440336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.7da641bfb4e40d1fca02005cb053b09e0700e2741236ceb41dda4aa501035901\" limit:1 ","response":"range_response_count:1 size:984"}
{"level":"info","ts":"2026-02-17T02:42:22.154887Z","caller":"traceutil/trace.go:172","msg":"trace[1515377550] range","detail":"{range_begin:/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.7da641bfb4e40d1fca02005cb053b09e0700e2741236ceb41dda4aa501035901; range_end:; response_count:1; response_revision:12658; }","duration":"310.632115ms","start":"2026-02-17T02:42:21.844245Z","end":"2026-02-17T02:42:22.154877Z","steps":["trace[1515377550] 'agreement among raft nodes before linearized reading'  (duration: 306.427493ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-17T02:42:22.154919Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-02-17T02:42:21.844224Z","time spent":"310.681767ms","remote":"127.0.0.1:41442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":1,"response size":1006,"request content":"key:\"/registry/crd.projectcalico.org/ipamhandles/k8s-pod-network.7da641bfb4e40d1fca02005cb053b09e0700e2741236ceb41dda4aa501035901\" limit:1 "}
{"level":"info","ts":"2026-02-17T02:42:22.407858Z","caller":"traceutil/trace.go:172","msg":"trace[1635071776] transaction","detail":"{read_only:false; response_revision:12660; number_of_response:1; }","duration":"143.300601ms","start":"2026-02-17T02:42:22.264543Z","end":"2026-02-17T02:42:22.407844Z","steps":["trace[1635071776] 'process raft request'  (duration: 143.126974ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:42:22.675941Z","caller":"traceutil/trace.go:172","msg":"trace[1299253043] transaction","detail":"{read_only:false; number_of_response:1; response_revision:12662; }","duration":"196.042803ms","start":"2026-02-17T02:42:22.479877Z","end":"2026-02-17T02:42:22.675919Z","steps":["trace[1299253043] 'process raft request'  (duration: 153.431039ms)","trace[1299253043] 'compare'  (duration: 42.320932ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:22.935388Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"140.238525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/job-5604/with-backoff-limit-per-index-1-nplgf\" limit:1 ","response":"range_response_count:1 size:5128"}
{"level":"info","ts":"2026-02-17T02:42:22.935528Z","caller":"traceutil/trace.go:172","msg":"trace[85729122] range","detail":"{range_begin:/registry/pods/job-5604/with-backoff-limit-per-index-1-nplgf; range_end:; response_count:1; response_revision:12663; }","duration":"140.35447ms","start":"2026-02-17T02:42:22.795109Z","end":"2026-02-17T02:42:22.935464Z","steps":["trace[85729122] 'agreement among raft nodes before linearized reading'  (duration: 34.583737ms)","trace[85729122] 'range keys from in-memory index tree'  (duration: 105.509802ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:22.935882Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"106.369857ms","expected-duration":"100ms","prefix":"","request":"header:<ID:7553834451638615060 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/crd.projectcalico.org/tiers/default\" mod_revision:0 > success:<request_put:<key:\"/registry/crd.projectcalico.org/tiers/default\" value_size:634 >> failure:<>>","response":"size:5"}
{"level":"info","ts":"2026-02-17T02:42:22.936245Z","caller":"traceutil/trace.go:172","msg":"trace[1679629856] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12663; }","duration":"194.999288ms","start":"2026-02-17T02:42:22.741236Z","end":"2026-02-17T02:42:22.936235Z","steps":["trace[1679629856] 'process raft request'  (duration: 88.235795ms)","trace[1679629856] 'compare'  (duration: 106.338406ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:23.128267Z","caller":"traceutil/trace.go:172","msg":"trace[1382022617] transaction","detail":"{read_only:false; number_of_response:0; response_revision:12665; }","duration":"116.434529ms","start":"2026-02-17T02:42:23.011807Z","end":"2026-02-17T02:42:23.128241Z","steps":["trace[1382022617] 'process raft request'  (duration: 71.186802ms)","trace[1382022617] 'compare'  (duration: 44.764027ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:23.315601Z","caller":"traceutil/trace.go:172","msg":"trace[2143093950] linearizableReadLoop","detail":"{readStateIndex:13141; appliedIndex:13141; }","duration":"117.839966ms","start":"2026-02-17T02:42:23.197725Z","end":"2026-02-17T02:42:23.315564Z","steps":["trace[2143093950] 'read index received'  (duration: 117.822295ms)","trace[2143093950] 'applied index is now lower than readState.Index'  (duration: 13.62µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:23.350809Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"153.063431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52\" limit:1 ","response":"range_response_count:1 size:3532"}
{"level":"info","ts":"2026-02-17T02:42:23.351467Z","caller":"traceutil/trace.go:172","msg":"trace[1242213103] transaction","detail":"{read_only:false; response_revision:12668; number_of_response:1; }","duration":"211.686646ms","start":"2026-02-17T02:42:23.139762Z","end":"2026-02-17T02:42:23.351449Z","steps":["trace[1242213103] 'process raft request'  (duration: 175.859066ms)","trace[1242213103] 'compare'  (duration: 35.357501ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:23.352291Z","caller":"traceutil/trace.go:172","msg":"trace[2051703998] range","detail":"{range_begin:/registry/pods/pods-5397/pod-generation-ac9a3017-2b27-4107-8878-0c099d2a3d52; range_end:; response_count:1; response_revision:12667; }","duration":"153.308741ms","start":"2026-02-17T02:42:23.197719Z","end":"2026-02-17T02:42:23.351027Z","steps":["trace[2051703998] 'agreement among raft nodes before linearized reading'  (duration: 118.060984ms)","trace[2051703998] 'range keys from in-memory index tree'  (duration: 34.896212ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-17T02:42:24.301887Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"142.837011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/job-9643/evicted-pod-ignore-on-disruption-condition\" limit:1 ","response":"range_response_count:1 size:2908"}
{"level":"info","ts":"2026-02-17T02:42:24.302083Z","caller":"traceutil/trace.go:172","msg":"trace[282074887] range","detail":"{range_begin:/registry/jobs/job-9643/evicted-pod-ignore-on-disruption-condition; range_end:; response_count:1; response_revision:12671; }","duration":"142.982187ms","start":"2026-02-17T02:42:24.159011Z","end":"2026-02-17T02:42:24.301993Z","steps":["trace[282074887] 'agreement among raft nodes before linearized reading'  (duration: 73.625146ms)","trace[282074887] 'range keys from in-memory index tree'  (duration: 69.061488ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:24.302968Z","caller":"traceutil/trace.go:172","msg":"trace[1949189157] transaction","detail":"{read_only:false; response_revision:12672; number_of_response:1; }","duration":"208.841574ms","start":"2026-02-17T02:42:24.094105Z","end":"2026-02-17T02:42:24.302946Z","steps":["trace[1949189157] 'process raft request'  (duration: 138.590787ms)","trace[1949189157] 'compare'  (duration: 69.279617ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:42:24.303653Z","caller":"traceutil/trace.go:172","msg":"trace[1844163450] transaction","detail":"{read_only:false; response_revision:12673; number_of_response:1; }","duration":"209.407027ms","start":"2026-02-17T02:42:24.094219Z","end":"2026-02-17T02:42:24.303626Z","steps":["trace[1844163450] 'process raft request'  (duration: 208.733069ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:44:48.635343Z","caller":"mvcc/index.go:194","msg":"compact tree index","revision":8979}
{"level":"info","ts":"2026-02-17T02:44:48.789331Z","caller":"mvcc/kvstore_compaction.go:70","msg":"finished scheduled compaction","compact-revision":8979,"took":"150.275791ms","hash":1744829427,"current-db-size-bytes":25513984,"current-db-size":"26 MB","current-db-size-in-use-bytes":17022976,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-02-17T02:44:48.789506Z","caller":"mvcc/hash.go:157","msg":"storing new hash","hash":1744829427,"revision":8979,"compact-revision":2965}
{"level":"info","ts":"2026-02-17T02:47:03.023575Z","caller":"etcdserver/server.go:2201","msg":"triggering snapshot","local-member-id":"2541a250140d68d4","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000,"snapshot-forced":false}
{"level":"info","ts":"2026-02-17T02:47:03.038989Z","caller":"etcdserver/server.go:2246","msg":"saved snapshot to disk","snapshot-index":20002}
{"level":"info","ts":"2026-02-17T02:49:48.653779Z","caller":"mvcc/index.go:194","msg":"compact tree index","revision":15517}
{"level":"info","ts":"2026-02-17T02:49:48.818578Z","caller":"mvcc/kvstore_compaction.go:70","msg":"finished scheduled compaction","compact-revision":15517,"took":"162.080976ms","hash":3221523137,"current-db-size-bytes":32829440,"current-db-size":"33 MB","current-db-size-in-use-bytes":20279296,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-02-17T02:49:48.818703Z","caller":"mvcc/hash.go:157","msg":"storing new hash","hash":3221523137,"revision":15517,"compact-revision":8979}
{"level":"info","ts":"2026-02-17T02:54:48.590417Z","caller":"etcdserver/server.go:2201","msg":"triggering snapshot","local-member-id":"2541a250140d68d4","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000,"snapshot-forced":false}
{"level":"info","ts":"2026-02-17T02:54:48.598888Z","caller":"etcdserver/server.go:2246","msg":"saved snapshot to disk","snapshot-index":30003}
{"level":"info","ts":"2026-02-17T02:54:48.664516Z","caller":"mvcc/index.go:194","msg":"compact tree index","revision":22937}
{"level":"info","ts":"2026-02-17T02:54:48.838721Z","caller":"mvcc/kvstore_compaction.go:70","msg":"finished scheduled compaction","compact-revision":22937,"took":"169.12288ms","hash":3367741849,"current-db-size-bytes":32829440,"current-db-size":"33 MB","current-db-size-in-use-bytes":14901248,"current-db-size-in-use":"15 MB"}
{"level":"info","ts":"2026-02-17T02:54:48.838893Z","caller":"mvcc/hash.go:157","msg":"storing new hash","hash":3367741849,"revision":22937,"compact-revision":15517}
{"level":"info","ts":"2026-02-17T02:56:48.178435Z","caller":"traceutil/trace.go:172","msg":"trace[1094757301] transaction","detail":"{read_only:false; response_revision:30117; number_of_response:1; }","duration":"139.080947ms","start":"2026-02-17T02:56:48.039332Z","end":"2026-02-17T02:56:48.178413Z","steps":["trace[1094757301] 'process raft request'  (duration: 139.014685ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:56:48.178730Z","caller":"traceutil/trace.go:172","msg":"trace[18073235] transaction","detail":"{read_only:false; response_revision:30116; number_of_response:1; }","duration":"140.280751ms","start":"2026-02-17T02:56:48.038433Z","end":"2026-02-17T02:56:48.178714Z","steps":["trace[18073235] 'process raft request'  (duration: 93.355448ms)","trace[18073235] 'compare'  (duration: 46.364053ms)"],"step_count":2}
{"level":"info","ts":"2026-02-17T02:56:51.829406Z","caller":"traceutil/trace.go:172","msg":"trace[1675145229] transaction","detail":"{read_only:false; response_revision:30126; number_of_response:1; }","duration":"149.898754ms","start":"2026-02-17T02:56:51.679488Z","end":"2026-02-17T02:56:51.829386Z","steps":["trace[1675145229] 'process raft request'  (duration: 149.752868ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:56:53.516660Z","caller":"traceutil/trace.go:172","msg":"trace[958089159] transaction","detail":"{read_only:false; response_revision:30131; number_of_response:1; }","duration":"148.565629ms","start":"2026-02-17T02:56:53.368076Z","end":"2026-02-17T02:56:53.516642Z","steps":["trace[958089159] 'process raft request'  (duration: 148.421124ms)"],"step_count":1}
{"level":"info","ts":"2026-02-17T02:56:53.607643Z","caller":"traceutil/trace.go:172","msg":"trace[1900265794] transaction","detail":"{read_only:false; response_revision:30132; number_of_response:1; }","duration":"115.269354ms","start":"2026-02-17T02:56:53.492348Z","end":"2026-02-17T02:56:53.607617Z","steps":["trace[1900265794] 'process raft request'  (duration: 69.909724ms)","trace[1900265794] 'compare'  (duration: 45.231865ms)"],"step_count":2}
