{"level":"warn","ts":"2026-02-12T03:37:30.218291Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-12T03:37:30.218628Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.149:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.149:2380","--initial-cluster=instance=https://199.204.45.149:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.149:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.149:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-12T03:37:30.218685Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-12T03:37:30.218703Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.149:2380"]} {"level":"info","ts":"2026-02-12T03:37:30.218721Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-12T03:37:30.219244Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"]} {"level":"info","ts":"2026-02-12T03:37:30.21931Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.149:2380"],"listen-peer-urls":["https://199.204.45.149:2380"],"advertise-client-urls":["https://199.204.45.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.149:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-12T03:37:30.235945Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"16.45226ms"} {"level":"info","ts":"2026-02-12T03:37:30.283064Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b1b675f124322401","cluster-id":"913dfbf24a38e0aa"} {"level":"info","ts":"2026-02-12T03:37:30.283184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=()"} {"level":"info","ts":"2026-02-12T03:37:30.283261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became follower at term 0"} {"level":"info","ts":"2026-02-12T03:37:30.283282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b1b675f124322401 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-12T03:37:30.283332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became follower at term 1"} {"level":"info","ts":"2026-02-12T03:37:30.283405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=(12805552269029417985)"} {"level":"warn","ts":"2026-02-12T03:37:30.382924Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-12T03:37:30.395087Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-12T03:37:30.434911Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-12T03:37:30.463683Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b1b675f124322401","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-12T03:37:30.487221Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-12T03:37:30.487441Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b1b675f124322401","initial-advertise-peer-urls":["https://199.204.45.149:2380"],"listen-peer-urls":["https://199.204.45.149:2380"],"advertise-client-urls":["https://199.204.45.149:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.149:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-12T03:37:30.487472Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-12T03:37:30.487551Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-12T03:37:30.487592Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-12T03:37:30.487598Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-12T03:37:30.487716Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.149:2380"} {"level":"info","ts":"2026-02-12T03:37:30.487731Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.149:2380"} {"level":"info","ts":"2026-02-12T03:37:30.488628Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b1b675f124322401","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-12T03:37:30.519007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 switched to configuration voters=(12805552269029417985)"} {"level":"info","ts":"2026-02-12T03:37:30.519145Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"913dfbf24a38e0aa","local-member-id":"b1b675f124322401","added-peer-id":"b1b675f124322401","added-peer-peer-urls":["https://199.204.45.149:2380"]} {"level":"info","ts":"2026-02-12T03:37:31.284647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 is starting a new election at term 1"} {"level":"info","ts":"2026-02-12T03:37:31.284687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-12T03:37:31.284712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 received MsgPreVoteResp from b1b675f124322401 at term 1"} {"level":"info","ts":"2026-02-12T03:37:31.284735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became candidate at term 2"} {"level":"info","ts":"2026-02-12T03:37:31.284744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 received MsgVoteResp from b1b675f124322401 at term 2"} {"level":"info","ts":"2026-02-12T03:37:31.284753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b1b675f124322401 became leader at term 2"} {"level":"info","ts":"2026-02-12T03:37:31.28476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b1b675f124322401 elected leader b1b675f124322401 at term 2"} {"level":"info","ts":"2026-02-12T03:37:31.312209Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b1b675f124322401","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.149:2379]}","request-path":"/0/members/b1b675f124322401/attributes","cluster-id":"913dfbf24a38e0aa","publish-timeout":"7s"} {"level":"info","ts":"2026-02-12T03:37:31.312339Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:37:31.312414Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T03:37:31.312662Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T03:37:31.313928Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-12T03:37:31.314315Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-12T03:37:31.31435Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-12T03:37:31.315079Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.149:2379"} {"level":"info","ts":"2026-02-12T03:37:31.351397Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"913dfbf24a38e0aa","local-member-id":"b1b675f124322401","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:37:31.35147Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:37:31.351488Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:37:44.953259Z","caller":"traceutil/trace.go:171","msg":"trace[161428418] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"116.678358ms","start":"2026-02-12T03:37:44.836567Z","end":"2026-02-12T03:37:44.953245Z","steps":["trace[161428418] 'process raft request' (duration: 116.326335ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:37:45.576604Z","caller":"traceutil/trace.go:171","msg":"trace[756753098] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"151.170813ms","start":"2026-02-12T03:37:45.425416Z","end":"2026-02-12T03:37:45.576587Z","steps":["trace[756753098] 'process raft request' (duration: 151.074423ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:37:55.575501Z","caller":"traceutil/trace.go:171","msg":"trace[152762795] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"200.784513ms","start":"2026-02-12T03:37:55.374699Z","end":"2026-02-12T03:37:55.575484Z","steps":["trace[152762795] 'read index received' (duration: 200.665453ms)","trace[152762795] 'applied index is now lower than readState.Index' (duration: 118.23µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:37:55.575594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.876824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:37:55.57564Z","caller":"traceutil/trace.go:171","msg":"trace[255700165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:426; }","duration":"200.962074ms","start":"2026-02-12T03:37:55.37467Z","end":"2026-02-12T03:37:55.575632Z","steps":["trace[255700165] 'agreement among raft nodes before linearized reading' (duration: 200.881894ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:37:55.575824Z","caller":"traceutil/trace.go:171","msg":"trace[1624543047] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"249.680174ms","start":"2026-02-12T03:37:55.326134Z","end":"2026-02-12T03:37:55.575814Z","steps":["trace[1624543047] 'process raft request' (duration: 249.228912ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:37:57.064581Z","caller":"traceutil/trace.go:171","msg":"trace[435988254] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"360.142484ms","start":"2026-02-12T03:37:56.704417Z","end":"2026-02-12T03:37:57.06456Z","steps":["trace[435988254] 'process raft request' (duration: 359.850893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:37:57.065147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:37:56.704403Z","time spent":"360.233875ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:38:03.505206Z","caller":"traceutil/trace.go:171","msg":"trace[1491849535] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:494; }","duration":"369.082797ms","start":"2026-02-12T03:38:03.136107Z","end":"2026-02-12T03:38:03.50519Z","steps":["trace[1491849535] 'read index received' (duration: 368.94206ms)","trace[1491849535] 'applied index is now lower than readState.Index' (duration: 140.147µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:38:03.505293Z","caller":"traceutil/trace.go:171","msg":"trace[759753604] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"394.637941ms","start":"2026-02-12T03:38:03.110648Z","end":"2026-02-12T03:38:03.505286Z","steps":["trace[759753604] 'process raft request' (duration: 394.437731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:03.505381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:03.110638Z","time spent":"394.673882ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:38:03.505527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.319159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-12T03:38:03.505598Z","caller":"traceutil/trace.go:171","msg":"trace[62363632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:476; }","duration":"369.404712ms","start":"2026-02-12T03:38:03.136173Z","end":"2026-02-12T03:38:03.505578Z","steps":["trace[62363632] 'agreement among raft nodes before linearized reading' (duration: 369.230994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:03.505637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:03.136168Z","time spent":"369.460445ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-12T03:38:03.505662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.55228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-12T03:38:03.505688Z","caller":"traceutil/trace.go:171","msg":"trace[1227507651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:476; }","duration":"369.604402ms","start":"2026-02-12T03:38:03.136077Z","end":"2026-02-12T03:38:03.505681Z","steps":["trace[1227507651] 'agreement among raft nodes before linearized reading' (duration: 369.512118ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:03.505709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:03.136061Z","time spent":"369.642095ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-12T03:38:04.218072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.711041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:38:04.218306Z","caller":"traceutil/trace.go:171","msg":"trace[872940748] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:495; }","duration":"600.459322ms","start":"2026-02-12T03:38:03.617834Z","end":"2026-02-12T03:38:04.218293Z","steps":["trace[872940748] 'read index received' (duration: 205.489589ms)","trace[872940748] 'applied index is now lower than readState.Index' (duration: 394.969023ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:38:04.218403Z","caller":"traceutil/trace.go:171","msg":"trace[1057758924] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"707.571798ms","start":"2026-02-12T03:38:03.510811Z","end":"2026-02-12T03:38:04.218383Z","steps":["trace[1057758924] 'process raft request' (duration: 312.33013ms)","trace[1057758924] 'compare' (duration: 394.49148ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:38:04.218476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.636643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T03:38:04.218538Z","caller":"traceutil/trace.go:171","msg":"trace[1818515849] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:479; }","duration":"600.730297ms","start":"2026-02-12T03:38:03.617796Z","end":"2026-02-12T03:38:04.218526Z","steps":["trace[1818515849] 'agreement among raft nodes before linearized reading' (duration: 600.534416ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:04.218572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:03.61778Z","time spent":"600.782289ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-12T03:38:04.218791Z","caller":"traceutil/trace.go:171","msg":"trace[1759903583] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"690.493143ms","start":"2026-02-12T03:38:03.528289Z","end":"2026-02-12T03:38:04.218782Z","steps":["trace[1759903583] 'process raft request' (duration: 689.874922ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:04.218499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:03.51079Z","time spent":"707.655043ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:38:04.218872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:03.52827Z","time spent":"690.540566ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:38:04.218913Z","caller":"traceutil/trace.go:171","msg":"trace[462890856] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"524.407751ms","start":"2026-02-12T03:38:03.694499Z","end":"2026-02-12T03:38:04.218907Z","steps":["trace[462890856] 'process raft request' (duration: 523.747517ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:04.218952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:03.694462Z","time spent":"524.466964ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:38:06.358623Z","caller":"traceutil/trace.go:171","msg":"trace[85733197] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"128.796068ms","start":"2026-02-12T03:38:06.229812Z","end":"2026-02-12T03:38:06.358608Z","steps":["trace[85733197] 'process raft request' (duration: 128.690983ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:38:06.35871Z","caller":"traceutil/trace.go:171","msg":"trace[1400252791] linearizableReadLoop","detail":"{readStateIndex:503; appliedIndex:503; }","duration":"126.98629ms","start":"2026-02-12T03:38:06.231705Z","end":"2026-02-12T03:38:06.358692Z","steps":["trace[1400252791] 'read index received' (duration: 126.97952ms)","trace[1400252791] 'applied index is now lower than readState.Index' (duration: 5.47µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:38:06.358894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.1734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T03:38:06.358925Z","caller":"traceutil/trace.go:171","msg":"trace[291631758] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:483; }","duration":"127.256554ms","start":"2026-02-12T03:38:06.231661Z","end":"2026-02-12T03:38:06.358918Z","steps":["trace[291631758] 'agreement among raft nodes before linearized reading' (duration: 127.100986ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:38:06.365533Z","caller":"traceutil/trace.go:171","msg":"trace[572128344] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"132.704839ms","start":"2026-02-12T03:38:06.232817Z","end":"2026-02-12T03:38:06.365522Z","steps":["trace[572128344] 'process raft request' (duration: 132.622535ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:38:08.524792Z","caller":"traceutil/trace.go:171","msg":"trace[1423945230] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"143.314419ms","start":"2026-02-12T03:38:08.381459Z","end":"2026-02-12T03:38:08.524773Z","steps":["trace[1423945230] 'process raft request' (duration: 116.730411ms)","trace[1423945230] 'compare' (duration: 26.498454ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:38:08.537682Z","caller":"traceutil/trace.go:171","msg":"trace[306822265] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"155.990392ms","start":"2026-02-12T03:38:08.381676Z","end":"2026-02-12T03:38:08.537667Z","steps":["trace[306822265] 'process raft request' (duration: 155.919518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:11.444855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.130264ms","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-12T03:38:11.444945Z","caller":"traceutil/trace.go:171","msg":"trace[463414170] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:519; }","duration":"632.235329ms","start":"2026-02-12T03:38:10.812694Z","end":"2026-02-12T03:38:11.44493Z","steps":["trace[463414170] 'range keys from in-memory index tree' (duration: 632.113934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:11.445118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.724113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8wj2d\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-12T03:38:11.44517Z","caller":"traceutil/trace.go:171","msg":"trace[317107771] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8wj2d; range_end:; response_count:1; response_revision:519; }","duration":"257.807397ms","start":"2026-02-12T03:38:11.187348Z","end":"2026-02-12T03:38:11.445155Z","steps":["trace[317107771] 'range keys from in-memory index tree' (duration: 257.614508ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:38:11.95939Z","caller":"traceutil/trace.go:171","msg":"trace[1565572848] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"506.062746ms","start":"2026-02-12T03:38:11.453307Z","end":"2026-02-12T03:38:11.95937Z","steps":["trace[1565572848] 'process raft request' (duration: 505.699099ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:11.959482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:11.453294Z","time spent":"506.131048ms","remote":"127.0.0.1:60350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:38:11.95912Z","caller":"traceutil/trace.go:171","msg":"trace[313738404] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"380.039654ms","start":"2026-02-12T03:38:11.579065Z","end":"2026-02-12T03:38:11.959105Z","steps":["trace[313738404] 'read index received' (duration: 379.883527ms)","trace[313738404] 'applied index is now lower than readState.Index' (duration: 155.727µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:38:11.959719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.652123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:38:11.959735Z","caller":"traceutil/trace.go:171","msg":"trace[249592431] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"380.704484ms","start":"2026-02-12T03:38:11.579025Z","end":"2026-02-12T03:38:11.95973Z","steps":["trace[249592431] 'agreement among raft nodes before linearized reading' (duration: 380.625111ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:11.959749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:11.579007Z","time spent":"380.738986ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-12T03:38:12.844513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.086688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T03:38:12.844566Z","caller":"traceutil/trace.go:171","msg":"trace[751473895] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:521; }","duration":"304.194202ms","start":"2026-02-12T03:38:12.540361Z","end":"2026-02-12T03:38:12.844555Z","steps":["trace[751473895] 'range keys from in-memory index tree' (duration: 303.976033ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:12.844592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:12.540348Z","time spent":"304.239635ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T03:38:12.844578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.075957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T03:38:12.844633Z","caller":"traceutil/trace.go:171","msg":"trace[1177816353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"291.160711ms","start":"2026-02-12T03:38:12.553457Z","end":"2026-02-12T03:38:12.844618Z","steps":["trace[1177816353] 'range keys from in-memory index tree' (duration: 290.963342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:12.844842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.435031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T03:38:12.844858Z","caller":"traceutil/trace.go:171","msg":"trace[1561173587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:521; }","duration":"448.472874ms","start":"2026-02-12T03:38:12.39638Z","end":"2026-02-12T03:38:12.844853Z","steps":["trace[1561173587] 'range keys from in-memory index tree' (duration: 448.364728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:12.844871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:12.396367Z","time spent":"448.500394ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-12T03:38:13.615852Z","caller":"traceutil/trace.go:171","msg":"trace[802381924] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"766.781747ms","start":"2026-02-12T03:38:12.849047Z","end":"2026-02-12T03:38:13.615829Z","steps":["trace[802381924] 'process raft request' (duration: 766.653482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:13.616019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:12.849034Z","time spent":"766.882541ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:38:15.376368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000527835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-12T03:38:15.376422Z","caller":"traceutil/trace.go:171","msg":"trace[1404115229] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000595468s","start":"2026-02-12T03:38:13.375814Z","end":"2026-02-12T03:38:15.37641Z","steps":["trace[1404115229] 'agreement among raft nodes before linearized reading' (duration: 2.000524905s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:15.376462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:13.375799Z","time spent":"2.000656551s","remote":"127.0.0.1:60168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T03:38:15.935489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.955425233s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:38:15.935596Z","caller":"traceutil/trace.go:171","msg":"trace[625064532] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:543; }","duration":"2.559765089s","start":"2026-02-12T03:38:13.375819Z","end":"2026-02-12T03:38:15.935585Z","steps":["trace[625064532] 'read index received' (duration: 240.665918ms)","trace[625064532] 'applied index is now lower than readState.Index' (duration: 2.319097251s)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:38:15.935736Z","caller":"traceutil/trace.go:171","msg":"trace[1804508860] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"3.086559617s","start":"2026-02-12T03:38:12.849166Z","end":"2026-02-12T03:38:15.935726Z","steps":["trace[1804508860] 'process raft request' (duration: 1.130846081s)","trace[1804508860] 'compare' (duration: 1.954926952s)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:38:15.935788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:12.849161Z","time spent":"3.086595578s","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:38:15.935889Z","caller":"traceutil/trace.go:171","msg":"trace[911856640] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"3.086686053s","start":"2026-02-12T03:38:12.849198Z","end":"2026-02-12T03:38:15.935884Z","steps":["trace[911856640] 'process raft request' (duration: 3.086354448s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:15.935921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:12.849194Z","time spent":"3.086710164s","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:38:15.997705Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.466630686s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-12T03:38:15.998055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00898292s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:38:15.998096Z","caller":"traceutil/trace.go:171","msg":"trace[1501095513] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:525; }","duration":"2.009060834s","start":"2026-02-12T03:38:13.989021Z","end":"2026-02-12T03:38:15.998082Z","steps":["trace[1501095513] 'agreement among raft nodes before linearized reading' (duration: 2.008914807s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:15.998131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:13.989001Z","time spent":"2.009123377s","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-12T03:38:15.998181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.160282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T03:38:15.998248Z","caller":"traceutil/trace.go:171","msg":"trace[546108776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:525; }","duration":"379.269607ms","start":"2026-02-12T03:38:15.618961Z","end":"2026-02-12T03:38:15.99823Z","steps":["trace[546108776] 'agreement among raft nodes before linearized reading' (duration: 379.023366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:15.998289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:15.618947Z","time spent":"379.33422ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T03:38:15.998329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.523141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:38:15.998348Z","caller":"traceutil/trace.go:171","msg":"trace[1720181254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:525; }","duration":"621.573633ms","start":"2026-02-12T03:38:15.376769Z","end":"2026-02-12T03:38:15.998343Z","steps":["trace[1720181254] 'agreement among raft nodes before linearized reading' (duration: 621.543512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:15.998366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:15.37675Z","time spent":"621.609735ms","remote":"127.0.0.1:60176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T03:38:15.998491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.63723709s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.149\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-12T03:38:15.998508Z","caller":"traceutil/trace.go:171","msg":"trace[1209030810] range","detail":"{range_begin:/registry/masterleases/199.204.45.149; range_end:; response_count:1; response_revision:525; }","duration":"1.637279062s","start":"2026-02-12T03:38:14.361223Z","end":"2026-02-12T03:38:15.998502Z","steps":["trace[1209030810] 'agreement among raft nodes before linearized reading' (duration: 1.63722636s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:15.998526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:14.361208Z","time spent":"1.637314255s","remote":"127.0.0.1:60218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.149\" "} {"level":"info","ts":"2026-02-12T03:38:15.998624Z","caller":"traceutil/trace.go:171","msg":"trace[617984025] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.467619851s","start":"2026-02-12T03:38:14.53099Z","end":"2026-02-12T03:38:15.99861Z","steps":["trace[617984025] 'process raft request' (duration: 1.466855836s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:15.998703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:14.53097Z","time spent":"1.467682073s","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:38:17.770057Z","caller":"traceutil/trace.go:171","msg":"trace[1223338744] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"344.160269ms","start":"2026-02-12T03:38:17.425872Z","end":"2026-02-12T03:38:17.770033Z","steps":["trace[1223338744] 'process raft request' (duration: 287.311966ms)","trace[1223338744] 'compare' (duration: 56.490077ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:38:17.770181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:17.425854Z","time spent":"344.258023ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:38:18.474967Z","caller":"traceutil/trace.go:171","msg":"trace[1832505051] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"532.454862ms","start":"2026-02-12T03:38:17.942493Z","end":"2026-02-12T03:38:18.474948Z","steps":["trace[1832505051] 'process raft request' (duration: 531.606656ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:18.475105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:17.942482Z","time spent":"532.552957ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:38:18.4768Z","caller":"traceutil/trace.go:171","msg":"trace[1463522081] linearizableReadLoop","detail":"{readStateIndex:562; appliedIndex:560; }","duration":"460.498608ms","start":"2026-02-12T03:38:18.016289Z","end":"2026-02-12T03:38:18.476788Z","steps":["trace[1463522081] 'read index received' (duration: 457.820215ms)","trace[1463522081] 'applied index is now lower than readState.Index' (duration: 2.677863ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:38:18.476915Z","caller":"traceutil/trace.go:171","msg":"trace[2109541961] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"533.581188ms","start":"2026-02-12T03:38:17.943328Z","end":"2026-02-12T03:38:18.476909Z","steps":["trace[2109541961] 'process raft request' (duration: 533.399861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:18.476972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:17.94332Z","time spent":"533.60977ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:38:18.477034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.205286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T03:38:18.477065Z","caller":"traceutil/trace.go:171","msg":"trace[215947141] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:540; }","duration":"443.29662ms","start":"2026-02-12T03:38:18.03376Z","end":"2026-02-12T03:38:18.477057Z","steps":["trace[215947141] 'agreement among raft nodes before linearized reading' (duration: 443.153764ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:18.477085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:18.033746Z","time spent":"443.334442ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T03:38:18.477167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.877574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:38:18.477186Z","caller":"traceutil/trace.go:171","msg":"trace[629461151] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:540; }","duration":"460.921315ms","start":"2026-02-12T03:38:18.016259Z","end":"2026-02-12T03:38:18.47718Z","steps":["trace[629461151] 'agreement among raft nodes before linearized reading' (duration: 460.853783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:18.477201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:18.016244Z","time spent":"460.953927ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-12T03:38:18.477213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.576664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8wj2d\" ","response":"range_response_count:1 size:17171"} {"level":"info","ts":"2026-02-12T03:38:18.47723Z","caller":"traceutil/trace.go:171","msg":"trace[378190703] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8wj2d; range_end:; response_count:1; response_revision:540; }","duration":"261.617405ms","start":"2026-02-12T03:38:18.215607Z","end":"2026-02-12T03:38:18.477224Z","steps":["trace[378190703] 'agreement among raft nodes before linearized reading' (duration: 261.553483ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:38:19.683061Z","caller":"traceutil/trace.go:171","msg":"trace[897859169] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"213.538947ms","start":"2026-02-12T03:38:19.469508Z","end":"2026-02-12T03:38:19.683047Z","steps":["trace[897859169] 'process raft request' (duration: 213.480855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:32.954853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.061512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:38:32.954934Z","caller":"traceutil/trace.go:171","msg":"trace[582193429] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"295.722833ms","start":"2026-02-12T03:38:32.659192Z","end":"2026-02-12T03:38:32.954915Z","steps":["trace[582193429] 'process raft request' (duration: 149.520407ms)","trace[582193429] 'compare' (duration: 145.869764ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:38:36.696742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.535861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:38:36.696829Z","caller":"traceutil/trace.go:171","msg":"trace[1587228823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:724; }","duration":"323.661585ms","start":"2026-02-12T03:38:36.37315Z","end":"2026-02-12T03:38:36.696811Z","steps":["trace[1587228823] 'range keys from in-memory index tree' (duration: 323.483519ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:38:36.696866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:38:36.373136Z","time spent":"323.721417ms","remote":"127.0.0.1:60168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T03:38:36.697218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.870345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:38:36.697247Z","caller":"traceutil/trace.go:171","msg":"trace[2100429426] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:724; }","duration":"124.927227ms","start":"2026-02-12T03:38:36.572311Z","end":"2026-02-12T03:38:36.697238Z","steps":["trace[2100429426] 'range keys from in-memory index tree' (duration: 124.73591ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:38:44.527265Z","caller":"traceutil/trace.go:171","msg":"trace[577542964] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"119.409262ms","start":"2026-02-12T03:38:44.407833Z","end":"2026-02-12T03:38:44.527242Z","steps":["trace[577542964] 'process raft request' (duration: 21.211203ms)","trace[577542964] 'compare' (duration: 97.953751ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:04.647859Z","caller":"traceutil/trace.go:171","msg":"trace[1389880442] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"228.80064ms","start":"2026-02-12T03:39:04.41904Z","end":"2026-02-12T03:39:04.647841Z","steps":["trace[1389880442] 'process raft request' (duration: 228.103361ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:05.131556Z","caller":"traceutil/trace.go:171","msg":"trace[724270693] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:842; }","duration":"111.017704ms","start":"2026-02-12T03:39:05.020324Z","end":"2026-02-12T03:39:05.131342Z","steps":["trace[724270693] 'read index received' (duration: 20.579902ms)","trace[724270693] 'applied index is now lower than readState.Index' (duration: 90.436572ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:39:05.131886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.537477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-12T03:39:05.131939Z","caller":"traceutil/trace.go:171","msg":"trace[1734952523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:810; }","duration":"111.64869ms","start":"2026-02-12T03:39:05.020275Z","end":"2026-02-12T03:39:05.131923Z","steps":["trace[1734952523] 'agreement among raft nodes before linearized reading' (duration: 111.358813ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:05.132322Z","caller":"traceutil/trace.go:171","msg":"trace[1320365371] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"190.104188ms","start":"2026-02-12T03:39:04.9422Z","end":"2026-02-12T03:39:05.132304Z","steps":["trace[1320365371] 'process raft request' (duration: 188.991819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:05.298066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.694143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:39:05.298163Z","caller":"traceutil/trace.go:171","msg":"trace[801435425] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"108.289725ms","start":"2026-02-12T03:39:05.189858Z","end":"2026-02-12T03:39:05.298148Z","steps":["trace[801435425] 'read index received' (duration: 21.671µs)","trace[801435425] 'applied index is now lower than readState.Index' (duration: 108.266784ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:05.298219Z","caller":"traceutil/trace.go:171","msg":"trace[115829395] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"162.684442ms","start":"2026-02-12T03:39:05.135514Z","end":"2026-02-12T03:39:05.298198Z","steps":["trace[115829395] 'process raft request' (duration: 38.780293ms)","trace[115829395] 'compare' (duration: 123.493268ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:39:05.298299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.436948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-12T03:39:05.298327Z","caller":"traceutil/trace.go:171","msg":"trace[1971833262] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:811; }","duration":"108.485879ms","start":"2026-02-12T03:39:05.189832Z","end":"2026-02-12T03:39:05.298318Z","steps":["trace[1971833262] 'agreement among raft nodes before linearized reading' (duration: 108.357006ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:07.505106Z","caller":"traceutil/trace.go:171","msg":"trace[1002083571] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"456.808557ms","start":"2026-02-12T03:39:07.048277Z","end":"2026-02-12T03:39:07.505085Z","steps":["trace[1002083571] 'process raft request' (duration: 456.645603ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:07.505974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:07.048266Z","time spent":"457.651739ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:39:07.505721Z","caller":"traceutil/trace.go:171","msg":"trace[27139789] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:848; }","duration":"368.248055ms","start":"2026-02-12T03:39:07.13746Z","end":"2026-02-12T03:39:07.505708Z","steps":["trace[27139789] 'read index received' (duration: 368.240305ms)","trace[27139789] 'applied index is now lower than readState.Index' (duration: 4.47µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:39:07.50586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.382609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:39:07.507664Z","caller":"traceutil/trace.go:171","msg":"trace[425838230] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:814; }","duration":"370.165373ms","start":"2026-02-12T03:39:07.137455Z","end":"2026-02-12T03:39:07.507621Z","steps":["trace[425838230] 'agreement among raft nodes before linearized reading' (duration: 368.297086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:07.508571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:07.137413Z","time spent":"371.141069ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-12T03:39:07.692785Z","caller":"traceutil/trace.go:171","msg":"trace[1770918673] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:848; }","duration":"185.585019ms","start":"2026-02-12T03:39:07.507175Z","end":"2026-02-12T03:39:07.69276Z","steps":["trace[1770918673] 'read index received' (duration: 153.042032ms)","trace[1770918673] 'applied index is now lower than readState.Index' (duration: 32.541697ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:07.692903Z","caller":"traceutil/trace.go:171","msg":"trace[837414965] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"464.074582ms","start":"2026-02-12T03:39:07.228817Z","end":"2026-02-12T03:39:07.692891Z","steps":["trace[837414965] 'process raft request' (duration: 431.37928ms)","trace[837414965] 'compare' (duration: 32.371492ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:39:07.693022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:07.2288Z","time spent":"464.133044ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:39:07.693972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.001961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-12T03:39:07.694285Z","caller":"traceutil/trace.go:171","msg":"trace[2615060] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:816; }","duration":"129.336268ms","start":"2026-02-12T03:39:07.564903Z","end":"2026-02-12T03:39:07.694239Z","steps":["trace[2615060] 'agreement among raft nodes before linearized reading' (duration: 128.804155ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:07.694696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.441328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:39:07.695207Z","caller":"traceutil/trace.go:171","msg":"trace[1637426301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:816; }","duration":"318.965831ms","start":"2026-02-12T03:39:07.376225Z","end":"2026-02-12T03:39:07.695191Z","steps":["trace[1637426301] 'agreement among raft nodes before linearized reading' (duration: 317.041563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:07.695396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.017824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-12T03:39:07.695443Z","caller":"traceutil/trace.go:171","msg":"trace[161284886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"393.082136ms","start":"2026-02-12T03:39:07.302348Z","end":"2026-02-12T03:39:07.695431Z","steps":["trace[161284886] 'agreement among raft nodes before linearized reading' (duration: 390.949063ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:07.695478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:07.302338Z","time spent":"393.133667ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-12T03:39:07.695409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:07.376215Z","time spent":"319.177386ms","remote":"127.0.0.1:60168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T03:39:07.695911Z","caller":"traceutil/trace.go:171","msg":"trace[2110261643] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"183.160429ms","start":"2026-02-12T03:39:07.512735Z","end":"2026-02-12T03:39:07.695895Z","steps":["trace[2110261643] 'process raft request' (duration: 179.982767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:07.695245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.102704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-12T03:39:07.696241Z","caller":"traceutil/trace.go:171","msg":"trace[78452264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:816; }","duration":"344.140441ms","start":"2026-02-12T03:39:07.352086Z","end":"2026-02-12T03:39:07.696227Z","steps":["trace[78452264] 'agreement among raft nodes before linearized reading' (duration: 341.194166ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:07.696282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:07.352076Z","time spent":"344.195893ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T03:39:07.695339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.545571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-02-12T03:39:07.696424Z","caller":"traceutil/trace.go:171","msg":"trace[120170709] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:816; }","duration":"365.653289ms","start":"2026-02-12T03:39:07.330763Z","end":"2026-02-12T03:39:07.696416Z","steps":["trace[120170709] 'agreement among raft nodes before linearized reading' (duration: 362.52777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:07.69646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:07.330751Z","time spent":"365.696131ms","remote":"127.0.0.1:60616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4221,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"info","ts":"2026-02-12T03:39:14.540119Z","caller":"traceutil/trace.go:171","msg":"trace[1736600945] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"130.46414ms","start":"2026-02-12T03:39:14.409631Z","end":"2026-02-12T03:39:14.540095Z","steps":["trace[1736600945] 'process raft request' (duration: 79.395629ms)","trace[1736600945] 'compare' (duration: 50.966899ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:33.376044Z","caller":"traceutil/trace.go:171","msg":"trace[466571582] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"117.080278ms","start":"2026-02-12T03:39:33.258942Z","end":"2026-02-12T03:39:33.376022Z","steps":["trace[466571582] 'process raft request' (duration: 116.952345ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:36.023224Z","caller":"traceutil/trace.go:171","msg":"trace[1222592346] linearizableReadLoop","detail":"{readStateIndex:966; appliedIndex:965; }","duration":"123.364557ms","start":"2026-02-12T03:39:35.899844Z","end":"2026-02-12T03:39:36.023209Z","steps":["trace[1222592346] 'read index received' (duration: 123.250045ms)","trace[1222592346] 'applied index is now lower than readState.Index' (duration: 113.972µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:36.023379Z","caller":"traceutil/trace.go:171","msg":"trace[844313058] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"127.108963ms","start":"2026-02-12T03:39:35.896265Z","end":"2026-02-12T03:39:36.023374Z","steps":["trace[844313058] 'process raft request' (duration: 126.866928ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:36.023552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.704433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-12T03:39:36.023575Z","caller":"traceutil/trace.go:171","msg":"trace[781636763] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:925; }","duration":"123.760764ms","start":"2026-02-12T03:39:35.899809Z","end":"2026-02-12T03:39:36.02357Z","steps":["trace[781636763] 'agreement among raft nodes before linearized reading' (duration: 123.674612ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:36.023664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.694973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T03:39:36.023681Z","caller":"traceutil/trace.go:171","msg":"trace[1423792088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:925; }","duration":"119.733173ms","start":"2026-02-12T03:39:35.903945Z","end":"2026-02-12T03:39:36.023678Z","steps":["trace[1423792088] 'agreement among raft nodes before linearized reading' (duration: 119.691912ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:38.159998Z","caller":"traceutil/trace.go:171","msg":"trace[1079713758] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"131.702391ms","start":"2026-02-12T03:39:38.028284Z","end":"2026-02-12T03:39:38.159986Z","steps":["trace[1079713758] 'process raft request' (duration: 131.61022ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:38.160312Z","caller":"traceutil/trace.go:171","msg":"trace[678916838] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:971; }","duration":"111.850848ms","start":"2026-02-12T03:39:38.048455Z","end":"2026-02-12T03:39:38.160306Z","steps":["trace[678916838] 'read index received' (duration: 111.848058ms)","trace[678916838] 'applied index is now lower than readState.Index' (duration: 2.43µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:39:38.160406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.94068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T03:39:38.160424Z","caller":"traceutil/trace.go:171","msg":"trace[383029628] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:930; }","duration":"112.013672ms","start":"2026-02-12T03:39:38.048403Z","end":"2026-02-12T03:39:38.160417Z","steps":["trace[383029628] 'agreement among raft nodes before linearized reading' (duration: 111.93518ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:38.221887Z","caller":"traceutil/trace.go:171","msg":"trace[1447266796] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"100.938581ms","start":"2026-02-12T03:39:38.120928Z","end":"2026-02-12T03:39:38.221866Z","steps":["trace[1447266796] 'process raft request' (duration: 97.457803ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:38.676003Z","caller":"traceutil/trace.go:171","msg":"trace[1774298452] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"143.281612ms","start":"2026-02-12T03:39:38.532699Z","end":"2026-02-12T03:39:38.67598Z","steps":["trace[1774298452] 'process raft request' (duration: 143.122798ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:41.93205Z","caller":"traceutil/trace.go:171","msg":"trace[640222217] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"130.78657ms","start":"2026-02-12T03:39:41.801058Z","end":"2026-02-12T03:39:41.931844Z","steps":["trace[640222217] 'process raft request' (duration: 130.624107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:42.334614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.683278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T03:39:42.33469Z","caller":"traceutil/trace.go:171","msg":"trace[688492250] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:944; }","duration":"134.808381ms","start":"2026-02-12T03:39:42.199866Z","end":"2026-02-12T03:39:42.334674Z","steps":["trace[688492250] 'count revisions from in-memory index tree' (duration: 134.621077ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:42.335078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.692676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-12T03:39:42.335119Z","caller":"traceutil/trace.go:171","msg":"trace[1881192567] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:944; }","duration":"122.735587ms","start":"2026-02-12T03:39:42.212374Z","end":"2026-02-12T03:39:42.335109Z","steps":["trace[1881192567] 'range keys from in-memory index tree' (duration: 122.554774ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:42.581631Z","caller":"traceutil/trace.go:171","msg":"trace[67473913] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"271.19765ms","start":"2026-02-12T03:39:42.310405Z","end":"2026-02-12T03:39:42.581603Z","steps":["trace[67473913] 'process raft request' (duration: 271.069957ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:42.674021Z","caller":"traceutil/trace.go:171","msg":"trace[1672344894] linearizableReadLoop","detail":"{readStateIndex:989; appliedIndex:987; }","duration":"297.617731ms","start":"2026-02-12T03:39:42.376378Z","end":"2026-02-12T03:39:42.673995Z","steps":["trace[1672344894] 'read index received' (duration: 205.82113ms)","trace[1672344894] 'applied index is now lower than readState.Index' (duration: 91.795231ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:42.674262Z","caller":"traceutil/trace.go:171","msg":"trace[1797925308] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"333.43336ms","start":"2026-02-12T03:39:42.340809Z","end":"2026-02-12T03:39:42.674242Z","steps":["trace[1797925308] 'process raft request' (duration: 304.108614ms)","trace[1797925308] 'compare' (duration: 28.852937ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:39:42.674352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.958957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-12T03:39:42.674393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:42.340789Z","time spent":"333.518451ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:39:42.674419Z","caller":"traceutil/trace.go:171","msg":"trace[1721723839] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:947; }","duration":"298.060258ms","start":"2026-02-12T03:39:42.376341Z","end":"2026-02-12T03:39:42.674402Z","steps":["trace[1721723839] 'agreement among raft nodes before linearized reading' (duration: 297.953576ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:42.674624Z","caller":"traceutil/trace.go:171","msg":"trace[1713703419] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"333.198495ms","start":"2026-02-12T03:39:42.341414Z","end":"2026-02-12T03:39:42.674612Z","steps":["trace[1713703419] 'process raft request' (duration: 332.517082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:42.674709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:42.341407Z","time spent":"333.242087ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:39:42.67471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.798963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-12T03:39:42.674761Z","caller":"traceutil/trace.go:171","msg":"trace[1048552952] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:947; }","duration":"269.881504ms","start":"2026-02-12T03:39:42.404866Z","end":"2026-02-12T03:39:42.674747Z","steps":["trace[1048552952] 'agreement among raft nodes before linearized reading' (duration: 269.743651ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:42.675034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.298394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:39:42.675074Z","caller":"traceutil/trace.go:171","msg":"trace[1049881530] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:947; }","duration":"254.357686ms","start":"2026-02-12T03:39:42.420706Z","end":"2026-02-12T03:39:42.675063Z","steps":["trace[1049881530] 'agreement among raft nodes before linearized reading' (duration: 254.295435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:42.675109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.152549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T03:39:42.675154Z","caller":"traceutil/trace.go:171","msg":"trace[1268222466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:947; }","duration":"270.20569ms","start":"2026-02-12T03:39:42.404933Z","end":"2026-02-12T03:39:42.675138Z","steps":["trace[1268222466] 'agreement among raft nodes before linearized reading' (duration: 270.100708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:42.675441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.584832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2476"} {"level":"info","ts":"2026-02-12T03:39:42.675474Z","caller":"traceutil/trace.go:171","msg":"trace[196899009] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:947; }","duration":"138.643303ms","start":"2026-02-12T03:39:42.536819Z","end":"2026-02-12T03:39:42.675463Z","steps":["trace[196899009] 'agreement among raft nodes before linearized reading' (duration: 138.561672ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:42.877024Z","caller":"traceutil/trace.go:171","msg":"trace[1131772630] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"189.537525ms","start":"2026-02-12T03:39:42.687461Z","end":"2026-02-12T03:39:42.876999Z","steps":["trace[1131772630] 'process raft request' (duration: 185.316304ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:42.877498Z","caller":"traceutil/trace.go:171","msg":"trace[725960313] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"189.225639ms","start":"2026-02-12T03:39:42.688261Z","end":"2026-02-12T03:39:42.877487Z","steps":["trace[725960313] 'process raft request' (duration: 188.686718ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:42.878063Z","caller":"traceutil/trace.go:171","msg":"trace[2004182470] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"188.73032ms","start":"2026-02-12T03:39:42.689311Z","end":"2026-02-12T03:39:42.878041Z","steps":["trace[2004182470] 'process raft request' (duration: 188.134778ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:45.067925Z","caller":"traceutil/trace.go:171","msg":"trace[1398122579] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:997; }","duration":"178.023108ms","start":"2026-02-12T03:39:44.889877Z","end":"2026-02-12T03:39:45.0679Z","steps":["trace[1398122579] 'read index received' (duration: 177.832965ms)","trace[1398122579] 'applied index is now lower than readState.Index' (duration: 189.313µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:45.068576Z","caller":"traceutil/trace.go:171","msg":"trace[1088878408] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"178.967975ms","start":"2026-02-12T03:39:44.889588Z","end":"2026-02-12T03:39:45.068556Z","steps":["trace[1088878408] 'process raft request' (duration: 178.183031ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:45.068578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.67679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-12T03:39:45.07055Z","caller":"traceutil/trace.go:171","msg":"trace[2111984897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:955; }","duration":"180.708289ms","start":"2026-02-12T03:39:44.889831Z","end":"2026-02-12T03:39:45.070539Z","steps":["trace[2111984897] 'agreement among raft nodes before linearized reading' (duration: 178.600229ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:49.48363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.635323ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:39:49.484073Z","caller":"traceutil/trace.go:171","msg":"trace[1652311797] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1009; }","duration":"447.545842ms","start":"2026-02-12T03:39:49.03648Z","end":"2026-02-12T03:39:49.484026Z","steps":["trace[1652311797] 'read index received' (duration: 42.931µs)","trace[1652311797] 'applied index is now lower than readState.Index' (duration: 447.500921ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:49.484756Z","caller":"traceutil/trace.go:171","msg":"trace[1527753939] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"627.392871ms","start":"2026-02-12T03:39:48.857341Z","end":"2026-02-12T03:39:49.484734Z","steps":["trace[1527753939] 'process raft request' (duration: 106.545985ms)","trace[1527753939] 'compare' (duration: 519.243866ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:39:49.486497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:48.857317Z","time spent":"629.095081ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:39:49.485216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.150432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-02-12T03:39:49.487007Z","caller":"traceutil/trace.go:171","msg":"trace[2140574735] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"405.67663ms","start":"2026-02-12T03:39:49.081029Z","end":"2026-02-12T03:39:49.486706Z","steps":["trace[2140574735] 'agreement among raft nodes before linearized reading' (duration: 404.06551ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:49.48707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:49.081018Z","time spent":"406.036608ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-12T03:39:49.485268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.353213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:39:49.487588Z","caller":"traceutil/trace.go:171","msg":"trace[625342753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:967; }","duration":"111.556974ms","start":"2026-02-12T03:39:49.375871Z","end":"2026-02-12T03:39:49.487428Z","steps":["trace[625342753] 'agreement among raft nodes before linearized reading' (duration: 109.370164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:49.485336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.448423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-12T03:39:49.486119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.614909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:39:49.48817Z","caller":"traceutil/trace.go:171","msg":"trace[234294819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:967; }","duration":"451.718167ms","start":"2026-02-12T03:39:49.036436Z","end":"2026-02-12T03:39:49.488154Z","steps":["trace[234294819] 'agreement among raft nodes before linearized reading' (duration: 448.416667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:49.488281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:49.036416Z","time spent":"451.791809ms","remote":"127.0.0.1:60168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T03:39:49.489247Z","caller":"traceutil/trace.go:171","msg":"trace[1946055634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:967; }","duration":"367.377156ms","start":"2026-02-12T03:39:49.121859Z","end":"2026-02-12T03:39:49.489236Z","steps":["trace[1946055634] 'agreement among raft nodes before linearized reading' (duration: 363.425013ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:49.489354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:39:49.121849Z","time spent":"367.460017ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-12T03:39:49.722013Z","caller":"traceutil/trace.go:171","msg":"trace[4670135] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"228.115681ms","start":"2026-02-12T03:39:49.493875Z","end":"2026-02-12T03:39:49.721991Z","steps":["trace[4670135] 'process raft request' (duration: 227.920537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:49.890249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.289673ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-12T03:39:49.890782Z","caller":"traceutil/trace.go:171","msg":"trace[669832995] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1012; }","duration":"279.09618ms","start":"2026-02-12T03:39:49.61164Z","end":"2026-02-12T03:39:49.890737Z","steps":["trace[669832995] 'read index received' (duration: 110.383283ms)","trace[669832995] 'applied index is now lower than readState.Index' (duration: 168.709127ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:39:49.891082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.415426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T03:39:49.891136Z","caller":"traceutil/trace.go:171","msg":"trace[575262680] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:970; }","duration":"279.522397ms","start":"2026-02-12T03:39:49.611601Z","end":"2026-02-12T03:39:49.891124Z","steps":["trace[575262680] 'agreement among raft nodes before linearized reading' (duration: 279.271322ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:39:59.815901Z","caller":"traceutil/trace.go:171","msg":"trace[1607140098] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"121.675669ms","start":"2026-02-12T03:39:59.69419Z","end":"2026-02-12T03:39:59.815866Z","steps":["trace[1607140098] 'read index received' (duration: 121.527986ms)","trace[1607140098] 'applied index is now lower than readState.Index' (duration: 146.823µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:39:59.816003Z","caller":"traceutil/trace.go:171","msg":"trace[2126426508] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"172.398017ms","start":"2026-02-12T03:39:59.643594Z","end":"2026-02-12T03:39:59.815992Z","steps":["trace[2126426508] 'process raft request' (duration: 172.146683ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:59.816118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.677268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-12T03:39:59.816145Z","caller":"traceutil/trace.go:171","msg":"trace[2028921551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:999; }","duration":"110.73976ms","start":"2026-02-12T03:39:59.705399Z","end":"2026-02-12T03:39:59.816139Z","steps":["trace[2028921551] 'agreement among raft nodes before linearized reading' (duration: 110.655888ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:39:59.816196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.104702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-02-12T03:39:59.81621Z","caller":"traceutil/trace.go:171","msg":"trace[1458533086] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:999; }","duration":"142.155563ms","start":"2026-02-12T03:39:59.674049Z","end":"2026-02-12T03:39:59.816205Z","steps":["trace[1458533086] 'agreement among raft nodes before linearized reading' (duration: 142.133052ms)"],"step_count":1}