{"level":"warn","ts":"2026-02-17T06:34:54.993697Z","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-17T06:34:54.994065Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-17T06:34:54.994255Z","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-17T06:34:54.994329Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-02-17T06:34:54.994418Z","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-17T06:34:54.99547Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-02-17T06:34:55.000546Z","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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-17T06:34:55.062515Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"53.437008ms"} {"level":"info","ts":"2026-02-17T06:34:55.075508Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-02-17T06:34:55.075649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T06:34:55.07571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-02-17T06:34:55.075798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T06:34:55.075879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-02-17T06:34:55.075993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-02-17T06:34:55.087488Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T06:34:55.09769Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T06:34:55.107298Z","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-17T06:34:55.112978Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T06:34:55.114977Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T06:34:55.115334Z","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-17T06:34:55.115431Z","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-17T06:34:55.115484Z","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-17T06:34:55.117513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-02-17T06:34:55.117883Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-02-17T06:34:55.154675Z","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-17T06:34:55.161905Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T06:34:55.161941Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T06:34:55.155435Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-02-17T06:34:55.164847Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-02-17T06:34:55.176765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T06:34:55.176788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T06:34:55.176798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-02-17T06:34:55.176878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-02-17T06:34:55.17689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-02-17T06:34:55.176898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-02-17T06:34:55.176952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-02-17T06:34:55.186891Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:34:55.192043Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T06:34:55.192063Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:34:55.192164Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:34:55.192199Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T06:34:55.192211Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T06:34:55.192338Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T06:34:55.192583Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T06:34:55.19266Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T06:34:55.19704Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-02-17T06:34:55.198761Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T06:34:57.902541Z","caller":"traceutil/trace.go:171","msg":"trace[628751841] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"192.013141ms","start":"2026-02-17T06:34:57.710502Z","end":"2026-02-17T06:34:57.902516Z","steps":["trace[628751841] 'process raft request' (duration: 94.753209ms)","trace[628751841] 'compare' (duration: 97.149699ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:34:57.903338Z","caller":"traceutil/trace.go:171","msg":"trace[1481550609] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"126.952556ms","start":"2026-02-17T06:34:57.776373Z","end":"2026-02-17T06:34:57.903325Z","steps":["trace[1481550609] 'process raft request' (duration: 126.907745ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:57.904332Z","caller":"traceutil/trace.go:171","msg":"trace[519485233] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"130.614751ms","start":"2026-02-17T06:34:57.773699Z","end":"2026-02-17T06:34:57.904314Z","steps":["trace[519485233] 'process raft request' (duration: 129.43011ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:57.90444Z","caller":"traceutil/trace.go:171","msg":"trace[806356583] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"130.63243ms","start":"2026-02-17T06:34:57.773797Z","end":"2026-02-17T06:34:57.904429Z","steps":["trace[806356583] 'process raft request' (duration: 129.389579ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:57.904476Z","caller":"traceutil/trace.go:171","msg":"trace[199862799] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"129.4258ms","start":"2026-02-17T06:34:57.775044Z","end":"2026-02-17T06:34:57.904469Z","steps":["trace[199862799] 'process raft request' (duration: 128.166248ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:57.905302Z","caller":"traceutil/trace.go:171","msg":"trace[1890202614] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"129.197184ms","start":"2026-02-17T06:34:57.775296Z","end":"2026-02-17T06:34:57.904493Z","steps":["trace[1890202614] 'process raft request' (duration: 127.937942ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:34:57.905425Z","caller":"traceutil/trace.go:171","msg":"trace[716394363] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"130.076417ms","start":"2026-02-17T06:34:57.775339Z","end":"2026-02-17T06:34:57.905415Z","steps":["trace[716394363] 'process raft request' (duration: 127.917812ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:11.912752Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101153146267537,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:35:13.300781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1479094s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:35:13.30088Z","caller":"traceutil/trace.go:171","msg":"trace[111556117] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:428; }","duration":"1.888281159s","start":"2026-02-17T06:35:11.412584Z","end":"2026-02-17T06:35:13.300865Z","steps":["trace[111556117] 'read index received' (duration: 739.877067ms)","trace[111556117] 'applied index is now lower than readState.Index' (duration: 1.148402942s)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:13.301035Z","caller":"traceutil/trace.go:171","msg":"trace[726695029] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"2.069909716s","start":"2026-02-17T06:35:11.231113Z","end":"2026-02-17T06:35:13.301023Z","steps":["trace[726695029] 'process raft request' (duration: 921.3694ms)","trace[726695029] 'compare' (duration: 1.146822533s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:13.302668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.60621471s","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-17T06:35:13.302698Z","caller":"traceutil/trace.go:171","msg":"trace[1234963097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:414; }","duration":"1.60627964s","start":"2026-02-17T06:35:11.696411Z","end":"2026-02-17T06:35:13.302691Z","steps":["trace[1234963097] 'agreement among raft nodes before linearized reading' (duration: 1.606205209s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:13.30272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:11.696395Z","time spent":"1.606320302s","remote":"127.0.0.1:35160","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-17T06:35:13.302841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.890259379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T06:35:13.302863Z","caller":"traceutil/trace.go:171","msg":"trace[820139478] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:414; }","duration":"1.890308861s","start":"2026-02-17T06:35:11.412549Z","end":"2026-02-17T06:35:13.302858Z","steps":["trace[820139478] 'agreement among raft nodes before linearized reading' (duration: 1.89027225s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:13.30288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:11.412515Z","time spent":"1.890360932s","remote":"127.0.0.1:35160","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-17T06:35:13.302956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.025925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:13.302977Z","caller":"traceutil/trace.go:171","msg":"trace[1530818841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:414; }","duration":"927.101857ms","start":"2026-02-17T06:35:12.37587Z","end":"2026-02-17T06:35:13.302972Z","steps":["trace[1530818841] 'agreement among raft nodes before linearized reading' (duration: 927.072706ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:13.302993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:12.375852Z","time spent":"927.136387ms","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:35:13.303077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170385511s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-17T06:35:13.303098Z","caller":"traceutil/trace.go:171","msg":"trace[556607782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:414; }","duration":"1.170446273s","start":"2026-02-17T06:35:12.132647Z","end":"2026-02-17T06:35:13.303093Z","steps":["trace[556607782] 'agreement among raft nodes before linearized reading' (duration: 1.170413292s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:13.303114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:12.132629Z","time spent":"1.170481714s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T06:35:13.303193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.606455355s","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-17T06:35:13.303212Z","caller":"traceutil/trace.go:171","msg":"trace[486922563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"1.606486197s","start":"2026-02-17T06:35:11.696722Z","end":"2026-02-17T06:35:13.303208Z","steps":["trace[486922563] 'agreement among raft nodes before linearized reading' (duration: 1.606454306s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:13.303228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:11.696716Z","time spent":"1.606508467s","remote":"127.0.0.1:35160","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-17T06:35:13.301091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:11.231096Z","time spent":"2.069971348s","remote":"127.0.0.1:35388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3656,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T06:35:25.595861Z","caller":"traceutil/trace.go:171","msg":"trace[1736658439] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"129.861498ms","start":"2026-02-17T06:35:25.465984Z","end":"2026-02-17T06:35:25.595846Z","steps":["trace[1736658439] 'process raft request' (duration: 126.038273ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:28.039906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.240589ms","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-17T06:35:28.039977Z","caller":"traceutil/trace.go:171","msg":"trace[949415544] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"435.344731ms","start":"2026-02-17T06:35:27.60462Z","end":"2026-02-17T06:35:28.039965Z","steps":["trace[949415544] 'range keys from in-memory index tree' (duration: 435.178348ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:28.04Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:27.604608Z","time spent":"435.388353ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T06:35:28.040132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.691462ms","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-17T06:35:28.040155Z","caller":"traceutil/trace.go:171","msg":"trace[2097344098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"429.724943ms","start":"2026-02-17T06:35:27.610426Z","end":"2026-02-17T06:35:28.040151Z","steps":["trace[2097344098] 'range keys from in-memory index tree' (duration: 429.659681ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:28.040169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:27.610421Z","time spent":"429.744653ms","remote":"127.0.0.1:35160","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-17T06:35:28.040254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.738703ms","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-17T06:35:28.040279Z","caller":"traceutil/trace.go:171","msg":"trace[1474992962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:513; }","duration":"429.778674ms","start":"2026-02-17T06:35:27.610489Z","end":"2026-02-17T06:35:28.040268Z","steps":["trace[1474992962] 'range keys from in-memory index tree' (duration: 429.685082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:28.040295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:27.610476Z","time spent":"429.816055ms","remote":"127.0.0.1:35160","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-17T06:35:28.452199Z","caller":"traceutil/trace.go:171","msg":"trace[1406404595] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"408.879438ms","start":"2026-02-17T06:35:28.0433Z","end":"2026-02-17T06:35:28.45218Z","steps":["trace[1406404595] 'process raft request' (duration: 408.776246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:28.452407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:28.043288Z","time spent":"408.95805ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:35:29.053939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.616116ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:35:29.054036Z","caller":"traceutil/trace.go:171","msg":"trace[1219829960] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.009657995s","start":"2026-02-17T06:35:28.044368Z","end":"2026-02-17T06:35:29.054026Z","steps":["trace[1219829960] 'process raft request' (duration: 1.009626034s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.054069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:28.044363Z","time spent":"1.009691086s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:29.054223Z","caller":"traceutil/trace.go:171","msg":"trace[290721128] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.010381213s","start":"2026-02-17T06:35:28.043835Z","end":"2026-02-17T06:35:29.054217Z","steps":["trace[290721128] 'process raft request' (duration: 583.435669ms)","trace[290721128] 'compare' (duration: 426.531964ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:29.054248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:28.043829Z","time spent":"1.010406134s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:29.492309Z","caller":"traceutil/trace.go:171","msg":"trace[1141587839] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"417.422259ms","start":"2026-02-17T06:35:29.074868Z","end":"2026-02-17T06:35:29.49229Z","steps":["trace[1141587839] 'read index received' (duration: 417.253765ms)","trace[1141587839] 'applied index is now lower than readState.Index' (duration: 167.604µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:29.492544Z","caller":"traceutil/trace.go:171","msg":"trace[233555335] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"935.134165ms","start":"2026-02-17T06:35:28.557395Z","end":"2026-02-17T06:35:29.49253Z","steps":["trace[233555335] 'process raft request' (duration: 934.774316ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.492635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:28.557377Z","time spent":"935.192966ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:35:29.492815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.940952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T06:35:29.492847Z","caller":"traceutil/trace.go:171","msg":"trace[1554887763] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:517; }","duration":"417.992112ms","start":"2026-02-17T06:35:29.074844Z","end":"2026-02-17T06:35:29.492836Z","steps":["trace[1554887763] 'agreement among raft nodes before linearized reading' (duration: 417.932031ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.492873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:29.074832Z","time spent":"418.035334ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-02-17T06:35:29.492998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.133719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:29.493025Z","caller":"traceutil/trace.go:171","msg":"trace[1220580797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:517; }","duration":"357.178351ms","start":"2026-02-17T06:35:29.135836Z","end":"2026-02-17T06:35:29.493014Z","steps":["trace[1220580797] 'agreement among raft nodes before linearized reading' (duration: 357.14391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:29.49305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:29.135823Z","time spent":"357.221142ms","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:35:29.656617Z","caller":"traceutil/trace.go:171","msg":"trace[1809847818] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"158.723499ms","start":"2026-02-17T06:35:29.497875Z","end":"2026-02-17T06:35:29.656598Z","steps":["trace[1809847818] 'process raft request' (duration: 158.613286ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:31.873133Z","caller":"traceutil/trace.go:171","msg":"trace[1125427709] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"207.781841ms","start":"2026-02-17T06:35:31.665332Z","end":"2026-02-17T06:35:31.873114Z","steps":["trace[1125427709] 'process raft request' (duration: 207.672168ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:31.87582Z","caller":"traceutil/trace.go:171","msg":"trace[104079617] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"151.645995ms","start":"2026-02-17T06:35:31.724166Z","end":"2026-02-17T06:35:31.875812Z","steps":["trace[104079617] 'process raft request' (duration: 150.182888ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:34.126282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.696087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T06:35:34.126342Z","caller":"traceutil/trace.go:171","msg":"trace[1503556441] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:530; }","duration":"249.795489ms","start":"2026-02-17T06:35:33.876531Z","end":"2026-02-17T06:35:34.126327Z","steps":["trace[1503556441] 'range keys from in-memory index tree' (duration: 249.607375ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:34.464976Z","caller":"traceutil/trace.go:171","msg":"trace[861068517] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"318.582958ms","start":"2026-02-17T06:35:34.146337Z","end":"2026-02-17T06:35:34.46492Z","steps":["trace[861068517] 'process raft request' (duration: 318.431604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:34.465171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:34.146311Z","time spent":"318.765673ms","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:34.471307Z","caller":"traceutil/trace.go:171","msg":"trace[1425466519] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:551; }","duration":"168.799059ms","start":"2026-02-17T06:35:34.302498Z","end":"2026-02-17T06:35:34.471297Z","steps":["trace[1425466519] 'read index received' (duration: 162.220297ms)","trace[1425466519] 'applied index is now lower than readState.Index' (duration: 6.578042ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:34.471521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.010404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:34.471544Z","caller":"traceutil/trace.go:171","msg":"trace[1837156746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"169.077666ms","start":"2026-02-17T06:35:34.30246Z","end":"2026-02-17T06:35:34.471537Z","steps":["trace[1837156746] 'agreement among raft nodes before linearized reading' (duration: 169.024095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:36.66742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.023268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:36.667487Z","caller":"traceutil/trace.go:171","msg":"trace[884684724] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:547; }","duration":"355.208743ms","start":"2026-02-17T06:35:36.312265Z","end":"2026-02-17T06:35:36.667473Z","steps":["trace[884684724] 'range keys from in-memory index tree' (duration: 354.986777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:36.667519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:36.312256Z","time spent":"355.255404ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-17T06:35:36.667786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.348266ms","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-17T06:35:36.667809Z","caller":"traceutil/trace.go:171","msg":"trace[2112425593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:547; }","duration":"172.398998ms","start":"2026-02-17T06:35:36.495402Z","end":"2026-02-17T06:35:36.667801Z","steps":["trace[2112425593] 'range keys from in-memory index tree' (duration: 172.238194ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:39.69019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.595325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:35:39.690519Z","caller":"traceutil/trace.go:171","msg":"trace[2093160551] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"194.017322ms","start":"2026-02-17T06:35:39.496479Z","end":"2026-02-17T06:35:39.690497Z","steps":["trace[2093160551] 'process raft request' (duration: 61.699974ms)","trace[2093160551] 'compare' (duration: 130.498203ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:41.586999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.44397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:41.587124Z","caller":"traceutil/trace.go:171","msg":"trace[1980668051] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:620; }","duration":"183.617744ms","start":"2026-02-17T06:35:41.403488Z","end":"2026-02-17T06:35:41.587105Z","steps":["trace[1980668051] 'range keys from in-memory index tree' (duration: 183.40708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:41.587468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.802114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:41.587508Z","caller":"traceutil/trace.go:171","msg":"trace[763128151] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:620; }","duration":"184.889576ms","start":"2026-02-17T06:35:41.402606Z","end":"2026-02-17T06:35:41.587496Z","steps":["trace[763128151] 'range keys from in-memory index tree' (duration: 184.755663ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:41.587651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.607219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:41.587685Z","caller":"traceutil/trace.go:171","msg":"trace[422503782] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:620; }","duration":"184.65142ms","start":"2026-02-17T06:35:41.403025Z","end":"2026-02-17T06:35:41.587676Z","steps":["trace[422503782] 'count revisions from in-memory index tree' (duration: 184.386563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:41.58798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.353603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:35:41.588044Z","caller":"traceutil/trace.go:171","msg":"trace[612591942] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"161.56816ms","start":"2026-02-17T06:35:41.426463Z","end":"2026-02-17T06:35:41.588031Z","steps":["trace[612591942] 'process raft request' (duration: 60.117995ms)","trace[612591942] 'compare' (duration: 100.381139ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:41.620284Z","caller":"traceutil/trace.go:171","msg":"trace[1853072766] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"189.584433ms","start":"2026-02-17T06:35:41.430683Z","end":"2026-02-17T06:35:41.620267Z","steps":["trace[1853072766] 'process raft request' (duration: 189.48693ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:41.870713Z","caller":"traceutil/trace.go:171","msg":"trace[608874052] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"177.293718ms","start":"2026-02-17T06:35:41.693398Z","end":"2026-02-17T06:35:41.870691Z","steps":["trace[608874052] 'process raft request' (duration: 167.136177ms)","trace[608874052] 'compare' (duration: 10.073849ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:42.052455Z","caller":"traceutil/trace.go:171","msg":"trace[276677013] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"357.595311ms","start":"2026-02-17T06:35:41.69483Z","end":"2026-02-17T06:35:42.052425Z","steps":["trace[276677013] 'process raft request' (duration: 329.485277ms)","trace[276677013] 'compare' (duration: 27.673273ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:42.053578Z","caller":"traceutil/trace.go:171","msg":"trace[788159815] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:645; }","duration":"328.016001ms","start":"2026-02-17T06:35:41.725546Z","end":"2026-02-17T06:35:42.053562Z","steps":["trace[788159815] 'read index received' (duration: 135.021375ms)","trace[788159815] 'applied index is now lower than readState.Index' (duration: 192.994076ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:42.05369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.120233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.055552Z","caller":"traceutil/trace.go:171","msg":"trace[1243753628] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:628; }","duration":"330.01721ms","start":"2026-02-17T06:35:41.72552Z","end":"2026-02-17T06:35:42.055537Z","steps":["trace[1243753628] 'agreement among raft nodes before linearized reading' (duration: 328.105993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.055581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.725508Z","time spent":"330.062632ms","remote":"127.0.0.1:60532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "} {"level":"info","ts":"2026-02-17T06:35:42.053871Z","caller":"traceutil/trace.go:171","msg":"trace[416788466] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"358.260287ms","start":"2026-02-17T06:35:41.695604Z","end":"2026-02-17T06:35:42.053864Z","steps":["trace[416788466] 'process raft request' (duration: 356.534585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.057057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.695596Z","time spent":"360.37054ms","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3834,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:42.053953Z","caller":"traceutil/trace.go:171","msg":"trace[1958883530] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"343.402631ms","start":"2026-02-17T06:35:41.710544Z","end":"2026-02-17T06:35:42.053947Z","steps":["trace[1958883530] 'process raft request' (duration: 342.945109ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.060193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.710526Z","time spent":"349.616295ms","remote":"127.0.0.1:35076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4268,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:42.053968Z","caller":"traceutil/trace.go:171","msg":"trace[1439295823] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"270.219123ms","start":"2026-02-17T06:35:41.783745Z","end":"2026-02-17T06:35:42.053964Z","steps":["trace[1439295823] 'process raft request' (duration: 269.780932ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.065708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.694808Z","time spent":"360.637867ms","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3834,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:35:42.095281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.423093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.095387Z","caller":"traceutil/trace.go:171","msg":"trace[1866383676] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:630; }","duration":"369.605048ms","start":"2026-02-17T06:35:41.725745Z","end":"2026-02-17T06:35:42.09535Z","steps":["trace[1866383676] 'agreement among raft nodes before linearized reading' (duration: 369.378432ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.095525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.725741Z","time spent":"369.773872ms","remote":"127.0.0.1:60532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-17T06:35:42.095522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.958708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.095715Z","caller":"traceutil/trace.go:171","msg":"trace[1704986297] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:630; }","duration":"187.181843ms","start":"2026-02-17T06:35:41.90852Z","end":"2026-02-17T06:35:42.095702Z","steps":["trace[1704986297] 'agreement among raft nodes before linearized reading' (duration: 186.785093ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:42.095983Z","caller":"traceutil/trace.go:171","msg":"trace[847547973] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"219.230284ms","start":"2026-02-17T06:35:41.876746Z","end":"2026-02-17T06:35:42.095976Z","steps":["trace[847547973] 'process raft request' (duration: 218.245629ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.096122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.068275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-8q8mm\" ","response":"range_response_count:1 size:3813"} {"level":"info","ts":"2026-02-17T06:35:42.096155Z","caller":"traceutil/trace.go:171","msg":"trace[153581224] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-8q8mm; range_end:; response_count:1; response_revision:630; }","duration":"220.125456ms","start":"2026-02-17T06:35:41.876024Z","end":"2026-02-17T06:35:42.09615Z","steps":["trace[153581224] 'agreement among raft nodes before linearized reading' (duration: 219.970192ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:42.096331Z","caller":"traceutil/trace.go:171","msg":"trace[227303778] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"126.028462ms","start":"2026-02-17T06:35:41.970296Z","end":"2026-02-17T06:35:42.096325Z","steps":["trace[227303778] 'process raft request' (duration: 124.780741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.096496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.048347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.096533Z","caller":"traceutil/trace.go:171","msg":"trace[516784107] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:630; }","duration":"178.098198ms","start":"2026-02-17T06:35:41.91843Z","end":"2026-02-17T06:35:42.096528Z","steps":["trace[516784107] 'agreement among raft nodes before linearized reading' (duration: 178.048067ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.096681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.398636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.096718Z","caller":"traceutil/trace.go:171","msg":"trace[133967429] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:630; }","duration":"178.449367ms","start":"2026-02-17T06:35:41.918264Z","end":"2026-02-17T06:35:42.096713Z","steps":["trace[133967429] 'agreement among raft nodes before linearized reading' (duration: 178.398405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.096845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.882868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.096999Z","caller":"traceutil/trace.go:171","msg":"trace[1714463952] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:630; }","duration":"179.055362ms","start":"2026-02-17T06:35:41.917938Z","end":"2026-02-17T06:35:42.096993Z","steps":["trace[1714463952] 'agreement among raft nodes before linearized reading' (duration: 178.892278ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.095962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.763166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.097251Z","caller":"traceutil/trace.go:171","msg":"trace[832688476] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:630; }","duration":"193.084389ms","start":"2026-02-17T06:35:41.90416Z","end":"2026-02-17T06:35:42.097244Z","steps":["trace[832688476] 'agreement among raft nodes before linearized reading' (duration: 191.782767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.097419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.748319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.097444Z","caller":"traceutil/trace.go:171","msg":"trace[1104290722] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:630; }","duration":"343.781701ms","start":"2026-02-17T06:35:41.753656Z","end":"2026-02-17T06:35:42.097438Z","steps":["trace[1104290722] 'agreement among raft nodes before linearized reading' (duration: 343.536535ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.097943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.753654Z","time spent":"344.280293ms","remote":"127.0.0.1:60536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-17T06:35:42.098097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.440027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.098117Z","caller":"traceutil/trace.go:171","msg":"trace[2107302838] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:630; }","duration":"344.467257ms","start":"2026-02-17T06:35:41.753645Z","end":"2026-02-17T06:35:42.098112Z","steps":["trace[2107302838] 'agreement among raft nodes before linearized reading' (duration: 344.435107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.098249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.753643Z","time spent":"344.597551ms","remote":"127.0.0.1:60536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-02-17T06:35:42.098377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.737044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.098405Z","caller":"traceutil/trace.go:171","msg":"trace[1526172049] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:630; }","duration":"344.785125ms","start":"2026-02-17T06:35:41.753613Z","end":"2026-02-17T06:35:42.098398Z","steps":["trace[1526172049] 'agreement among raft nodes before linearized reading' (duration: 344.747064ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.098547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.753602Z","time spent":"344.935609ms","remote":"127.0.0.1:60536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-17T06:35:42.099642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.122361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:42.09967Z","caller":"traceutil/trace.go:171","msg":"trace[1007140362] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:630; }","duration":"372.181442ms","start":"2026-02-17T06:35:41.727482Z","end":"2026-02-17T06:35:42.099663Z","steps":["trace[1007140362] 'agreement among raft nodes before linearized reading' (duration: 372.11895ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:42.100567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:41.727475Z","time spent":"372.310265ms","remote":"127.0.0.1:60532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "} {"level":"info","ts":"2026-02-17T06:35:42.446907Z","caller":"traceutil/trace.go:171","msg":"trace[204660287] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"170.598143ms","start":"2026-02-17T06:35:42.276291Z","end":"2026-02-17T06:35:42.446889Z","steps":["trace[204660287] 'read index received' (duration: 170.45572ms)","trace[204660287] 'applied index is now lower than readState.Index' (duration: 141.803µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:42.447048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.739107ms","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-17T06:35:42.447069Z","caller":"traceutil/trace.go:171","msg":"trace[1253902577] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"170.803488ms","start":"2026-02-17T06:35:42.276259Z","end":"2026-02-17T06:35:42.447062Z","steps":["trace[1253902577] 'agreement among raft nodes before linearized reading' (duration: 170.694936ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:42.447247Z","caller":"traceutil/trace.go:171","msg":"trace[1902861990] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"179.600806ms","start":"2026-02-17T06:35:42.267638Z","end":"2026-02-17T06:35:42.447239Z","steps":["trace[1902861990] 'process raft request' (duration: 179.147645ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:48.551098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090006518s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:35:48.551392Z","caller":"traceutil/trace.go:171","msg":"trace[550429604] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:699; }","duration":"407.287218ms","start":"2026-02-17T06:35:48.144086Z","end":"2026-02-17T06:35:48.551373Z","steps":["trace[550429604] 'read index received' (duration: 96.929674ms)","trace[550429604] 'applied index is now lower than readState.Index' (duration: 310.356774ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:48.551595Z","caller":"traceutil/trace.go:171","msg":"trace[826923025] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"1.319513576s","start":"2026-02-17T06:35:47.232066Z","end":"2026-02-17T06:35:48.55158Z","steps":["trace[826923025] 'process raft request' (duration: 228.957574ms)","trace[826923025] 'compare' (duration: 1.089580677s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:48.55166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:47.22934Z","time spent":"1.322284785s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:48.551856Z","caller":"traceutil/trace.go:171","msg":"trace[627384173] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"1.319718051s","start":"2026-02-17T06:35:47.232122Z","end":"2026-02-17T06:35:48.55184Z","steps":["trace[627384173] 'process raft request' (duration: 1.319144437s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:48.551944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:47.232116Z","time spent":"1.319771672s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:48.552196Z","caller":"traceutil/trace.go:171","msg":"trace[1267438157] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"1.318574483s","start":"2026-02-17T06:35:47.233607Z","end":"2026-02-17T06:35:48.552182Z","steps":["trace[1267438157] 'process raft request' (duration: 1.317725961s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:48.552366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:47.233601Z","time spent":"1.318628965s","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4829,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:35:48.552632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.548159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:48.552674Z","caller":"traceutil/trace.go:171","msg":"trace[1829728535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:678; }","duration":"408.614801ms","start":"2026-02-17T06:35:48.144043Z","end":"2026-02-17T06:35:48.552658Z","steps":["trace[1829728535] 'agreement among raft nodes before linearized reading' (duration: 408.55325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:48.552709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:48.14401Z","time spent":"408.691593ms","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:35:49.009932Z","caller":"traceutil/trace.go:171","msg":"trace[971648329] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"442.319724ms","start":"2026-02-17T06:35:48.567587Z","end":"2026-02-17T06:35:49.009907Z","steps":["trace[971648329] 'process raft request' (duration: 442.184341ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:49.010031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:48.567578Z","time spent":"442.401086ms","remote":"127.0.0.1:35176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:49.018372Z","caller":"traceutil/trace.go:171","msg":"trace[1858570189] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"450.571617ms","start":"2026-02-17T06:35:48.567785Z","end":"2026-02-17T06:35:49.018356Z","steps":["trace[1858570189] 'process raft request' (duration: 450.414934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:49.01847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:48.56778Z","time spent":"450.636979ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:49.018556Z","caller":"traceutil/trace.go:171","msg":"trace[397842487] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"450.67517ms","start":"2026-02-17T06:35:48.567876Z","end":"2026-02-17T06:35:49.018551Z","steps":["trace[397842487] 'process raft request' (duration: 450.419734ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:49.01858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:48.567872Z","time spent":"450.693511ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":900,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:49.018713Z","caller":"traceutil/trace.go:171","msg":"trace[258199421] linearizableReadLoop","detail":"{readStateIndex:705; appliedIndex:703; }","duration":"446.764043ms","start":"2026-02-17T06:35:48.57187Z","end":"2026-02-17T06:35:49.018634Z","steps":["trace[258199421] 'read index received' (duration: 438.555801ms)","trace[258199421] 'applied index is now lower than readState.Index' (duration: 8.207322ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:49.018972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.217118ms","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-17T06:35:49.018994Z","caller":"traceutil/trace.go:171","msg":"trace[484555166] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:682; }","duration":"205.309721ms","start":"2026-02-17T06:35:48.813677Z","end":"2026-02-17T06:35:49.018986Z","steps":["trace[484555166] 'agreement among raft nodes before linearized reading' (duration: 205.212339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:49.019048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.160623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-8q8mm\" ","response":"range_response_count:1 size:4696"} {"level":"info","ts":"2026-02-17T06:35:49.019084Z","caller":"traceutil/trace.go:171","msg":"trace[1597615494] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-8q8mm; range_end:; response_count:1; response_revision:682; }","duration":"447.231885ms","start":"2026-02-17T06:35:48.571843Z","end":"2026-02-17T06:35:49.019074Z","steps":["trace[1597615494] 'agreement among raft nodes before linearized reading' (duration: 447.086782ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:49.019091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.865731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T06:35:49.019108Z","caller":"traceutil/trace.go:171","msg":"trace[760963010] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:682; }","duration":"147.918093ms","start":"2026-02-17T06:35:48.871185Z","end":"2026-02-17T06:35:49.019103Z","steps":["trace[760963010] 'agreement among raft nodes before linearized reading' (duration: 147.865312ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:49.019114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:48.571836Z","time spent":"447.269786ms","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4719,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-8q8mm\" "} {"level":"info","ts":"2026-02-17T06:35:49.019238Z","caller":"traceutil/trace.go:171","msg":"trace[1077182475] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"447.145943ms","start":"2026-02-17T06:35:48.572086Z","end":"2026-02-17T06:35:49.019231Z","steps":["trace[1077182475] 'process raft request' (duration: 446.240161ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:49.019305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:48.572079Z","time spent":"447.170583ms","remote":"127.0.0.1:35388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3866,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:57.031041Z","caller":"traceutil/trace.go:171","msg":"trace[1489322566] linearizableReadLoop","detail":"{readStateIndex:751; appliedIndex:750; }","duration":"109.665448ms","start":"2026-02-17T06:35:56.92133Z","end":"2026-02-17T06:35:57.030995Z","steps":["trace[1489322566] 'read index received' (duration: 13.045192ms)","trace[1489322566] 'applied index is now lower than readState.Index' (duration: 96.619366ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:57.031221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.866693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T06:35:57.031259Z","caller":"traceutil/trace.go:171","msg":"trace[936776437] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:725; }","duration":"109.951785ms","start":"2026-02-17T06:35:56.921299Z","end":"2026-02-17T06:35:57.03125Z","steps":["trace[936776437] 'agreement among raft nodes before linearized reading' (duration: 109.805242ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:35:57.031613Z","caller":"traceutil/trace.go:171","msg":"trace[1014726562] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"376.603341ms","start":"2026-02-17T06:35:56.654997Z","end":"2026-02-17T06:35:57.0316Z","steps":["trace[1014726562] 'process raft request' (duration: 279.429781ms)","trace[1014726562] 'compare' (duration: 96.491033ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:57.031701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:56.654982Z","time spent":"376.665372ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:57.228336Z","caller":"traceutil/trace.go:171","msg":"trace[850187956] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:751; }","duration":"170.737016ms","start":"2026-02-17T06:35:57.05758Z","end":"2026-02-17T06:35:57.228317Z","steps":["trace[850187956] 'read index received' (duration: 104.86274ms)","trace[850187956] 'applied index is now lower than readState.Index' (duration: 65.873656ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:35:57.228467Z","caller":"traceutil/trace.go:171","msg":"trace[1807341399] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"175.667519ms","start":"2026-02-17T06:35:57.052791Z","end":"2026-02-17T06:35:57.228459Z","steps":["trace[1807341399] 'process raft request' (duration: 109.70946ms)","trace[1807341399] 'compare' (duration: 65.710393ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:57.228652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.556446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-17T06:35:57.228697Z","caller":"traceutil/trace.go:171","msg":"trace[116487684] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:726; }","duration":"139.629229ms","start":"2026-02-17T06:35:57.089056Z","end":"2026-02-17T06:35:57.228686Z","steps":["trace[116487684] 'agreement among raft nodes before linearized reading' (duration: 139.513706ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:57.228814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.219028ms","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-17T06:35:57.228839Z","caller":"traceutil/trace.go:171","msg":"trace[344320215] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:726; }","duration":"171.27635ms","start":"2026-02-17T06:35:57.057556Z","end":"2026-02-17T06:35:57.228832Z","steps":["trace[344320215] 'agreement among raft nodes before linearized reading' (duration: 171.177268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:58.450071Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.218504162s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-17T06:35:58.554455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.394014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:35:58.554594Z","caller":"traceutil/trace.go:171","msg":"trace[1355668782] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:752; }","duration":"417.254524ms","start":"2026-02-17T06:35:58.137328Z","end":"2026-02-17T06:35:58.554582Z","steps":["trace[1355668782] 'read index received' (duration: 315.685226ms)","trace[1355668782] 'applied index is now lower than readState.Index' (duration: 101.568408ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:58.554634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.322655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:35:58.55465Z","caller":"traceutil/trace.go:171","msg":"trace[1407362303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:728; }","duration":"417.365336ms","start":"2026-02-17T06:35:58.137279Z","end":"2026-02-17T06:35:58.554644Z","steps":["trace[1407362303] 'agreement among raft nodes before linearized reading' (duration: 417.336276ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:58.55467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:58.137262Z","time spent":"417.402827ms","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:35:58.554675Z","caller":"traceutil/trace.go:171","msg":"trace[1716112983] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"1.323147337s","start":"2026-02-17T06:35:57.231508Z","end":"2026-02-17T06:35:58.554655Z","steps":["trace[1716112983] 'process raft request' (duration: 1.221496386s)","trace[1716112983] 'compare' (duration: 99.901337ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:58.554778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:57.231492Z","time spent":"1.323226878s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:58.554794Z","caller":"traceutil/trace.go:171","msg":"trace[164268916] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"1.322773417s","start":"2026-02-17T06:35:57.232013Z","end":"2026-02-17T06:35:58.554787Z","steps":["trace[164268916] 'process raft request' (duration: 1.32251452s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:58.554833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:57.231999Z","time spent":"1.322812568s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:35:59.092748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.134335ms","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-17T06:35:59.092799Z","caller":"traceutil/trace.go:171","msg":"trace[1872317200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:728; }","duration":"437.218988ms","start":"2026-02-17T06:35:58.655568Z","end":"2026-02-17T06:35:59.092787Z","steps":["trace[1872317200] 'range keys from in-memory index tree' (duration: 437.052673ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:59.092822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:58.655554Z","time spent":"437.263259ms","remote":"127.0.0.1:35160","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":"info","ts":"2026-02-17T06:35:59.630365Z","caller":"traceutil/trace.go:171","msg":"trace[1282016973] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"534.458189ms","start":"2026-02-17T06:35:59.095892Z","end":"2026-02-17T06:35:59.63035Z","steps":["trace[1282016973] 'process raft request' (duration: 534.334036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:59.630451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:59.095883Z","time spent":"534.522651ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:59.630507Z","caller":"traceutil/trace.go:171","msg":"trace[1969693262] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"533.664959ms","start":"2026-02-17T06:35:59.096832Z","end":"2026-02-17T06:35:59.630497Z","steps":["trace[1969693262] 'process raft request' (duration: 533.487615ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:59.630541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:59.096826Z","time spent":"533.696841ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:35:59.912013Z","caller":"traceutil/trace.go:171","msg":"trace[2080734318] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:755; }","duration":"679.923912ms","start":"2026-02-17T06:35:59.232066Z","end":"2026-02-17T06:35:59.91199Z","steps":["trace[2080734318] 'read index received' (duration: 398.171153ms)","trace[2080734318] 'applied index is now lower than readState.Index' (duration: 281.751579ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:59.912194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.110666ms","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-17T06:35:59.912229Z","caller":"traceutil/trace.go:171","msg":"trace[253657695] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:731; }","duration":"680.175027ms","start":"2026-02-17T06:35:59.232045Z","end":"2026-02-17T06:35:59.91222Z","steps":["trace[253657695] 'agreement among raft nodes before linearized reading' (duration: 680.025754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:35:59.912262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:59.232033Z","time spent":"680.221329ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-17T06:35:59.912442Z","caller":"traceutil/trace.go:171","msg":"trace[1837588818] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"703.438673ms","start":"2026-02-17T06:35:59.208992Z","end":"2026-02-17T06:35:59.912431Z","steps":["trace[1837588818] 'process raft request' (duration: 618.442574ms)","trace[1837588818] 'compare' (duration: 84.202939ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:35:59.91252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:35:59.20898Z","time spent":"703.493014ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:00.987425Z","caller":"traceutil/trace.go:171","msg":"trace[1369552863] linearizableReadLoop","detail":"{readStateIndex:762; appliedIndex:761; }","duration":"261.58821ms","start":"2026-02-17T06:36:00.725819Z","end":"2026-02-17T06:36:00.987407Z","steps":["trace[1369552863] 'read index received' (duration: 261.446187ms)","trace[1369552863] 'applied index is now lower than readState.Index' (duration: 141.293µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:00.987545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.693923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T06:36:00.987571Z","caller":"traceutil/trace.go:171","msg":"trace[1466706042] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:735; }","duration":"261.751454ms","start":"2026-02-17T06:36:00.725813Z","end":"2026-02-17T06:36:00.987564Z","steps":["trace[1466706042] 'agreement among raft nodes before linearized reading' (duration: 261.661892ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:00.987852Z","caller":"traceutil/trace.go:171","msg":"trace[986648351] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"337.923616ms","start":"2026-02-17T06:36:00.649913Z","end":"2026-02-17T06:36:00.987837Z","steps":["trace[986648351] 'process raft request' (duration: 337.398943ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:00.987916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:00.649899Z","time spent":"337.974987ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:01.754139Z","caller":"traceutil/trace.go:171","msg":"trace[149093450] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"114.393895ms","start":"2026-02-17T06:36:01.639721Z","end":"2026-02-17T06:36:01.754115Z","steps":["trace[149093450] 'process raft request' (duration: 114.255762ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:13.996357Z","caller":"traceutil/trace.go:171","msg":"trace[268753978] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:804; }","duration":"194.043202ms","start":"2026-02-17T06:36:13.802292Z","end":"2026-02-17T06:36:13.996335Z","steps":["trace[268753978] 'read index received' (duration: 193.908789ms)","trace[268753978] 'applied index is now lower than readState.Index' (duration: 133.443µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:13.996539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.239056ms","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-17T06:36:13.99657Z","caller":"traceutil/trace.go:171","msg":"trace[1763955442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:776; }","duration":"194.283827ms","start":"2026-02-17T06:36:13.802277Z","end":"2026-02-17T06:36:13.996561Z","steps":["trace[1763955442] 'agreement among raft nodes before linearized reading' (duration: 194.156254ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:13.996628Z","caller":"traceutil/trace.go:171","msg":"trace[1467070036] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"214.725012ms","start":"2026-02-17T06:36:13.781876Z","end":"2026-02-17T06:36:13.996601Z","steps":["trace[1467070036] 'process raft request' (duration: 214.328643ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:17.359097Z","caller":"traceutil/trace.go:171","msg":"trace[1759893926] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"221.259984ms","start":"2026-02-17T06:36:17.137823Z","end":"2026-02-17T06:36:17.359083Z","steps":["trace[1759893926] 'read index received' (duration: 221.07928ms)","trace[1759893926] 'applied index is now lower than readState.Index' (duration: 179.884µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:17.359193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.345156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:17.359213Z","caller":"traceutil/trace.go:171","msg":"trace[201158452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:785; }","duration":"221.434058ms","start":"2026-02-17T06:36:17.13777Z","end":"2026-02-17T06:36:17.359204Z","steps":["trace[201158452] 'agreement among raft nodes before linearized reading' (duration: 221.369637ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:17.359416Z","caller":"traceutil/trace.go:171","msg":"trace[783227725] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"302.919301ms","start":"2026-02-17T06:36:17.056489Z","end":"2026-02-17T06:36:17.359408Z","steps":["trace[783227725] 'process raft request' (duration: 302.505071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:17.359468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:17.056471Z","time spent":"302.961322ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:19.321419Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101153146268326,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T06:36:19.398633Z","caller":"traceutil/trace.go:171","msg":"trace[1102149045] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"578.015055ms","start":"2026-02-17T06:36:18.820597Z","end":"2026-02-17T06:36:19.398612Z","steps":["trace[1102149045] 'read index received' (duration: 577.871781ms)","trace[1102149045] 'applied index is now lower than readState.Index' (duration: 142.484µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:19.398936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.087528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T06:36:19.398978Z","caller":"traceutil/trace.go:171","msg":"trace[459023801] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:789; }","duration":"310.137559ms","start":"2026-02-17T06:36:19.088828Z","end":"2026-02-17T06:36:19.398966Z","steps":["trace[459023801] 'agreement among raft nodes before linearized reading' (duration: 310.007686ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:19.399013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:19.08879Z","time spent":"310.215231ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-02-17T06:36:19.399176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.573738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:19.399203Z","caller":"traceutil/trace.go:171","msg":"trace[1393370986] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:789; }","duration":"578.63113ms","start":"2026-02-17T06:36:18.820564Z","end":"2026-02-17T06:36:19.399195Z","steps":["trace[1393370986] 'agreement among raft nodes before linearized reading' (duration: 578.587009ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:19.398738Z","caller":"traceutil/trace.go:171","msg":"trace[1725495190] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"685.400346ms","start":"2026-02-17T06:36:18.713326Z","end":"2026-02-17T06:36:19.398727Z","steps":["trace[1725495190] 'process raft request' (duration: 685.15342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:19.399932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:18.713306Z","time spent":"686.567926ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:19.400209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.193865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:19.400242Z","caller":"traceutil/trace.go:171","msg":"trace[11683945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:789; }","duration":"262.264477ms","start":"2026-02-17T06:36:19.137967Z","end":"2026-02-17T06:36:19.400231Z","steps":["trace[11683945] 'agreement among raft nodes before linearized reading' (duration: 262.217676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:19.408509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:18.820548Z","time spent":"587.775497ms","remote":"127.0.0.1:35264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-17T06:36:20.151339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.107273ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-17T06:36:20.151568Z","caller":"traceutil/trace.go:171","msg":"trace[1726110446] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"739.872881ms","start":"2026-02-17T06:36:19.411678Z","end":"2026-02-17T06:36:20.151551Z","steps":["trace[1726110446] 'process raft request' (duration: 739.750508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:20.152235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:19.411672Z","time spent":"739.939453ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:20.152582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:19.411466Z","time spent":"741.113052ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-17T06:36:20.153045Z","caller":"traceutil/trace.go:171","msg":"trace[331161662] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"741.398689ms","start":"2026-02-17T06:36:19.411631Z","end":"2026-02-17T06:36:20.153029Z","steps":["trace[331161662] 'read index received' (duration: 490.600665ms)","trace[331161662] 'applied index is now lower than readState.Index' (duration: 250.796164ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:20.153557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.913962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:20.153616Z","caller":"traceutil/trace.go:171","msg":"trace[65782949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"741.987193ms","start":"2026-02-17T06:36:19.411616Z","end":"2026-02-17T06:36:20.153603Z","steps":["trace[65782949] 'agreement among raft nodes before linearized reading' (duration: 741.894931ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:20.153649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:19.41161Z","time spent":"742.030954ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:36:20.15385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.695332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T06:36:20.153879Z","caller":"traceutil/trace.go:171","msg":"trace[1124663697] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:790; }","duration":"457.768724ms","start":"2026-02-17T06:36:19.696101Z","end":"2026-02-17T06:36:20.15387Z","steps":["trace[1124663697] 'agreement among raft nodes before linearized reading' (duration: 457.705092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:20.153907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:19.696083Z","time spent":"457.817246ms","remote":"127.0.0.1:35098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":40,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-02-17T06:36:20.426452Z","caller":"traceutil/trace.go:171","msg":"trace[479360516] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:822; }","duration":"255.708115ms","start":"2026-02-17T06:36:20.170728Z","end":"2026-02-17T06:36:20.426436Z","steps":["trace[479360516] 'read index received' (duration: 6.590743ms)","trace[479360516] 'applied index is now lower than readState.Index' (duration: 249.116682ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:20.426622Z","caller":"traceutil/trace.go:171","msg":"trace[1270316386] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"260.064503ms","start":"2026-02-17T06:36:20.166548Z","end":"2026-02-17T06:36:20.426613Z","steps":["trace[1270316386] 'process raft request' (duration: 186.470815ms)","trace[1270316386] 'compare' (duration: 73.098126ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:20.426742Z","caller":"traceutil/trace.go:171","msg":"trace[1839936261] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"259.256903ms","start":"2026-02-17T06:36:20.167479Z","end":"2026-02-17T06:36:20.426736Z","steps":["trace[1839936261] 'process raft request' (duration: 258.900874ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:20.426827Z","caller":"traceutil/trace.go:171","msg":"trace[2137497785] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"253.521902ms","start":"2026-02-17T06:36:20.173287Z","end":"2026-02-17T06:36:20.426809Z","steps":["trace[2137497785] 'process raft request' (duration: 253.124882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:20.426926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.185007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:20.426945Z","caller":"traceutil/trace.go:171","msg":"trace[179590691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"256.229738ms","start":"2026-02-17T06:36:20.17071Z","end":"2026-02-17T06:36:20.42694Z","steps":["trace[179590691] 'agreement among raft nodes before linearized reading' (duration: 256.184597ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:20.427045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.901676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-02-17T06:36:20.427061Z","caller":"traceutil/trace.go:171","msg":"trace[1046597494] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:794; }","duration":"248.932358ms","start":"2026-02-17T06:36:20.178124Z","end":"2026-02-17T06:36:20.427056Z","steps":["trace[1046597494] 'agreement among raft nodes before linearized reading' (duration: 248.898737ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.453441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.024563082s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:36:32.454025Z","caller":"traceutil/trace.go:171","msg":"trace[509653024] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"2.381674291s","start":"2026-02-17T06:36:30.072312Z","end":"2026-02-17T06:36:32.453986Z","steps":["trace[509653024] 'process raft request' (duration: 356.038932ms)","trace[509653024] 'compare' (duration: 2.023845425s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:32.45413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.072304Z","time spent":"2.381768483s","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":914,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:32.461981Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.033518943s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T06:36:32.467854Z","caller":"traceutil/trace.go:171","msg":"trace[796934562] linearizableReadLoop","detail":"{readStateIndex:899; appliedIndex:895; }","duration":"2.363736928s","start":"2026-02-17T06:36:30.104067Z","end":"2026-02-17T06:36:32.467804Z","steps":["trace[796934562] 'read index received' (duration: 324.296388ms)","trace[796934562] 'applied index is now lower than readState.Index' (duration: 2.03943972s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:32.46989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.365805768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:6 size:363638"} {"level":"info","ts":"2026-02-17T06:36:32.469931Z","caller":"traceutil/trace.go:171","msg":"trace[1302069289] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:864; }","duration":"2.365890371s","start":"2026-02-17T06:36:30.104031Z","end":"2026-02-17T06:36:32.469921Z","steps":["trace[1302069289] 'agreement among raft nodes before linearized reading' (duration: 2.363866831s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.470088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.104014Z","time spent":"2.366058265s","remote":"127.0.0.1:34972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":6,"response size":363661,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-02-17T06:36:32.470703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.262239035s","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-17T06:36:32.470808Z","caller":"traceutil/trace.go:171","msg":"trace[781839921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:866; }","duration":"2.262397808s","start":"2026-02-17T06:36:30.208397Z","end":"2026-02-17T06:36:32.470795Z","steps":["trace[781839921] 'agreement among raft nodes before linearized reading' (duration: 2.262156902s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.470866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.208384Z","time spent":"2.2624597s","remote":"127.0.0.1:35160","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-17T06:36:32.471075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.311552641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-02-17T06:36:32.472495Z","caller":"traceutil/trace.go:171","msg":"trace[484737878] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:866; }","duration":"2.312977346s","start":"2026-02-17T06:36:30.159508Z","end":"2026-02-17T06:36:32.472485Z","steps":["trace[484737878] 'agreement among raft nodes before linearized reading' (duration: 2.31152417s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.472576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.159504Z","time spent":"2.313051318s","remote":"127.0.0.1:35098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":774,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" "} {"level":"info","ts":"2026-02-17T06:36:32.471337Z","caller":"traceutil/trace.go:171","msg":"trace[819700280] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"2.398843103s","start":"2026-02-17T06:36:30.072481Z","end":"2026-02-17T06:36:32.471324Z","steps":["trace[819700280] 'process raft request' (duration: 2.391976324s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.472875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.072475Z","time spent":"2.400358192s","remote":"127.0.0.1:35176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1507,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:32.47251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.900719ms","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-17T06:36:32.473133Z","caller":"traceutil/trace.go:171","msg":"trace[2018854139] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:866; }","duration":"978.549525ms","start":"2026-02-17T06:36:31.494566Z","end":"2026-02-17T06:36:32.473115Z","steps":["trace[2018854139] 'agreement among raft nodes before linearized reading' (duration: 975.790577ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.473201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:31.494545Z","time spent":"978.649218ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T06:36:32.47221Z","caller":"traceutil/trace.go:171","msg":"trace[777319913] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"2.391810361s","start":"2026-02-17T06:36:30.080381Z","end":"2026-02-17T06:36:32.472191Z","steps":["trace[777319913] 'process raft request' (duration: 2.384371407s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.472529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.335324904s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:32.473715Z","caller":"traceutil/trace.go:171","msg":"trace[1151488236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:866; }","duration":"1.336548584s","start":"2026-02-17T06:36:31.137157Z","end":"2026-02-17T06:36:32.473706Z","steps":["trace[1151488236] 'agreement among raft nodes before linearized reading' (duration: 1.333202772s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.473821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.080371Z","time spent":"2.393252856s","remote":"127.0.0.1:35082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12321,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:32.472313Z","caller":"traceutil/trace.go:171","msg":"trace[259613577] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"2.38975929s","start":"2026-02-17T06:36:30.082546Z","end":"2026-02-17T06:36:32.472305Z","steps":["trace[259613577] 'process raft request' (duration: 2.382588463s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.474198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.082539Z","time spent":"2.391567344s","remote":"127.0.0.1:35362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11014,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:32.474378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:31.137135Z","time spent":"1.337232711s","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:36:32.474817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.945806321s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-17T06:36:32.472389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.312887903s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-02-17T06:36:32.475136Z","caller":"traceutil/trace.go:171","msg":"trace[1578204021] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin; range_end:; response_count:1; response_revision:866; }","duration":"2.315652792s","start":"2026-02-17T06:36:30.159473Z","end":"2026-02-17T06:36:32.475126Z","steps":["trace[1578204021] 'agreement among raft nodes before linearized reading' (duration: 2.31029476s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.475226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.159426Z","time spent":"2.315789075s","remote":"127.0.0.1:35098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":774,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-nodeplugin\" "} {"level":"info","ts":"2026-02-17T06:36:32.472466Z","caller":"traceutil/trace.go:171","msg":"trace[2141404890] transaction","detail":"{read_only:false; response_revision:865; number_of_response:1; }","duration":"1.729206228s","start":"2026-02-17T06:36:30.743255Z","end":"2026-02-17T06:36:32.472461Z","steps":["trace[2141404890] 'process raft request' (duration: 1.72641435s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.475958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.743233Z","time spent":"1.732695385s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:32.476558Z","caller":"traceutil/trace.go:171","msg":"trace[906794444] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"1.310372159s","start":"2026-02-17T06:36:31.159913Z","end":"2026-02-17T06:36:32.470285Z","steps":["trace[906794444] 'process raft request' (duration: 1.309814465s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.476666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:31.159893Z","time spent":"1.316751826s","remote":"127.0.0.1:34956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":832,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T06:36:32.476963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.953205483s","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-17T06:36:32.47704Z","caller":"traceutil/trace.go:171","msg":"trace[1075274055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:866; }","duration":"1.953297196s","start":"2026-02-17T06:36:30.523721Z","end":"2026-02-17T06:36:32.477018Z","steps":["trace[1075274055] 'agreement among raft nodes before linearized reading' (duration: 1.946645332s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.477107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.52369Z","time spent":"1.953410299s","remote":"127.0.0.1:35160","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":"info","ts":"2026-02-17T06:36:32.474847Z","caller":"traceutil/trace.go:171","msg":"trace[1448487879] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:866; }","duration":"1.945862462s","start":"2026-02-17T06:36:30.528977Z","end":"2026-02-17T06:36:32.47484Z","steps":["trace[1448487879] 'agreement among raft nodes before linearized reading' (duration: 1.941385642s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.480157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.528966Z","time spent":"1.950428026s","remote":"127.0.0.1:35160","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-17T06:36:32.481625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.212337563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:754"} {"level":"info","ts":"2026-02-17T06:36:32.485985Z","caller":"traceutil/trace.go:171","msg":"trace[202351984] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:866; }","duration":"2.216701801s","start":"2026-02-17T06:36:30.269268Z","end":"2026-02-17T06:36:32.48597Z","steps":["trace[202351984] 'agreement among raft nodes before linearized reading' (duration: 2.212280782s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.486071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.269265Z","time spent":"2.216791554s","remote":"127.0.0.1:35098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":777,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" "} {"level":"warn","ts":"2026-02-17T06:36:32.482666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.965959688s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T06:36:32.486382Z","caller":"traceutil/trace.go:171","msg":"trace[573426680] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:866; }","duration":"1.969721661s","start":"2026-02-17T06:36:30.516639Z","end":"2026-02-17T06:36:32.486361Z","steps":["trace[573426680] 'agreement among raft nodes before linearized reading' (duration: 1.953744497s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.486418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.516621Z","time spent":"1.969789733s","remote":"127.0.0.1:35160","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-17T06:36:32.48291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.213649206s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:754"} {"level":"info","ts":"2026-02-17T06:36:32.486563Z","caller":"traceutil/trace.go:171","msg":"trace[1346339623] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:866; }","duration":"2.217360857s","start":"2026-02-17T06:36:30.269196Z","end":"2026-02-17T06:36:32.486557Z","steps":["trace[1346339623] 'agreement among raft nodes before linearized reading' (duration: 2.201338662s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:32.486614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:30.26918Z","time spent":"2.217427779s","remote":"127.0.0.1:35098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":777,"request content":"key:\"/registry/serviceaccounts/kube-system/ceph-csi-rbd-provisioner\" "} {"level":"warn","ts":"2026-02-17T06:36:35.904218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.200235ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-17T06:36:38.806841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.635602ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:36:38.806978Z","caller":"traceutil/trace.go:171","msg":"trace[419884679] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"192.706933ms","start":"2026-02-17T06:36:38.614259Z","end":"2026-02-17T06:36:38.806966Z","steps":["trace[419884679] 'process raft request' (duration: 192.680742ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:38.807136Z","caller":"traceutil/trace.go:171","msg":"trace[670768589] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"197.477491ms","start":"2026-02-17T06:36:38.609653Z","end":"2026-02-17T06:36:38.80713Z","steps":["trace[670768589] 'process raft request' (duration: 21.506231ms)","trace[670768589] 'compare' (duration: 175.56661ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:38.807199Z","caller":"traceutil/trace.go:171","msg":"trace[1668026165] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"193.172114ms","start":"2026-02-17T06:36:38.614022Z","end":"2026-02-17T06:36:38.807194Z","steps":["trace[1668026165] 'process raft request' (duration: 192.884557ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:39.267016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.095753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T06:36:39.267067Z","caller":"traceutil/trace.go:171","msg":"trace[1465626876] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:893; }","duration":"178.182885ms","start":"2026-02-17T06:36:39.088872Z","end":"2026-02-17T06:36:39.267055Z","steps":["trace[1465626876] 'range keys from in-memory index tree' (duration: 177.9636ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:39.267062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.195473ms","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-17T06:36:39.267106Z","caller":"traceutil/trace.go:171","msg":"trace[1029649590] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:893; }","duration":"141.273544ms","start":"2026-02-17T06:36:39.125822Z","end":"2026-02-17T06:36:39.267095Z","steps":["trace[1029649590] 'count revisions from in-memory index tree' (duration: 141.144802ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:39.267223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.171349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:39.267239Z","caller":"traceutil/trace.go:171","msg":"trace[2110081735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:893; }","duration":"134.196559ms","start":"2026-02-17T06:36:39.133035Z","end":"2026-02-17T06:36:39.267232Z","steps":["trace[2110081735] 'range keys from in-memory index tree' (duration: 134.131958ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:47.251692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.3672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:36:47.25176Z","caller":"traceutil/trace.go:171","msg":"trace[1490743068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:914; }","duration":"114.463393ms","start":"2026-02-17T06:36:47.137283Z","end":"2026-02-17T06:36:47.251747Z","steps":["trace[1490743068] 'range keys from in-memory index tree' (duration: 114.30102ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:47.252234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.677862ms","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-17T06:36:47.252259Z","caller":"traceutil/trace.go:171","msg":"trace[287057565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:914; }","duration":"385.751444ms","start":"2026-02-17T06:36:46.8665Z","end":"2026-02-17T06:36:47.252251Z","steps":["trace[287057565] 'range keys from in-memory index tree' (duration: 385.487407ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:47.253093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.854046ms","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-17T06:36:47.253133Z","caller":"traceutil/trace.go:171","msg":"trace[1120365810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:914; }","duration":"385.904848ms","start":"2026-02-17T06:36:46.867221Z","end":"2026-02-17T06:36:47.253126Z","steps":["trace[1120365810] 'range keys from in-memory index tree' (duration: 385.791745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:47.253173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:46.867216Z","time spent":"385.931499ms","remote":"127.0.0.1:35160","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-17T06:36:47.252277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:46.866488Z","time spent":"385.783615ms","remote":"127.0.0.1:35160","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-17T06:36:51.180271Z","caller":"traceutil/trace.go:171","msg":"trace[419969987] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"284.569459ms","start":"2026-02-17T06:36:50.895684Z","end":"2026-02-17T06:36:51.180254Z","steps":["trace[419969987] 'process raft request' (duration: 284.173229ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:52.957442Z","caller":"traceutil/trace.go:171","msg":"trace[1823607367] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"311.685747ms","start":"2026-02-17T06:36:52.645732Z","end":"2026-02-17T06:36:52.957418Z","steps":["trace[1823607367] 'process raft request' (duration: 311.537543ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:52.957599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:52.645703Z","time spent":"311.80369ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:36:52.958089Z","caller":"traceutil/trace.go:171","msg":"trace[126843198] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:967; }","duration":"310.641991ms","start":"2026-02-17T06:36:52.647431Z","end":"2026-02-17T06:36:52.958073Z","steps":["trace[126843198] 'read index received' (duration: 310.633501ms)","trace[126843198] 'applied index is now lower than readState.Index' (duration: 6.8µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:52.958238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.795555ms","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-17T06:36:52.958297Z","caller":"traceutil/trace.go:171","msg":"trace[250800567] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:928; }","duration":"310.876957ms","start":"2026-02-17T06:36:52.64741Z","end":"2026-02-17T06:36:52.958287Z","steps":["trace[250800567] 'agreement among raft nodes before linearized reading' (duration: 310.728544ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:52.958334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:52.647404Z","time spent":"310.921758ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T06:36:52.967026Z","caller":"traceutil/trace.go:171","msg":"trace[1273314567] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"168.060665ms","start":"2026-02-17T06:36:52.798955Z","end":"2026-02-17T06:36:52.967015Z","steps":["trace[1273314567] 'process raft request' (duration: 167.997593ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:36:55.142523Z","caller":"traceutil/trace.go:171","msg":"trace[624100679] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"101.506633ms","start":"2026-02-17T06:36:55.041Z","end":"2026-02-17T06:36:55.142506Z","steps":["trace[624100679] 'process raft request' (duration: 78.963097ms)","trace[624100679] 'compare' (duration: 22.460364ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:55.976652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.707809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T06:36:55.976707Z","caller":"traceutil/trace.go:171","msg":"trace[437686107] linearizableReadLoop","detail":"{readStateIndex:985; appliedIndex:984; }","duration":"636.744623ms","start":"2026-02-17T06:36:55.339954Z","end":"2026-02-17T06:36:55.976698Z","steps":["trace[437686107] 'read index received' (duration: 75.883851ms)","trace[437686107] 'applied index is now lower than readState.Index' (duration: 560.860132ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:36:55.976816Z","caller":"traceutil/trace.go:171","msg":"trace[23232921] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"779.643577ms","start":"2026-02-17T06:36:55.197167Z","end":"2026-02-17T06:36:55.97681Z","steps":["trace[23232921] 'process raft request' (duration: 218.730294ms)","trace[23232921] 'compare' (duration: 560.576434ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:36:55.976844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:55.197155Z","time spent":"779.673978ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:36:55.976956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.00186ms","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-17T06:36:55.97697Z","caller":"traceutil/trace.go:171","msg":"trace[2134139016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:945; }","duration":"637.015421ms","start":"2026-02-17T06:36:55.339949Z","end":"2026-02-17T06:36:55.976965Z","steps":["trace[2134139016] 'agreement among raft nodes before linearized reading' (duration: 636.964269ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:55.976982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:55.339909Z","time spent":"637.070572ms","remote":"127.0.0.1:35160","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-17T06:36:55.977064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.070762ms","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-17T06:36:55.977076Z","caller":"traceutil/trace.go:171","msg":"trace[1766245329] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:945; }","duration":"637.093702ms","start":"2026-02-17T06:36:55.339979Z","end":"2026-02-17T06:36:55.977073Z","steps":["trace[1766245329] 'agreement among raft nodes before linearized reading' (duration: 637.052181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:36:55.977088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:36:55.339976Z","time spent":"637.109453ms","remote":"127.0.0.1:35160","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-17T06:37:07.870801Z","caller":"traceutil/trace.go:171","msg":"trace[967429597] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"135.160753ms","start":"2026-02-17T06:37:07.735625Z","end":"2026-02-17T06:37:07.870786Z","steps":["trace[967429597] 'process raft request' (duration: 134.849226ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:08.39489Z","caller":"traceutil/trace.go:171","msg":"trace[538841913] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"191.161495ms","start":"2026-02-17T06:37:08.2037Z","end":"2026-02-17T06:37:08.394862Z","steps":["trace[538841913] 'process raft request' (duration: 161.3802ms)","trace[538841913] 'compare' (duration: 29.685682ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:09.629958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.065742ms","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-17T06:37:09.630035Z","caller":"traceutil/trace.go:171","msg":"trace[1465186857] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1036; }","duration":"547.194315ms","start":"2026-02-17T06:37:09.082822Z","end":"2026-02-17T06:37:09.630016Z","steps":["trace[1465186857] 'range keys from in-memory index tree' (duration: 546.899888ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:09.630063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.528321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-02-17T06:37:09.63008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.082802Z","time spent":"547.268007ms","remote":"127.0.0.1:35160","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":"info","ts":"2026-02-17T06:37:09.63012Z","caller":"traceutil/trace.go:171","msg":"trace[1503584790] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:1036; }","duration":"538.605863ms","start":"2026-02-17T06:37:09.091499Z","end":"2026-02-17T06:37:09.630105Z","steps":["trace[1503584790] 'range keys from in-memory index tree' (duration: 538.412118ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:09.63015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.091492Z","time spent":"538.651974ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-02-17T06:37:09.630303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.712517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:37:09.630321Z","caller":"traceutil/trace.go:171","msg":"trace[1025972767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1036; }","duration":"493.753407ms","start":"2026-02-17T06:37:09.136561Z","end":"2026-02-17T06:37:09.630315Z","steps":["trace[1025972767] 'range keys from in-memory index tree' (duration: 493.649684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:09.630336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.136555Z","time spent":"493.777727ms","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:37:09.630479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"928.635513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-02-17T06:37:09.630512Z","caller":"traceutil/trace.go:171","msg":"trace[1597811086] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1036; }","duration":"928.704975ms","start":"2026-02-17T06:37:08.701796Z","end":"2026-02-17T06:37:09.630501Z","steps":["trace[1597811086] 'range keys from in-memory index tree' (duration: 928.53824ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:09.630542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:08.701776Z","time spent":"928.759285ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T06:37:09.63077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.719647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-02-17T06:37:09.630798Z","caller":"traceutil/trace.go:171","msg":"trace[810968208] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1036; }","duration":"712.777459ms","start":"2026-02-17T06:37:08.918011Z","end":"2026-02-17T06:37:09.630789Z","steps":["trace[810968208] 'range keys from in-memory index tree' (duration: 712.541893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:09.630825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:08.917995Z","time spent":"712.82177ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":556,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-02-17T06:37:09.631045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.111768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-17T06:37:09.631069Z","caller":"traceutil/trace.go:171","msg":"trace[1890784059] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1036; }","duration":"237.172349ms","start":"2026-02-17T06:37:09.39389Z","end":"2026-02-17T06:37:09.631062Z","steps":["trace[1890784059] 'range keys from in-memory index tree' (duration: 237.003476ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:09.971376Z","caller":"traceutil/trace.go:171","msg":"trace[1111198671] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"336.085898ms","start":"2026-02-17T06:37:09.635263Z","end":"2026-02-17T06:37:09.971348Z","steps":["trace[1111198671] 'process raft request' (duration: 335.944115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:09.971729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.635249Z","time spent":"336.198951ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:37:09.974014Z","caller":"traceutil/trace.go:171","msg":"trace[700942541] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1079; }","duration":"338.498908ms","start":"2026-02-17T06:37:09.63547Z","end":"2026-02-17T06:37:09.973969Z","steps":["trace[700942541] 'read index received' (duration: 338.488728ms)","trace[700942541] 'applied index is now lower than readState.Index' (duration: 8.43µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:09.974179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.679832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:37:09.974234Z","caller":"traceutil/trace.go:171","msg":"trace[835126823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1037; }","duration":"338.761774ms","start":"2026-02-17T06:37:09.635453Z","end":"2026-02-17T06:37:09.974215Z","steps":["trace[835126823] 'agreement among raft nodes before linearized reading' (duration: 338.646471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:09.97428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.635441Z","time spent":"338.828526ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T06:37:10.589923Z","caller":"traceutil/trace.go:171","msg":"trace[516192962] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1079; }","duration":"615.823718ms","start":"2026-02-17T06:37:09.974084Z","end":"2026-02-17T06:37:10.589907Z","steps":["trace[516192962] 'read index received' (duration: 595.807704ms)","trace[516192962] 'applied index is now lower than readState.Index' (duration: 20.015304ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:37:10.590279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.635491Z","time spent":"954.785817ms","remote":"127.0.0.1:34914","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-17T06:37:10.590579Z","caller":"traceutil/trace.go:171","msg":"trace[454440489] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"954.989502ms","start":"2026-02-17T06:37:09.635579Z","end":"2026-02-17T06:37:10.590569Z","steps":["trace[454440489] 'process raft request' (duration: 954.161682ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.590716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.635571Z","time spent":"955.094334ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:37:10.590909Z","caller":"traceutil/trace.go:171","msg":"trace[2041464299] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"953.219838ms","start":"2026-02-17T06:37:09.63768Z","end":"2026-02-17T06:37:10.590899Z","steps":["trace[2041464299] 'process raft request' (duration: 952.135481ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.591009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.637669Z","time spent":"953.314781ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:37:10.591163Z","caller":"traceutil/trace.go:171","msg":"trace[329362707] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"953.345911ms","start":"2026-02-17T06:37:09.637809Z","end":"2026-02-17T06:37:10.591155Z","steps":["trace[329362707] 'process raft request' (duration: 952.027939ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.591261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.637802Z","time spent":"953.434263ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:37:10.591714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.633499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"} {"level":"warn","ts":"2026-02-17T06:37:10.591891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.061462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:37:10.59196Z","caller":"traceutil/trace.go:171","msg":"trace[1188560960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1040; }","duration":"455.276918ms","start":"2026-02-17T06:37:10.136673Z","end":"2026-02-17T06:37:10.59195Z","steps":["trace[1188560960] 'agreement among raft nodes before linearized reading' (duration: 455.073753ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.592017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:10.136659Z","time spent":"455.34872ms","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:37:10.592241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.726793ms","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-17T06:37:10.59232Z","caller":"traceutil/trace.go:171","msg":"trace[1672697957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1040; }","duration":"192.842936ms","start":"2026-02-17T06:37:10.39947Z","end":"2026-02-17T06:37:10.592313Z","steps":["trace[1672697957] 'agreement among raft nodes before linearized reading' (duration: 192.711473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.592511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.826434ms","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-17T06:37:10.592597Z","caller":"traceutil/trace.go:171","msg":"trace[1343968209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1040; }","duration":"389.962998ms","start":"2026-02-17T06:37:10.202626Z","end":"2026-02-17T06:37:10.59259Z","steps":["trace[1343968209] 'agreement among raft nodes before linearized reading' (duration: 389.839705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.592665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:10.202607Z","time spent":"390.05043ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T06:37:10.592838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.111551ms","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-17T06:37:10.592758Z","caller":"traceutil/trace.go:171","msg":"trace[1590714273] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1040; }","duration":"820.740911ms","start":"2026-02-17T06:37:09.771028Z","end":"2026-02-17T06:37:10.591769Z","steps":["trace[1590714273] 'agreement among raft nodes before linearized reading' (duration: 820.536686ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:10.592938Z","caller":"traceutil/trace.go:171","msg":"trace[355515144] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1040; }","duration":"392.241353ms","start":"2026-02-17T06:37:10.200689Z","end":"2026-02-17T06:37:10.59293Z","steps":["trace[355515144] 'agreement among raft nodes before linearized reading' (duration: 392.1057ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.593037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:10.200674Z","time spent":"392.329606ms","remote":"127.0.0.1:35160","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-17T06:37:10.593274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:09.770975Z","time spent":"822.280409ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-02-17T06:37:10.981581Z","caller":"traceutil/trace.go:171","msg":"trace[1000065013] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1084; }","duration":"347.287515ms","start":"2026-02-17T06:37:10.634277Z","end":"2026-02-17T06:37:10.981565Z","steps":["trace[1000065013] 'read index received' (duration: 347.021829ms)","trace[1000065013] 'applied index is now lower than readState.Index' (duration: 265.056µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:37:10.981602Z","caller":"traceutil/trace.go:171","msg":"trace[850932495] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"378.418723ms","start":"2026-02-17T06:37:10.603154Z","end":"2026-02-17T06:37:10.981573Z","steps":["trace[850932495] 'process raft request' (duration: 378.191577ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:10.981738Z","caller":"traceutil/trace.go:171","msg":"trace[1112662696] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"378.31477ms","start":"2026-02-17T06:37:10.603333Z","end":"2026-02-17T06:37:10.981648Z","steps":["trace[1112662696] 'process raft request' (duration: 378.160147ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.981752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:10.603144Z","time spent":"378.520096ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:37:10.981824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:10.603326Z","time spent":"378.436283ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":512,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:37:10.981918Z","caller":"traceutil/trace.go:171","msg":"trace[1052215800] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"377.915981ms","start":"2026-02-17T06:37:10.603996Z","end":"2026-02-17T06:37:10.981912Z","steps":["trace[1052215800] 'process raft request' (duration: 377.526711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.981947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:10.603989Z","time spent":"377.940791ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:37:10.982066Z","caller":"traceutil/trace.go:171","msg":"trace[1950894705] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"377.290916ms","start":"2026-02-17T06:37:10.604769Z","end":"2026-02-17T06:37:10.98206Z","steps":["trace[1950894705] 'process raft request' (duration: 376.771763ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.982098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:10.604753Z","time spent":"377.328216ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T06:37:10.982168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.89547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-02-17T06:37:10.982185Z","caller":"traceutil/trace.go:171","msg":"trace[680993973] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1045; }","duration":"347.930982ms","start":"2026-02-17T06:37:10.634249Z","end":"2026-02-17T06:37:10.98218Z","steps":["trace[680993973] 'agreement among raft nodes before linearized reading' (duration: 347.891481ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:37:10.982202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:37:10.63424Z","time spent":"347.958792ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-02-17T06:37:10.982354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.059881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-02-17T06:37:10.982374Z","caller":"traceutil/trace.go:171","msg":"trace[1837524840] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1045; }","duration":"195.105552ms","start":"2026-02-17T06:37:10.78726Z","end":"2026-02-17T06:37:10.982366Z","steps":["trace[1837524840] 'agreement among raft nodes before linearized reading' (duration: 195.02831ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:37:11.138348Z","caller":"traceutil/trace.go:171","msg":"trace[1539603488] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"143.669133ms","start":"2026-02-17T06:37:10.994665Z","end":"2026-02-17T06:37:11.138334Z","steps":["trace[1539603488] 'process raft request' (duration: 142.35851ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:39.593128Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101153146269815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:38:40.093495Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101153146269815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:38:40.593584Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101153146269815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:38:41.094579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101153146269815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:38:41.137974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000523031s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T06:38:41.138776Z","caller":"traceutil/trace.go:171","msg":"trace[873258218] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00128395s","start":"2026-02-17T06:38:39.13742Z","end":"2026-02-17T06:38:41.138704Z","steps":["trace[873258218] 'agreement among raft nodes before linearized reading' (duration: 2.000520121s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:41.13945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:39.137386Z","time spent":"2.002047369s","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/17 06:38:41 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T06:38:41.595364Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101153146269815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:38:42.099907Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322101153146269815,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T06:38:42.104745Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.603238755s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T06:38:42.105001Z","caller":"traceutil/trace.go:171","msg":"trace[188718137] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"3.014454495s","start":"2026-02-17T06:38:39.090533Z","end":"2026-02-17T06:38:42.104988Z","steps":["trace[188718137] 'process raft request' (duration: 3.014361373s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.10507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:39.090521Z","time spent":"3.014500437s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T06:38:42.105487Z","caller":"traceutil/trace.go:171","msg":"trace[899497088] linearizableReadLoop","detail":"{readStateIndex:1462; appliedIndex:1462; }","duration":"3.014543818s","start":"2026-02-17T06:38:39.090937Z","end":"2026-02-17T06:38:42.105481Z","steps":["trace[899497088] 'read index received' (duration: 3.014538348s)","trace[899497088] 'applied index is now lower than readState.Index' (duration: 3.46µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:38:42.105572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.0098559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T06:38:42.105589Z","caller":"traceutil/trace.go:171","msg":"trace[828158343] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:1402; }","duration":"3.009885301s","start":"2026-02-17T06:38:39.095699Z","end":"2026-02-17T06:38:42.105584Z","steps":["trace[828158343] 'agreement among raft nodes before linearized reading' (duration: 3.00981976s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.105605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:39.095692Z","time spent":"3.009908642s","remote":"127.0.0.1:34914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-02-17T06:38:42.105729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.014790334s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-02-17T06:38:42.105742Z","caller":"traceutil/trace.go:171","msg":"trace[974065404] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1402; }","duration":"3.014814855s","start":"2026-02-17T06:38:39.090923Z","end":"2026-02-17T06:38:42.105738Z","steps":["trace[974065404] 'agreement among raft nodes before linearized reading' (duration: 3.014778764s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.105754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:39.090915Z","time spent":"3.014836215s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-02-17T06:38:42.10584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.09557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T06:38:42.105854Z","caller":"traceutil/trace.go:171","msg":"trace[1517718271] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1402; }","duration":"419.148591ms","start":"2026-02-17T06:38:41.686702Z","end":"2026-02-17T06:38:42.10585Z","steps":["trace[1517718271] 'agreement among raft nodes before linearized reading' (duration: 419.0985ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.105866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:41.686684Z","time spent":"419.178201ms","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":15,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-02-17T06:38:42.105936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.227431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:38:42.105949Z","caller":"traceutil/trace.go:171","msg":"trace[316553855] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1402; }","duration":"606.242031ms","start":"2026-02-17T06:38:41.499703Z","end":"2026-02-17T06:38:42.105945Z","steps":["trace[316553855] 'agreement among raft nodes before linearized reading' (duration: 606.221341ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.105986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:41.499642Z","time spent":"606.341114ms","remote":"127.0.0.1:35420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-02-17T06:38:42.106043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.816704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:38:42.106054Z","caller":"traceutil/trace.go:171","msg":"trace[1657566872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1402; }","duration":"789.858045ms","start":"2026-02-17T06:38:41.316192Z","end":"2026-02-17T06:38:42.106051Z","steps":["trace[1657566872] 'agreement among raft nodes before linearized reading' (duration: 789.840005ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:41.316178Z","time spent":"789.884245ms","remote":"127.0.0.1:34886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:38:42.106145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.853207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-02-17T06:38:42.106158Z","caller":"traceutil/trace.go:171","msg":"trace[155047332] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1402; }","duration":"813.92561ms","start":"2026-02-17T06:38:41.292227Z","end":"2026-02-17T06:38:42.106153Z","steps":["trace[155047332] 'agreement among raft nodes before linearized reading' (duration: 813.890609ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.10617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:41.29221Z","time spent":"813.95761ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T06:38:42.106237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.204136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-02-17T06:38:42.106248Z","caller":"traceutil/trace.go:171","msg":"trace[273794450] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1402; }","duration":"925.236236ms","start":"2026-02-17T06:38:41.181008Z","end":"2026-02-17T06:38:42.106244Z","steps":["trace[273794450] 'agreement among raft nodes before linearized reading' (duration: 925.203525ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:41.180997Z","time spent":"925.259637ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T06:38:42.106316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.575995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T06:38:42.106327Z","caller":"traceutil/trace.go:171","msg":"trace[1285143405] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1402; }","duration":"966.618406ms","start":"2026-02-17T06:38:41.139705Z","end":"2026-02-17T06:38:42.106323Z","steps":["trace[1285143405] 'agreement among raft nodes before linearized reading' (duration: 966.600215ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:41.139691Z","time spent":"966.644536ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T06:38:42.106411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.308897815s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-02-17T06:38:42.106422Z","caller":"traceutil/trace.go:171","msg":"trace[198782200] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1402; }","duration":"1.308933556s","start":"2026-02-17T06:38:40.797485Z","end":"2026-02-17T06:38:42.106418Z","steps":["trace[198782200] 'agreement among raft nodes before linearized reading' (duration: 1.308901255s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:40.79747Z","time spent":"1.308960037s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-17T06:38:42.106504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.772648997s","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-17T06:38:42.106516Z","caller":"traceutil/trace.go:171","msg":"trace[1639288646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1402; }","duration":"1.772682568s","start":"2026-02-17T06:38:40.333829Z","end":"2026-02-17T06:38:42.106512Z","steps":["trace[1639288646] 'agreement among raft nodes before linearized reading' (duration: 1.772648197s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:40.333816Z","time spent":"1.772708579s","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T06:38:42.106609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.600959328s","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-17T06:38:42.106621Z","caller":"traceutil/trace.go:171","msg":"trace[315902461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1402; }","duration":"2.600982028s","start":"2026-02-17T06:38:39.505635Z","end":"2026-02-17T06:38:42.106617Z","steps":["trace[315902461] 'agreement among raft nodes before linearized reading' (duration: 2.600932177s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:39.505632Z","time spent":"2.600997469s","remote":"127.0.0.1:35160","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-17T06:38:42.106699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.60107499s","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-17T06:38:42.10671Z","caller":"traceutil/trace.go:171","msg":"trace[642761948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1402; }","duration":"2.601117001s","start":"2026-02-17T06:38:39.505589Z","end":"2026-02-17T06:38:42.106706Z","steps":["trace[642761948] 'agreement among raft nodes before linearized reading' (duration: 2.601085041s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:39.505582Z","time spent":"2.601136232s","remote":"127.0.0.1:35160","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-17T06:38:42.106784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.603967033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-17T06:38:42.106796Z","caller":"traceutil/trace.go:171","msg":"trace[1002434419] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1402; }","duration":"2.604009855s","start":"2026-02-17T06:38:39.502783Z","end":"2026-02-17T06:38:42.106793Z","steps":["trace[1002434419] 'agreement among raft nodes before linearized reading' (duration: 2.603977174s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:39.502768Z","time spent":"2.604036005s","remote":"127.0.0.1:35160","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-17T06:38:42.106851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.912667399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T06:38:42.106861Z","caller":"traceutil/trace.go:171","msg":"trace[386016796] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1402; }","duration":"2.91271773s","start":"2026-02-17T06:38:39.19414Z","end":"2026-02-17T06:38:42.106858Z","steps":["trace[386016796] 'agreement among raft nodes before linearized reading' (duration: 2.91269742s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T06:38:42.106873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T06:38:39.194122Z","time spent":"2.912747931s","remote":"127.0.0.1:34972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":6,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-02-17T06:40:19.29283Z","caller":"traceutil/trace.go:171","msg":"trace[371150159] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"137.37112ms","start":"2026-02-17T06:40:19.155434Z","end":"2026-02-17T06:40:19.292805Z","steps":["trace[371150159] 'process raft request' (duration: 83.937261ms)","trace[371150159] 'compare' (duration: 53.190133ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:40:20.865639Z","caller":"traceutil/trace.go:171","msg":"trace[1592526700] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1921; }","duration":"114.132517ms","start":"2026-02-17T06:40:20.751488Z","end":"2026-02-17T06:40:20.865621Z","steps":["trace[1592526700] 'read index received' (duration: 71.159887ms)","trace[1592526700] 'applied index is now lower than readState.Index' (duration: 42.97179ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T06:40:20.865785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.28205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-17T06:40:20.865806Z","caller":"traceutil/trace.go:171","msg":"trace[1481119331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1839; }","duration":"114.317361ms","start":"2026-02-17T06:40:20.751481Z","end":"2026-02-17T06:40:20.865798Z","steps":["trace[1481119331] 'agreement among raft nodes before linearized reading' (duration: 114.202058ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:40:20.866038Z","caller":"traceutil/trace.go:171","msg":"trace[438352138] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"188.319798ms","start":"2026-02-17T06:40:20.677707Z","end":"2026-02-17T06:40:20.866027Z","steps":["trace[438352138] 'process raft request' (duration: 144.997639ms)","trace[438352138] 'compare' (duration: 42.831977ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T06:40:24.864989Z","caller":"traceutil/trace.go:171","msg":"trace[950022813] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"168.007596ms","start":"2026-02-17T06:40:24.696962Z","end":"2026-02-17T06:40:24.864969Z","steps":["trace[950022813] 'process raft request' (duration: 167.958965ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:40:24.86527Z","caller":"traceutil/trace.go:171","msg":"trace[65960926] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"170.400156ms","start":"2026-02-17T06:40:24.694859Z","end":"2026-02-17T06:40:24.865259Z","steps":["trace[65960926] 'process raft request' (duration: 166.009417ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T06:40:24.865278Z","caller":"traceutil/trace.go:171","msg":"trace[21976216] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"170.360874ms","start":"2026-02-17T06:40:24.69491Z","end":"2026-02-17T06:40:24.865271Z","steps":["trace[21976216] 'process raft request' (duration: 169.985615ms)"],"step_count":1}