{"level":"warn","ts":"2026-04-02T22:30:45.716489Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T22:30:45.716612Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-04-02T22:30:45.716701Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-02T22:30:45.716713Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-02T22:30:45.71674Z","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-04-02T22:30:45.717643Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-04-02T22:30:45.717736Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-04-02T22:30:45.72207Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.039333ms"} {"level":"info","ts":"2026-04-02T22:30:45.734784Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-04-02T22:30:45.734875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T22:30:45.734904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-04-02T22:30:45.734919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T22:30:45.734935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-04-02T22:30:45.734973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-04-02T22:30:45.748562Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T22:30:45.750409Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T22:30:45.751454Z","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-04-02T22:30:45.754598Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T22:30:45.754783Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T22:30:45.754916Z","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-04-02T22:30:45.75495Z","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-04-02T22:30:45.754971Z","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-04-02T22:30:45.756309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-04-02T22:30:45.756608Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-02T22:30:45.758766Z","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-04-02T22:30:45.759066Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T22:30:45.759122Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T22:30:45.75937Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-02T22:30:45.759401Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-02T22:30:46.135629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T22:30:46.135716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T22:30:46.135742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-04-02T22:30:46.135767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-04-02T22:30:46.135778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-02T22:30:46.135792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-04-02T22:30:46.135803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-02T22:30:46.13728Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T22:30:46.137467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T22:30:46.137664Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T22:30:46.137755Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T22:30:46.137674Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:30:46.13753Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T22:30:46.138696Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:30:46.138843Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:30:46.138916Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:30:46.140114Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T22:30:46.142413Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-04-02T22:31:15.889772Z","caller":"traceutil/trace.go:171","msg":"trace[1142797944] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"189.470807ms","start":"2026-04-02T22:31:15.700272Z","end":"2026-04-02T22:31:15.889743Z","steps":["trace[1142797944] 'process raft request' (duration: 180.15784ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:30.413205Z","caller":"traceutil/trace.go:171","msg":"trace[34484991] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"522.979367ms","start":"2026-04-02T22:31:29.890202Z","end":"2026-04-02T22:31:30.413182Z","steps":["trace[34484991] 'process raft request' (duration: 522.825334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.413679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.890185Z","time spent":"523.100239ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:31:30.760894Z","caller":"traceutil/trace.go:171","msg":"trace[1189360475] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"861.246083ms","start":"2026-04-02T22:31:29.899605Z","end":"2026-04-02T22:31:30.760852Z","steps":["trace[1189360475] 'process raft request' (duration: 860.939268ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:30.760981Z","caller":"traceutil/trace.go:171","msg":"trace[1859922425] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"853.457104ms","start":"2026-04-02T22:31:29.907507Z","end":"2026-04-02T22:31:30.760964Z","steps":["trace[1859922425] 'process raft request' (duration: 853.190789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.761029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.899599Z","time spent":"861.372365ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:31:30.761062Z","caller":"traceutil/trace.go:171","msg":"trace[1547169891] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:520; }","duration":"814.796012ms","start":"2026-04-02T22:31:29.946247Z","end":"2026-04-02T22:31:30.761043Z","steps":["trace[1547169891] 'read index received' (duration: 466.818592ms)","trace[1547169891] 'applied index is now lower than readState.Index' (duration: 347.97658ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:31:30.761046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.90749Z","time spent":"853.524196ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:31:30.761196Z","caller":"traceutil/trace.go:171","msg":"trace[1296439319] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"862.822961ms","start":"2026-04-02T22:31:29.898364Z","end":"2026-04-02T22:31:30.761187Z","steps":["trace[1296439319] 'process raft request' (duration: 862.087088ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:30.761189Z","caller":"traceutil/trace.go:171","msg":"trace[104978840] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"854.699965ms","start":"2026-04-02T22:31:29.90646Z","end":"2026-04-02T22:31:30.76116Z","steps":["trace[104978840] 'process raft request' (duration: 854.197157ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:30.761205Z","caller":"traceutil/trace.go:171","msg":"trace[364663127] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"870.460888ms","start":"2026-04-02T22:31:29.890716Z","end":"2026-04-02T22:31:30.761177Z","steps":["trace[364663127] 'process raft request' (duration: 869.555911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.761248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.898347Z","time spent":"862.877521ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:31:30.76127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.890697Z","time spent":"870.543879ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:31:30.761226Z","caller":"traceutil/trace.go:171","msg":"trace[1314284205] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"868.559933ms","start":"2026-04-02T22:31:29.892599Z","end":"2026-04-02T22:31:30.761158Z","steps":["trace[1314284205] 'process raft request' (duration: 867.79983ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:30.761324Z","caller":"traceutil/trace.go:171","msg":"trace[2110518582] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"796.130039ms","start":"2026-04-02T22:31:29.965186Z","end":"2026-04-02T22:31:30.761316Z","steps":["trace[2110518582] 'process raft request' (duration: 795.61657ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:30.761329Z","caller":"traceutil/trace.go:171","msg":"trace[2002476738] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"844.254139ms","start":"2026-04-02T22:31:29.917068Z","end":"2026-04-02T22:31:30.761322Z","steps":["trace[2002476738] 'process raft request' (duration: 843.675599ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:30.761356Z","caller":"traceutil/trace.go:171","msg":"trace[975655928] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"708.909249ms","start":"2026-04-02T22:31:30.052438Z","end":"2026-04-02T22:31:30.761348Z","steps":["trace[975655928] 'process raft request' (duration: 708.443941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.761375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.917058Z","time spent":"844.29971ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:31:30.761373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.965164Z","time spent":"796.18865ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:31:30.76141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:30.052404Z","time spent":"708.982141ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:31:30.761437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.89259Z","time spent":"868.752736ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:31:30.760904Z","caller":"traceutil/trace.go:171","msg":"trace[1186111828] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"854.449651ms","start":"2026-04-02T22:31:29.906417Z","end":"2026-04-02T22:31:30.760867Z","steps":["trace[1186111828] 'process raft request' (duration: 854.204957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.761508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.906412Z","time spent":"855.076412ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:31:30.761276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.906455Z","time spent":"854.778267ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:31:30.761054Z","caller":"traceutil/trace.go:171","msg":"trace[1730349770] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"854.672545ms","start":"2026-04-02T22:31:29.906368Z","end":"2026-04-02T22:31:30.761041Z","steps":["trace[1730349770] 'process raft request' (duration: 854.219127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.761816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.559116ms","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-04-02T22:31:30.761921Z","caller":"traceutil/trace.go:171","msg":"trace[487196960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:509; }","duration":"815.662079ms","start":"2026-04-02T22:31:29.946215Z","end":"2026-04-02T22:31:30.761878Z","steps":["trace[487196960] 'agreement among raft nodes before linearized reading' (duration: 815.276081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.761977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.946202Z","time spent":"815.76409ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T22:31:30.76186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:29.906359Z","time spent":"855.418799ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:31:30.774382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.301198ms","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-04-02T22:31:30.774995Z","caller":"traceutil/trace.go:171","msg":"trace[1385564079] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"356.212146ms","start":"2026-04-02T22:31:30.418768Z","end":"2026-04-02T22:31:30.77498Z","steps":["trace[1385564079] 'process raft request' (duration: 351.651215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.775077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:30.41875Z","time spent":"356.282517ms","remote":"127.0.0.1:42650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:31:30.775153Z","caller":"traceutil/trace.go:171","msg":"trace[323771388] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"353.696302ms","start":"2026-04-02T22:31:30.421431Z","end":"2026-04-02T22:31:30.775127Z","steps":["trace[323771388] 'process raft request' (duration: 352.744134ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:30.775392Z","caller":"traceutil/trace.go:171","msg":"trace[1259065526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"652.41577ms","start":"2026-04-02T22:31:30.122017Z","end":"2026-04-02T22:31:30.774433Z","steps":["trace[1259065526] 'agreement among raft nodes before linearized reading' (duration: 652.214055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.775431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:30.122003Z","time spent":"653.419308ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T22:31:30.775458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:30.421423Z","time spent":"353.788313ms","remote":"127.0.0.1:42126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:31:30.776821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.71425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:30.776873Z","caller":"traceutil/trace.go:171","msg":"trace[1445589635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"435.566274ms","start":"2026-04-02T22:31:30.341294Z","end":"2026-04-02T22:31:30.77686Z","steps":["trace[1445589635] 'agreement among raft nodes before linearized reading' (duration: 433.925675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:30.776909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:30.34124Z","time spent":"435.659456ms","remote":"127.0.0.1:42088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T22:31:31.576586Z","caller":"traceutil/trace.go:171","msg":"trace[1224008337] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"274.347462ms","start":"2026-04-02T22:31:31.302194Z","end":"2026-04-02T22:31:31.576541Z","steps":["trace[1224008337] 'process raft request' (duration: 246.149599ms)","trace[1224008337] 'compare' (duration: 27.863778ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:31:31.576824Z","caller":"traceutil/trace.go:171","msg":"trace[1095477168] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"273.702912ms","start":"2026-04-02T22:31:31.303086Z","end":"2026-04-02T22:31:31.576788Z","steps":["trace[1095477168] 'read index received' (duration: 245.379225ms)","trace[1095477168] 'applied index is now lower than readState.Index' (duration: 28.319456ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:31:31.576981Z","caller":"traceutil/trace.go:171","msg":"trace[855062651] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"251.101879ms","start":"2026-04-02T22:31:31.32586Z","end":"2026-04-02T22:31:31.576962Z","steps":["trace[855062651] 'process raft request' (duration: 250.746472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:31.577126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.011907ms","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-04-02T22:31:31.577208Z","caller":"traceutil/trace.go:171","msg":"trace[1185437240] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:559; }","duration":"274.126619ms","start":"2026-04-02T22:31:31.303055Z","end":"2026-04-02T22:31:31.577182Z","steps":["trace[1185437240] 'agreement among raft nodes before linearized reading' (duration: 273.919666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:31.578131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.449932ms","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-04-02T22:31:31.578217Z","caller":"traceutil/trace.go:171","msg":"trace[784410714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:560; }","duration":"130.594865ms","start":"2026-04-02T22:31:31.447605Z","end":"2026-04-02T22:31:31.5782Z","steps":["trace[784410714] 'agreement among raft nodes before linearized reading' (duration: 130.421982ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:31.578422Z","caller":"traceutil/trace.go:171","msg":"trace[1866635068] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"102.560502ms","start":"2026-04-02T22:31:31.475844Z","end":"2026-04-02T22:31:31.578404Z","steps":["trace[1866635068] 'process raft request' (duration: 101.361621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:36.341541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.507586ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:31:36.341646Z","caller":"traceutil/trace.go:171","msg":"trace[1142345205] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"146.704461ms","start":"2026-04-02T22:31:36.194929Z","end":"2026-04-02T22:31:36.341634Z","steps":["trace[1142345205] 'process raft request' (duration: 21.978422ms)","trace[1142345205] 'compare' (duration: 124.371633ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:31:37.33586Z","caller":"traceutil/trace.go:171","msg":"trace[1211927761] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"225.131344ms","start":"2026-04-02T22:31:37.110701Z","end":"2026-04-02T22:31:37.335833Z","steps":["trace[1211927761] 'process raft request' (duration: 224.938531ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:37.426564Z","caller":"traceutil/trace.go:171","msg":"trace[380719074] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"111.789619ms","start":"2026-04-02T22:31:37.314749Z","end":"2026-04-02T22:31:37.426539Z","steps":["trace[380719074] 'process raft request' (duration: 110.973444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:38.10482Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841273916,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:31:38.807772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.376406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:31:38.807887Z","caller":"traceutil/trace.go:171","msg":"trace[734958237] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"1.203555178s","start":"2026-04-02T22:31:37.604311Z","end":"2026-04-02T22:31:38.807866Z","steps":["trace[734958237] 'read index received' (duration: 591.925738ms)","trace[734958237] 'applied index is now lower than readState.Index' (duration: 611.62803ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:31:38.808104Z","caller":"traceutil/trace.go:171","msg":"trace[586581253] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.320159923s","start":"2026-04-02T22:31:37.487926Z","end":"2026-04-02T22:31:38.808086Z","steps":["trace[586581253] 'process raft request' (duration: 708.340469ms)","trace[586581253] 'compare' (duration: 611.191073ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:31:38.808187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:37.487901Z","time spent":"1.320250895s","remote":"127.0.0.1:42348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:31:38.808429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109796864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:38.808529Z","caller":"traceutil/trace.go:171","msg":"trace[1924955951] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"1.109937236s","start":"2026-04-02T22:31:37.698568Z","end":"2026-04-02T22:31:38.808505Z","steps":["trace[1924955951] 'agreement among raft nodes before linearized reading' (duration: 1.109745893s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:38.808588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:37.698555Z","time spent":"1.110021957s","remote":"127.0.0.1:42088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T22:31:38.808947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.27792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:38.809011Z","caller":"traceutil/trace.go:171","msg":"trace[2061444041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"467.375392ms","start":"2026-04-02T22:31:38.341617Z","end":"2026-04-02T22:31:38.808993Z","steps":["trace[2061444041] 'agreement among raft nodes before linearized reading' (duration: 466.581558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:38.809045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:38.341597Z","time spent":"467.439723ms","remote":"127.0.0.1:42102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T22:31:38.809043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170943826s","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-04-02T22:31:38.809106Z","caller":"traceutil/trace.go:171","msg":"trace[1891989631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"1.171020857s","start":"2026-04-02T22:31:37.63806Z","end":"2026-04-02T22:31:38.809081Z","steps":["trace[1891989631] 'agreement among raft nodes before linearized reading' (duration: 1.170055119s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:38.809142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:37.63805Z","time spent":"1.171085159s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T22:31:38.809442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205129706s","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-04-02T22:31:38.809486Z","caller":"traceutil/trace.go:171","msg":"trace[1830537795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"1.205209408s","start":"2026-04-02T22:31:37.604264Z","end":"2026-04-02T22:31:38.809473Z","steps":["trace[1830537795] 'agreement among raft nodes before linearized reading' (duration: 1.203964145s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:38.809515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:37.604245Z","time spent":"1.205263548s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T22:31:40.593315Z","caller":"traceutil/trace.go:171","msg":"trace[1627454338] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"221.848244ms","start":"2026-04-02T22:31:40.371434Z","end":"2026-04-02T22:31:40.593282Z","steps":["trace[1627454338] 'process raft request' (duration: 221.65171ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:42.044609Z","caller":"traceutil/trace.go:171","msg":"trace[108622731] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"130.551587ms","start":"2026-04-02T22:31:41.914026Z","end":"2026-04-02T22:31:42.044577Z","steps":["trace[108622731] 'process raft request' (duration: 129.947836ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:51.272375Z","caller":"traceutil/trace.go:171","msg":"trace[2010541484] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"390.48273ms","start":"2026-04-02T22:31:50.881868Z","end":"2026-04-02T22:31:51.272351Z","steps":["trace[2010541484] 'process raft request' (duration: 390.336526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:51.272579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:50.881843Z","time spent":"390.623403ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:31:51.279325Z","caller":"traceutil/trace.go:171","msg":"trace[1052026835] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:782; }","duration":"389.540763ms","start":"2026-04-02T22:31:50.88975Z","end":"2026-04-02T22:31:51.279291Z","steps":["trace[1052026835] 'read index received' (duration: 382.375035ms)","trace[1052026835] 'applied index is now lower than readState.Index' (duration: 7.164808ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:31:51.279438Z","caller":"traceutil/trace.go:171","msg":"trace[542801100] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"396.856024ms","start":"2026-04-02T22:31:50.882573Z","end":"2026-04-02T22:31:51.279429Z","steps":["trace[542801100] 'process raft request' (duration: 396.596368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:51.27954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:50.882555Z","time spent":"396.910244ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:31:51.279722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.95496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-02T22:31:51.279755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.418178ms","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-04-02T22:31:51.279806Z","caller":"traceutil/trace.go:171","msg":"trace[1484942261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:751; }","duration":"390.069703ms","start":"2026-04-02T22:31:50.889718Z","end":"2026-04-02T22:31:51.279787Z","steps":["trace[1484942261] 'agreement among raft nodes before linearized reading' (duration: 389.841209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:51.279851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:50.889706Z","time spent":"390.134384ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T22:31:51.279859Z","caller":"traceutil/trace.go:171","msg":"trace[2016794069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:751; }","duration":"377.599121ms","start":"2026-04-02T22:31:50.902235Z","end":"2026-04-02T22:31:51.279834Z","steps":["trace[2016794069] 'agreement among raft nodes before linearized reading' (duration: 377.319356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:51.279911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:50.902223Z","time spent":"377.676722ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T22:31:51.403463Z","caller":"traceutil/trace.go:171","msg":"trace[1151006987] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"118.955261ms","start":"2026-04-02T22:31:51.28448Z","end":"2026-04-02T22:31:51.403436Z","steps":["trace[1151006987] 'process raft request' (duration: 79.63674ms)","trace[1151006987] 'compare' (duration: 39.208459ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:31:56.73832Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841274283,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T22:31:56.888111Z","caller":"traceutil/trace.go:171","msg":"trace[19116778] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"653.215362ms","start":"2026-04-02T22:31:56.234871Z","end":"2026-04-02T22:31:56.888087Z","steps":["trace[19116778] 'process raft request' (duration: 652.677183ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.888246Z","caller":"traceutil/trace.go:171","msg":"trace[1066452228] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:815; }","duration":"650.27716ms","start":"2026-04-02T22:31:56.237956Z","end":"2026-04-02T22:31:56.888233Z","steps":["trace[1066452228] 'read index received' (duration: 650.27208ms)","trace[1066452228] 'applied index is now lower than readState.Index' (duration: 3.83µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:31:56.888342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.375422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.888369Z","caller":"traceutil/trace.go:171","msg":"trace[64257693] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:780; }","duration":"650.419034ms","start":"2026-04-02T22:31:56.237941Z","end":"2026-04-02T22:31:56.888361Z","steps":["trace[64257693] 'agreement among raft nodes before linearized reading' (duration: 650.347172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.888389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.237934Z","time spent":"650.448724ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:31:56.888277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.234847Z","time spent":"653.342736ms","remote":"127.0.0.1:42348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:31:56.888496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.451024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.888609Z","caller":"traceutil/trace.go:171","msg":"trace[1168919244] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:780; }","duration":"650.600046ms","start":"2026-04-02T22:31:56.237979Z","end":"2026-04-02T22:31:56.88858Z","steps":["trace[1168919244] 'agreement among raft nodes before linearized reading' (duration: 650.378763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.888672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.237898Z","time spent":"650.761809ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:31:56.888552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.451861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.888784Z","caller":"traceutil/trace.go:171","msg":"trace[487975224] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:780; }","duration":"293.666925ms","start":"2026-04-02T22:31:56.595053Z","end":"2026-04-02T22:31:56.88872Z","steps":["trace[487975224] 'agreement among raft nodes before linearized reading' (duration: 293.346059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.888823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.736698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.88884Z","caller":"traceutil/trace.go:171","msg":"trace[1126548684] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:780; }","duration":"163.78256ms","start":"2026-04-02T22:31:56.725051Z","end":"2026-04-02T22:31:56.888834Z","steps":["trace[1126548684] 'agreement among raft nodes before linearized reading' (duration: 163.760219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.888851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.272786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.888887Z","caller":"traceutil/trace.go:171","msg":"trace[701316224] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:780; }","duration":"252.335167ms","start":"2026-04-02T22:31:56.636541Z","end":"2026-04-02T22:31:56.888876Z","steps":["trace[701316224] 'agreement among raft nodes before linearized reading' (duration: 252.277296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.888924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.897261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.888942Z","caller":"traceutil/trace.go:171","msg":"trace[479435891] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:780; }","duration":"163.934421ms","start":"2026-04-02T22:31:56.725004Z","end":"2026-04-02T22:31:56.888938Z","steps":["trace[479435891] 'agreement among raft nodes before linearized reading' (duration: 163.907661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.88899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.120167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.589169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889035Z","caller":"traceutil/trace.go:171","msg":"trace[1450539495] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:780; }","duration":"540.183898ms","start":"2026-04-02T22:31:56.34884Z","end":"2026-04-02T22:31:56.889024Z","steps":["trace[1450539495] 'agreement among raft nodes before linearized reading' (duration: 540.116357ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.889054Z","caller":"traceutil/trace.go:171","msg":"trace[346078631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:780; }","duration":"180.626769ms","start":"2026-04-02T22:31:56.708422Z","end":"2026-04-02T22:31:56.889049Z","steps":["trace[346078631] 'agreement among raft nodes before linearized reading' (duration: 180.599969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.348827Z","time spent":"540.230409ms","remote":"127.0.0.1:37302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:31:56.889084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.002494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889122Z","caller":"traceutil/trace.go:171","msg":"trace[1031704703] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:780; }","duration":"237.095005ms","start":"2026-04-02T22:31:56.652018Z","end":"2026-04-02T22:31:56.889113Z","steps":["trace[1031704703] 'agreement among raft nodes before linearized reading' (duration: 237.048145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.88915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.122352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889173Z","caller":"traceutil/trace.go:171","msg":"trace[756602003] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:780; }","duration":"202.151632ms","start":"2026-04-02T22:31:56.687013Z","end":"2026-04-02T22:31:56.889164Z","steps":["trace[756602003] 'agreement among raft nodes before linearized reading' (duration: 202.118422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.888794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.042017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.88927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.71115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889304Z","caller":"traceutil/trace.go:171","msg":"trace[466202102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"548.785572ms","start":"2026-04-02T22:31:56.34051Z","end":"2026-04-02T22:31:56.889296Z","steps":["trace[466202102] 'agreement among raft nodes before linearized reading' (duration: 548.743721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.167781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889334Z","caller":"traceutil/trace.go:171","msg":"trace[270024969] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:780; }","duration":"203.198491ms","start":"2026-04-02T22:31:56.68613Z","end":"2026-04-02T22:31:56.889328Z","steps":["trace[270024969] 'agreement among raft nodes before linearized reading' (duration: 203.166851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.346539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.31087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889391Z","caller":"traceutil/trace.go:171","msg":"trace[768462590] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:780; }","duration":"564.371389ms","start":"2026-04-02T22:31:56.325012Z","end":"2026-04-02T22:31:56.889383Z","steps":["trace[768462590] 'agreement among raft nodes before linearized reading' (duration: 564.335219ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.889402Z","caller":"traceutil/trace.go:171","msg":"trace[1119902890] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:780; }","duration":"237.36575ms","start":"2026-04-02T22:31:56.652026Z","end":"2026-04-02T22:31:56.889392Z","steps":["trace[1119902890] 'agreement among raft nodes before linearized reading' (duration: 237.307379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.547588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.325001Z","time spent":"564.41501ms","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:31:56.889448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.057309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.072442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889558Z","caller":"traceutil/trace.go:171","msg":"trace[2084266893] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:780; }","duration":"272.206911ms","start":"2026-04-02T22:31:56.617339Z","end":"2026-04-02T22:31:56.889546Z","steps":["trace[2084266893] 'agreement among raft nodes before linearized reading' (duration: 271.973107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.867587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.88964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.621575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889681Z","caller":"traceutil/trace.go:171","msg":"trace[2021592331] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:780; }","duration":"591.701027ms","start":"2026-04-02T22:31:56.29797Z","end":"2026-04-02T22:31:56.889671Z","steps":["trace[2021592331] 'agreement among raft nodes before linearized reading' (duration: 591.644696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.297951Z","time spent":"591.752198ms","remote":"127.0.0.1:37266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:31:56.888697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.016611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889829Z","caller":"traceutil/trace.go:171","msg":"trace[931137713] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:780; }","duration":"221.167762ms","start":"2026-04-02T22:31:56.668655Z","end":"2026-04-02T22:31:56.889823Z","steps":["trace[931137713] 'agreement among raft nodes before linearized reading' (duration: 220.020961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.341785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.24313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.888799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.023525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889966Z","caller":"traceutil/trace.go:171","msg":"trace[2032727547] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:780; }","duration":"273.286981ms","start":"2026-04-02T22:31:56.616673Z","end":"2026-04-02T22:31:56.889961Z","steps":["trace[2032727547] 'agreement among raft nodes before linearized reading' (duration: 273.25022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.442935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.472458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889642Z","caller":"traceutil/trace.go:171","msg":"trace[1231260574] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:780; }","duration":"252.943038ms","start":"2026-04-02T22:31:56.636692Z","end":"2026-04-02T22:31:56.889635Z","steps":["trace[1231260574] 'agreement among raft nodes before linearized reading' (duration: 252.895678ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.890017Z","caller":"traceutil/trace.go:171","msg":"trace[1373806974] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:780; }","duration":"593.520679ms","start":"2026-04-02T22:31:56.296489Z","end":"2026-04-02T22:31:56.890009Z","steps":["trace[1373806974] 'agreement among raft nodes before linearized reading' (duration: 593.467618ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.889937Z","caller":"traceutil/trace.go:171","msg":"trace[1174515716] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:780; }","duration":"593.429247ms","start":"2026-04-02T22:31:56.296499Z","end":"2026-04-02T22:31:56.889928Z","steps":["trace[1174515716] 'agreement among raft nodes before linearized reading' (duration: 593.345556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.890074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.296483Z","time spent":"593.57307ms","remote":"127.0.0.1:37278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:31:56.890097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.296487Z","time spent":"593.60183ms","remote":"127.0.0.1:37278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-02T22:31:56.890037Z","caller":"traceutil/trace.go:171","msg":"trace[1807537196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:780; }","duration":"164.218096ms","start":"2026-04-02T22:31:56.72576Z","end":"2026-04-02T22:31:56.889978Z","steps":["trace[1807537196] 'agreement among raft nodes before linearized reading' (duration: 163.025405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.890099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.914157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.839736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.890173Z","caller":"traceutil/trace.go:171","msg":"trace[1995466297] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:780; }","duration":"221.478198ms","start":"2026-04-02T22:31:56.668689Z","end":"2026-04-02T22:31:56.890167Z","steps":["trace[1995466297] 'agreement among raft nodes before linearized reading' (duration: 220.840556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.89019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.611339ms","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":"warn","ts":"2026-04-02T22:31:56.88933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.34049Z","time spent":"548.835092ms","remote":"127.0.0.1:42088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T22:31:56.890221Z","caller":"traceutil/trace.go:171","msg":"trace[173156164] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:780; }","duration":"594.666449ms","start":"2026-04-02T22:31:56.295547Z","end":"2026-04-02T22:31:56.890213Z","steps":["trace[173156164] 'agreement among raft nodes before linearized reading' (duration: 594.535677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.890236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.651892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.889567Z","caller":"traceutil/trace.go:171","msg":"trace[713402502] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:780; }","duration":"252.136854ms","start":"2026-04-02T22:31:56.63742Z","end":"2026-04-02T22:31:56.889557Z","steps":["trace[713402502] 'agreement among raft nodes before linearized reading' (duration: 252.085583ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.890259Z","caller":"traceutil/trace.go:171","msg":"trace[163545466] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:780; }","duration":"294.671392ms","start":"2026-04-02T22:31:56.595579Z","end":"2026-04-02T22:31:56.89025Z","steps":["trace[163545466] 'agreement among raft nodes before linearized reading' (duration: 294.644872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.890303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.313895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.608298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.273247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.890345Z","caller":"traceutil/trace.go:171","msg":"trace[181770311] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:780; }","duration":"621.368545ms","start":"2026-04-02T22:31:56.268958Z","end":"2026-04-02T22:31:56.890326Z","steps":["trace[181770311] 'agreement among raft nodes before linearized reading' (duration: 621.320724ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.890359Z","caller":"traceutil/trace.go:171","msg":"trace[642076267] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:780; }","duration":"220.114673ms","start":"2026-04-02T22:31:56.670238Z","end":"2026-04-02T22:31:56.890352Z","steps":["trace[642076267] 'agreement among raft nodes before linearized reading' (duration: 219.265277ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.890359Z","caller":"traceutil/trace.go:171","msg":"trace[2070210512] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:780; }","duration":"301.163688ms","start":"2026-04-02T22:31:56.589183Z","end":"2026-04-02T22:31:56.890347Z","steps":["trace[2070210512] 'agreement among raft nodes before linearized reading' (duration: 300.444825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.890379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.268949Z","time spent":"621.421546ms","remote":"127.0.0.1:37266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:31:56.890396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.589181Z","time spent":"301.203448ms","remote":"127.0.0.1:37356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:31:56.889486Z","caller":"traceutil/trace.go:171","msg":"trace[665356543] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:780; }","duration":"539.584427ms","start":"2026-04-02T22:31:56.349679Z","end":"2026-04-02T22:31:56.889263Z","steps":["trace[665356543] 'agreement among raft nodes before linearized reading' (duration: 538.881795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.890249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.295531Z","time spent":"594.71136ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T22:31:56.890511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.34965Z","time spent":"540.813479ms","remote":"127.0.0.1:37302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:31:56.89053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.738932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.890564Z","caller":"traceutil/trace.go:171","msg":"trace[1287911677] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:780; }","duration":"621.796423ms","start":"2026-04-02T22:31:56.268759Z","end":"2026-04-02T22:31:56.890556Z","steps":["trace[1287911677] 'agreement among raft nodes before linearized reading' (duration: 621.745532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.582453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.890598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.268747Z","time spent":"621.843614ms","remote":"127.0.0.1:37266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-02T22:31:56.890611Z","caller":"traceutil/trace.go:171","msg":"trace[753548632] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:780; }","duration":"565.618012ms","start":"2026-04-02T22:31:56.324983Z","end":"2026-04-02T22:31:56.890602Z","steps":["trace[753548632] 'agreement among raft nodes before linearized reading' (duration: 564.568523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.89065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.324978Z","time spent":"565.659243ms","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:31:56.890712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.446079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.889012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.520868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.890746Z","caller":"traceutil/trace.go:171","msg":"trace[1762499085] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:780; }","duration":"652.49958ms","start":"2026-04-02T22:31:56.238237Z","end":"2026-04-02T22:31:56.890737Z","steps":["trace[1762499085] 'agreement among raft nodes before linearized reading' (duration: 652.454059ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.890763Z","caller":"traceutil/trace.go:171","msg":"trace[1900876175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:780; }","duration":"182.294999ms","start":"2026-04-02T22:31:56.70846Z","end":"2026-04-02T22:31:56.890755Z","steps":["trace[1900876175] 'agreement among raft nodes before linearized reading' (duration: 180.536307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.890777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.238226Z","time spent":"652.540781ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:31:56.89021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.566336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.890853Z","caller":"traceutil/trace.go:171","msg":"trace[1552867507] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:780; }","duration":"274.227757ms","start":"2026-04-02T22:31:56.616618Z","end":"2026-04-02T22:31:56.890846Z","steps":["trace[1552867507] 'agreement among raft nodes before linearized reading' (duration: 273.570236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.429712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.890166Z","caller":"traceutil/trace.go:171","msg":"trace[1835304992] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:780; }","duration":"295.041649ms","start":"2026-04-02T22:31:56.59511Z","end":"2026-04-02T22:31:56.890152Z","steps":["trace[1835304992] 'agreement among raft nodes before linearized reading' (duration: 294.890797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.889046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.859761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.89091Z","caller":"traceutil/trace.go:171","msg":"trace[1280515242] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:780; }","duration":"542.111482ms","start":"2026-04-02T22:31:56.348783Z","end":"2026-04-02T22:31:56.890894Z","steps":["trace[1280515242] 'agreement among raft nodes before linearized reading' (duration: 540.426982ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.889489Z","caller":"traceutil/trace.go:171","msg":"trace[1361059517] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:780; }","duration":"203.580528ms","start":"2026-04-02T22:31:56.685842Z","end":"2026-04-02T22:31:56.889423Z","steps":["trace[1361059517] 'agreement among raft nodes before linearized reading' (duration: 203.552837ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.890978Z","caller":"traceutil/trace.go:171","msg":"trace[355581943] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:780; }","duration":"238.794616ms","start":"2026-04-02T22:31:56.652176Z","end":"2026-04-02T22:31:56.89097Z","steps":["trace[355581943] 'agreement among raft nodes before linearized reading' (duration: 236.842891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.348775Z","time spent":"542.208914ms","remote":"127.0.0.1:37302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:31:56.891234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.071415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.891258Z","caller":"traceutil/trace.go:171","msg":"trace[792305898] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:780; }","duration":"302.115855ms","start":"2026-04-02T22:31:56.589136Z","end":"2026-04-02T22:31:56.891252Z","steps":["trace[792305898] 'agreement among raft nodes before linearized reading' (duration: 302.080954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.26206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.891254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.064904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.891275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.58912Z","time spent":"302.149275ms","remote":"127.0.0.1:37356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"info","ts":"2026-04-02T22:31:56.891279Z","caller":"traceutil/trace.go:171","msg":"trace[222919017] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:780; }","duration":"439.29648ms","start":"2026-04-02T22:31:56.451977Z","end":"2026-04-02T22:31:56.891273Z","steps":["trace[222919017] 'agreement among raft nodes before linearized reading' (duration: 439.25481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.803456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.891289Z","caller":"traceutil/trace.go:171","msg":"trace[2101409651] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:780; }","duration":"302.102005ms","start":"2026-04-02T22:31:56.589177Z","end":"2026-04-02T22:31:56.891279Z","steps":["trace[2101409651] 'agreement among raft nodes before linearized reading' (duration: 302.049064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.45197Z","time spent":"439.323741ms","remote":"127.0.0.1:37340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:31:56.891326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.589166Z","time spent":"302.152645ms","remote":"127.0.0.1:37356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"info","ts":"2026-04-02T22:31:56.891325Z","caller":"traceutil/trace.go:171","msg":"trace[517492535] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:780; }","duration":"459.870597ms","start":"2026-04-02T22:31:56.431443Z","end":"2026-04-02T22:31:56.891313Z","steps":["trace[517492535] 'agreement among raft nodes before linearized reading' (duration: 459.803536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.471709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.891394Z","caller":"traceutil/trace.go:171","msg":"trace[1798638856] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:780; }","duration":"459.568521ms","start":"2026-04-02T22:31:56.431818Z","end":"2026-04-02T22:31:56.891387Z","steps":["trace[1798638856] 'agreement among raft nodes before linearized reading' (duration: 459.525171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.431429Z","time spent":"459.939118ms","remote":"127.0.0.1:37326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:31:56.891424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.431792Z","time spent":"459.623902ms","remote":"127.0.0.1:37326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:31:56.89148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.76883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.891508Z","caller":"traceutil/trace.go:171","msg":"trace[1669409850] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:780; }","duration":"498.8066ms","start":"2026-04-02T22:31:56.392694Z","end":"2026-04-02T22:31:56.891501Z","steps":["trace[1669409850] 'agreement among raft nodes before linearized reading' (duration: 498.76687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.852481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:31:56.891527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.392687Z","time spent":"498.834621ms","remote":"127.0.0.1:37314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:31:56.891535Z","caller":"traceutil/trace.go:171","msg":"trace[1592467992] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:780; }","duration":"498.888302ms","start":"2026-04-02T22:31:56.392641Z","end":"2026-04-02T22:31:56.891529Z","steps":["trace[1592467992] 'agreement among raft nodes before linearized reading' (duration: 498.856911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.39263Z","time spent":"498.917312ms","remote":"127.0.0.1:37314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-02T22:31:56.891602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.936411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.89162Z","caller":"traceutil/trace.go:171","msg":"trace[375357929] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:780; }","duration":"439.992272ms","start":"2026-04-02T22:31:56.451623Z","end":"2026-04-02T22:31:56.891615Z","steps":["trace[375357929] 'agreement among raft nodes before linearized reading' (duration: 439.963302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.451598Z","time spent":"440.032162ms","remote":"127.0.0.1:37340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:31:56.891741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.352067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:31:56.891774Z","caller":"traceutil/trace.go:171","msg":"trace[540538667] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:780; }","duration":"459.402158ms","start":"2026-04-02T22:31:56.432363Z","end":"2026-04-02T22:31:56.891765Z","steps":["trace[540538667] 'agreement among raft nodes before linearized reading' (duration: 459.339397ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:31:56.889993Z","caller":"traceutil/trace.go:171","msg":"trace[104735904] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:780; }","duration":"438.502815ms","start":"2026-04-02T22:31:56.45148Z","end":"2026-04-02T22:31:56.889983Z","steps":["trace[104735904] 'agreement among raft nodes before linearized reading' (duration: 438.450645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:31:56.891794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.432355Z","time spent":"459.433868ms","remote":"127.0.0.1:37314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-02T22:31:56.891835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:31:56.451467Z","time spent":"440.352328ms","remote":"127.0.0.1:37340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-04-02T22:32:31.353592Z","caller":"traceutil/trace.go:171","msg":"trace[7299001] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"217.853012ms","start":"2026-04-02T22:32:31.135711Z","end":"2026-04-02T22:32:31.353564Z","steps":["trace[7299001] 'process raft request' (duration: 217.689289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:32.842241Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841274746,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:32:33.342727Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841274746,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:32:33.524167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.67638666s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:32:33.524286Z","caller":"traceutil/trace.go:171","msg":"trace[316891095] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"1.911944338s","start":"2026-04-02T22:32:31.612317Z","end":"2026-04-02T22:32:33.524262Z","steps":["trace[316891095] 'process raft request' (duration: 235.338895ms)","trace[316891095] 'compare' (duration: 1.67586548s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:32:33.524397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:31.612287Z","time spent":"1.91205467s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:32:33.843163Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841274746,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:32:33.940974Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.796249506s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T22:32:34.028275Z","caller":"traceutil/trace.go:171","msg":"trace[1004536380] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"2.415191798s","start":"2026-04-02T22:32:31.613058Z","end":"2026-04-02T22:32:34.02825Z","steps":["trace[1004536380] 'process raft request' (duration: 2.328151735s)","trace[1004536380] 'compare' (duration: 86.757037ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:32:34.028417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:31.613035Z","time spent":"2.415310119s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:32:34.028691Z","caller":"traceutil/trace.go:171","msg":"trace[1704639024] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"2.415294s","start":"2026-04-02T22:32:31.613373Z","end":"2026-04-02T22:32:34.028667Z","steps":["trace[1704639024] 'process raft request' (duration: 2.414777251s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:34.028838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:31.613364Z","time spent":"2.415400241s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:32:34.02902Z","caller":"traceutil/trace.go:171","msg":"trace[1328411428] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"1.022519944s","start":"2026-04-02T22:32:33.00648Z","end":"2026-04-02T22:32:34.029Z","steps":["trace[1328411428] 'process raft request' (duration: 1.022397102s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:34.029026Z","caller":"traceutil/trace.go:171","msg":"trace[548225992] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"2.413695911s","start":"2026-04-02T22:32:31.615293Z","end":"2026-04-02T22:32:34.028989Z","steps":["trace[548225992] 'process raft request' (duration: 2.413307185s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:34.029062Z","caller":"traceutil/trace.go:171","msg":"trace[2057954136] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1039; }","duration":"1.687626799s","start":"2026-04-02T22:32:32.341414Z","end":"2026-04-02T22:32:34.029041Z","steps":["trace[2057954136] 'read index received' (duration: 1.599759323s)","trace[2057954136] 'applied index is now lower than readState.Index' (duration: 87.864906ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:32:34.029086Z","caller":"traceutil/trace.go:171","msg":"trace[1652107919] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"415.72689ms","start":"2026-04-02T22:32:33.613324Z","end":"2026-04-02T22:32:34.02905Z","steps":["trace[1652107919] 'process raft request' (duration: 415.632559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:34.029111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:33.006447Z","time spent":"1.022623077s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:32:34.029183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:33.6133Z","time spent":"415.836702ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:32:34.029186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:31.615285Z","time spent":"2.413811703s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:32:34.029207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.687860834s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:32:34.029244Z","caller":"traceutil/trace.go:171","msg":"trace[1275160597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1002; }","duration":"1.687944255s","start":"2026-04-02T22:32:32.341288Z","end":"2026-04-02T22:32:34.029232Z","steps":["trace[1275160597] 'agreement among raft nodes before linearized reading' (duration: 1.687851254s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:34.029255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470394578s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:32:34.029283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:32.341266Z","time spent":"1.688010696s","remote":"127.0.0.1:42088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T22:32:34.029294Z","caller":"traceutil/trace.go:171","msg":"trace[1189209312] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1002; }","duration":"1.470468329s","start":"2026-04-02T22:32:32.558813Z","end":"2026-04-02T22:32:34.029282Z","steps":["trace[1189209312] 'agreement among raft nodes before linearized reading' (duration: 1.470411858s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:34.029322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:32.558777Z","time spent":"1.47053787s","remote":"127.0.0.1:42348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:32:34.029391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.16078615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-02T22:32:34.029401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.313903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-02T22:32:34.029434Z","caller":"traceutil/trace.go:171","msg":"trace[2045857361] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1002; }","duration":"1.160862121s","start":"2026-04-02T22:32:32.868561Z","end":"2026-04-02T22:32:34.029423Z","steps":["trace[2045857361] 'agreement among raft nodes before linearized reading' (duration: 1.16079763s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:34.029462Z","caller":"traceutil/trace.go:171","msg":"trace[1276180465] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1002; }","duration":"672.403284ms","start":"2026-04-02T22:32:33.357047Z","end":"2026-04-02T22:32:34.02945Z","steps":["trace[1276180465] 'agreement among raft nodes before linearized reading' (duration: 672.226781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:34.029466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:32.868543Z","time spent":"1.160916052s","remote":"127.0.0.1:42606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:32:34.029501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:33.357034Z","time spent":"672.459117ms","remote":"127.0.0.1:42370","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-04-02T22:32:34.029593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.246189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:32:34.029648Z","caller":"traceutil/trace.go:171","msg":"trace[1634173159] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1002; }","duration":"545.32854ms","start":"2026-04-02T22:32:33.484309Z","end":"2026-04-02T22:32:34.029638Z","steps":["trace[1634173159] 'agreement among raft nodes before linearized reading' (duration: 545.253879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:34.029686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:33.484294Z","time spent":"545.382821ms","remote":"127.0.0.1:42502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:32:52.280121Z","caller":"traceutil/trace.go:171","msg":"trace[1717964987] linearizableReadLoop","detail":"{readStateIndex:1104; appliedIndex:1103; }","duration":"169.90186ms","start":"2026-04-02T22:32:52.110202Z","end":"2026-04-02T22:32:52.280104Z","steps":["trace[1717964987] 'read index received' (duration: 169.662406ms)","trace[1717964987] 'applied index is now lower than readState.Index' (duration: 238.474µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:32:52.280284Z","caller":"traceutil/trace.go:171","msg":"trace[1554241262] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"180.777799ms","start":"2026-04-02T22:32:52.099473Z","end":"2026-04-02T22:32:52.280251Z","steps":["trace[1554241262] 'process raft request' (duration: 180.476653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:52.280353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.82489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-02T22:32:52.280381Z","caller":"traceutil/trace.go:171","msg":"trace[262136432] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1058; }","duration":"152.887711ms","start":"2026-04-02T22:32:52.127486Z","end":"2026-04-02T22:32:52.280374Z","steps":["trace[262136432] 'agreement among raft nodes before linearized reading' (duration: 152.765738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:52.280398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.209896ms","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-04-02T22:32:52.280472Z","caller":"traceutil/trace.go:171","msg":"trace[1641424727] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1058; }","duration":"170.324529ms","start":"2026-04-02T22:32:52.110129Z","end":"2026-04-02T22:32:52.280453Z","steps":["trace[1641424727] 'agreement among raft nodes before linearized reading' (duration: 170.080585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:52.280532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.258358ms","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-04-02T22:32:52.280569Z","caller":"traceutil/trace.go:171","msg":"trace[948479087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1058; }","duration":"158.347579ms","start":"2026-04-02T22:32:52.12221Z","end":"2026-04-02T22:32:52.280557Z","steps":["trace[948479087] 'agreement among raft nodes before linearized reading' (duration: 158.001493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:52.280619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.452979ms","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-04-02T22:32:52.280735Z","caller":"traceutil/trace.go:171","msg":"trace[220863042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1058; }","duration":"154.623222ms","start":"2026-04-02T22:32:52.126082Z","end":"2026-04-02T22:32:52.280706Z","steps":["trace[220863042] 'agreement among raft nodes before linearized reading' (duration: 154.176135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:56.058893Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.4914958s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T22:32:56.059399Z","caller":"traceutil/trace.go:171","msg":"trace[645068937] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1115; }","duration":"431.103707ms","start":"2026-04-02T22:32:55.628271Z","end":"2026-04-02T22:32:56.059375Z","steps":["trace[645068937] 'read index received' (duration: 430.936854ms)","trace[645068937] 'applied index is now lower than readState.Index' (duration: 163.463µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:32:56.059485Z","caller":"traceutil/trace.go:171","msg":"trace[512667956] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"1.492190614s","start":"2026-04-02T22:32:54.567264Z","end":"2026-04-02T22:32:56.059454Z","steps":["trace[512667956] 'process raft request' (duration: 1.49194832s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:56.059635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:54.56724Z","time spent":"1.492314606s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:32:56.059644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.351441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:32:56.059764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.132812ms","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-04-02T22:32:56.059762Z","caller":"traceutil/trace.go:171","msg":"trace[1543474612] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1069; }","duration":"431.486334ms","start":"2026-04-02T22:32:55.628225Z","end":"2026-04-02T22:32:56.059711Z","steps":["trace[1543474612] 'agreement among raft nodes before linearized reading' (duration: 431.360372ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:56.059804Z","caller":"traceutil/trace.go:171","msg":"trace[2020759220] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1069; }","duration":"406.202853ms","start":"2026-04-02T22:32:55.65359Z","end":"2026-04-02T22:32:56.059793Z","steps":["trace[2020759220] 'agreement among raft nodes before linearized reading' (duration: 406.082341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:56.05985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:55.653572Z","time spent":"406.270284ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T22:32:56.059867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:55.628204Z","time spent":"431.634336ms","remote":"127.0.0.1:42392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:32:56.47776Z","caller":"traceutil/trace.go:171","msg":"trace[1930821034] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"146.167697ms","start":"2026-04-02T22:32:56.331566Z","end":"2026-04-02T22:32:56.477734Z","steps":["trace[1930821034] 'process raft request' (duration: 49.051525ms)","trace[1930821034] 'compare' (duration: 96.960879ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:32:56.51599Z","caller":"traceutil/trace.go:171","msg":"trace[396199062] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1118; }","duration":"176.955259ms","start":"2026-04-02T22:32:56.33901Z","end":"2026-04-02T22:32:56.515965Z","steps":["trace[396199062] 'read index received' (duration: 41.590059ms)","trace[396199062] 'applied index is now lower than readState.Index' (duration: 135.36432ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:32:56.516208Z","caller":"traceutil/trace.go:171","msg":"trace[880899369] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"182.869067ms","start":"2026-04-02T22:32:56.333328Z","end":"2026-04-02T22:32:56.516197Z","steps":["trace[880899369] 'process raft request' (duration: 182.596432ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:56.516197Z","caller":"traceutil/trace.go:171","msg":"trace[1354327937] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"183.578ms","start":"2026-04-02T22:32:56.332591Z","end":"2026-04-02T22:32:56.516169Z","steps":["trace[1354327937] 'process raft request' (duration: 183.253464ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:56.51613Z","caller":"traceutil/trace.go:171","msg":"trace[1319699308] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"183.853914ms","start":"2026-04-02T22:32:56.33224Z","end":"2026-04-02T22:32:56.516093Z","steps":["trace[1319699308] 'process raft request' (duration: 183.464987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:56.516607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.54066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:32:56.516681Z","caller":"traceutil/trace.go:171","msg":"trace[425769409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1075; }","duration":"177.683292ms","start":"2026-04-02T22:32:56.338981Z","end":"2026-04-02T22:32:56.516665Z","steps":["trace[425769409] 'agreement among raft nodes before linearized reading' (duration: 177.52819ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:58.437052Z","caller":"traceutil/trace.go:171","msg":"trace[374947875] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"312.505902ms","start":"2026-04-02T22:32:58.124521Z","end":"2026-04-02T22:32:58.437027Z","steps":["trace[374947875] 'process raft request' (duration: 312.34899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:58.437226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:58.124496Z","time spent":"312.627834ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:32:58.679983Z","caller":"traceutil/trace.go:171","msg":"trace[1992652137] linearizableReadLoop","detail":"{readStateIndex:1124; appliedIndex:1122; }","duration":"338.651881ms","start":"2026-04-02T22:32:58.341304Z","end":"2026-04-02T22:32:58.679956Z","steps":["trace[1992652137] 'read index received' (duration: 95.592496ms)","trace[1992652137] 'applied index is now lower than readState.Index' (duration: 243.058475ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:32:58.680041Z","caller":"traceutil/trace.go:171","msg":"trace[928754558] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"362.112187ms","start":"2026-04-02T22:32:58.317858Z","end":"2026-04-02T22:32:58.67997Z","steps":["trace[928754558] 'process raft request' (duration: 296.791826ms)","trace[928754558] 'compare' (duration: 65.166818ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:32:58.680219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:58.317824Z","time spent":"362.328021ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:32:58.680247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.895166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:32:58.680413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.53236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-02T22:32:58.680416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.018521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T22:32:58.680425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.861859ms","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-04-02T22:32:58.680445Z","caller":"traceutil/trace.go:171","msg":"trace[1910736490] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1077; }","duration":"160.595611ms","start":"2026-04-02T22:32:58.51984Z","end":"2026-04-02T22:32:58.680436Z","steps":["trace[1910736490] 'agreement among raft nodes before linearized reading' (duration: 160.50878ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:58.680468Z","caller":"traceutil/trace.go:171","msg":"trace[1308448756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1077; }","duration":"199.113434ms","start":"2026-04-02T22:32:58.481338Z","end":"2026-04-02T22:32:58.680452Z","steps":["trace[1308448756] 'agreement among raft nodes before linearized reading' (duration: 198.934161ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:58.680451Z","caller":"traceutil/trace.go:171","msg":"trace[864265076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1077; }","duration":"339.085899ms","start":"2026-04-02T22:32:58.341288Z","end":"2026-04-02T22:32:58.680373Z","steps":["trace[864265076] 'agreement among raft nodes before linearized reading' (duration: 338.852274ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:58.680472Z","caller":"traceutil/trace.go:171","msg":"trace[1620071940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1077; }","duration":"159.94299ms","start":"2026-04-02T22:32:58.520519Z","end":"2026-04-02T22:32:58.680462Z","steps":["trace[1620071940] 'agreement among raft nodes before linearized reading' (duration: 159.816987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:58.680893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.349137ms","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-04-02T22:32:58.681129Z","caller":"traceutil/trace.go:171","msg":"trace[1837016591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1077; }","duration":"160.641572ms","start":"2026-04-02T22:32:58.520466Z","end":"2026-04-02T22:32:58.681108Z","steps":["trace[1837016591] 'agreement among raft nodes before linearized reading' (duration: 159.843298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:32:58.68053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:32:58.341226Z","time spent":"339.291933ms","remote":"127.0.0.1:42102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T22:32:58.972985Z","caller":"traceutil/trace.go:171","msg":"trace[2070043281] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"280.097542ms","start":"2026-04-02T22:32:58.692858Z","end":"2026-04-02T22:32:58.972955Z","steps":["trace[2070043281] 'process raft request' (duration: 280.031281ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:58.972998Z","caller":"traceutil/trace.go:171","msg":"trace[520868080] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"280.266406ms","start":"2026-04-02T22:32:58.69271Z","end":"2026-04-02T22:32:58.972976Z","steps":["trace[520868080] 'process raft request' (duration: 279.99087ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:32:58.973074Z","caller":"traceutil/trace.go:171","msg":"trace[1248574236] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"280.222375ms","start":"2026-04-02T22:32:58.692804Z","end":"2026-04-02T22:32:58.973026Z","steps":["trace[1248574236] 'process raft request' (duration: 280.043842ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:01.229682Z","caller":"traceutil/trace.go:171","msg":"trace[2047674405] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"251.829625ms","start":"2026-04-02T22:33:00.977829Z","end":"2026-04-02T22:33:01.229658Z","steps":["trace[2047674405] 'read index received' (duration: 251.642291ms)","trace[2047674405] 'applied index is now lower than readState.Index' (duration: 186.434µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:33:01.229823Z","caller":"traceutil/trace.go:171","msg":"trace[1371608118] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"395.270103ms","start":"2026-04-02T22:33:00.834512Z","end":"2026-04-02T22:33:01.229782Z","steps":["trace[1371608118] 'process raft request' (duration: 395.017918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:01.229889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.041269ms","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-04-02T22:33:01.229952Z","caller":"traceutil/trace.go:171","msg":"trace[4968132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1086; }","duration":"252.156522ms","start":"2026-04-02T22:33:00.977785Z","end":"2026-04-02T22:33:01.229942Z","steps":["trace[4968132] 'agreement among raft nodes before linearized reading' (duration: 251.988918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:01.230054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.040019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-02T22:33:01.230071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:00.834498Z","time spent":"395.462427ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:33:01.230133Z","caller":"traceutil/trace.go:171","msg":"trace[2033994444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1086; }","duration":"252.149211ms","start":"2026-04-02T22:33:00.977952Z","end":"2026-04-02T22:33:01.230101Z","steps":["trace[2033994444] 'agreement among raft nodes before linearized reading' (duration: 251.889157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:01.230163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.989698ms","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-04-02T22:33:01.230216Z","caller":"traceutil/trace.go:171","msg":"trace[313399483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1086; }","duration":"252.09058ms","start":"2026-04-02T22:33:00.978113Z","end":"2026-04-02T22:33:01.230204Z","steps":["trace[313399483] 'agreement among raft nodes before linearized reading' (duration: 251.885717ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:05.362853Z","caller":"traceutil/trace.go:171","msg":"trace[1577572015] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"113.249457ms","start":"2026-04-02T22:33:05.249576Z","end":"2026-04-02T22:33:05.362825Z","steps":["trace[1577572015] 'process raft request' (duration: 113.089814ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:05.589151Z","caller":"traceutil/trace.go:171","msg":"trace[978258796] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"220.76493ms","start":"2026-04-02T22:33:05.368362Z","end":"2026-04-02T22:33:05.589127Z","steps":["trace[978258796] 'process raft request' (duration: 220.682179ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:05.589165Z","caller":"traceutil/trace.go:171","msg":"trace[591377942] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"220.78904ms","start":"2026-04-02T22:33:05.368345Z","end":"2026-04-02T22:33:05.589134Z","steps":["trace[591377942] 'process raft request' (duration: 150.763552ms)","trace[591377942] 'compare' (duration: 69.713663ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:33:06.885666Z","caller":"traceutil/trace.go:171","msg":"trace[223735474] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"144.955516ms","start":"2026-04-02T22:33:06.74067Z","end":"2026-04-02T22:33:06.885625Z","steps":["trace[223735474] 'process raft request' (duration: 144.828944ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:16.65902Z","caller":"traceutil/trace.go:171","msg":"trace[1073811675] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"242.825121ms","start":"2026-04-02T22:33:16.416166Z","end":"2026-04-02T22:33:16.658991Z","steps":["trace[1073811675] 'process raft request' (duration: 242.644568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:18.002952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841275190,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:33:18.503989Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841275190,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:33:19.005102Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841275190,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:33:19.505681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841275190,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:33:19.696483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00003349s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-02T22:33:19.696579Z","caller":"traceutil/trace.go:171","msg":"trace[471042371] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000181122s","start":"2026-04-02T22:33:17.696376Z","end":"2026-04-02T22:33:19.696557Z","steps":["trace[471042371] 'agreement among raft nodes before linearized reading' (duration: 2.00006695s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:19.696647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:17.696356Z","time spent":"2.000277185s","remote":"127.0.0.1:42088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/02 22:33:19 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-02T22:33:20.006583Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898313841275190,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T22:33:20.030934Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.569647845s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T22:33:20.031298Z","caller":"traceutil/trace.go:171","msg":"trace[621020752] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"2.570062893s","start":"2026-04-02T22:33:17.461216Z","end":"2026-04-02T22:33:20.031279Z","steps":["trace[621020752] 'process raft request' (duration: 2.569948891s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.031423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:17.461206Z","time spent":"2.570161804s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:33:20.033801Z","caller":"traceutil/trace.go:171","msg":"trace[1193971202] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"1.063337276s","start":"2026-04-02T22:33:18.97044Z","end":"2026-04-02T22:33:20.033777Z","steps":["trace[1193971202] 'process raft request' (duration: 1.063176343s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.033975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:18.970422Z","time spent":"1.063443738s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:33:20.033969Z","caller":"traceutil/trace.go:171","msg":"trace[485487693] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1241; }","duration":"2.531914227s","start":"2026-04-02T22:33:17.502032Z","end":"2026-04-02T22:33:20.033946Z","steps":["trace[485487693] 'read index received' (duration: 2.529118715s)","trace[485487693] 'applied index is now lower than readState.Index' (duration: 2.786182ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:33:20.03404Z","caller":"traceutil/trace.go:171","msg":"trace[232279415] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"334.002826ms","start":"2026-04-02T22:33:19.699985Z","end":"2026-04-02T22:33:20.033987Z","steps":["trace[232279415] 'process raft request' (duration: 333.751792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.034159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.53213039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T22:33:20.03417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.69536025s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:20.034196Z","caller":"traceutil/trace.go:171","msg":"trace[1096371005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1191; }","duration":"2.532202692s","start":"2026-04-02T22:33:17.501983Z","end":"2026-04-02T22:33:20.034186Z","steps":["trace[1096371005] 'agreement among raft nodes before linearized reading' (duration: 2.53206802s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.034216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:17.501964Z","time spent":"2.532247522s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T22:33:20.03421Z","caller":"traceutil/trace.go:171","msg":"trace[25575692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1191; }","duration":"1.695441511s","start":"2026-04-02T22:33:18.338759Z","end":"2026-04-02T22:33:20.0342Z","steps":["trace[25575692] 'agreement among raft nodes before linearized reading' (duration: 1.695332899s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.034243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:18.338744Z","time spent":"1.695491263s","remote":"127.0.0.1:42102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T22:33:20.034249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.274970208s","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":"warn","ts":"2026-04-02T22:33:20.034254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:19.699954Z","time spent":"334.22774ms","remote":"127.0.0.1:42166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:33:20.034287Z","caller":"traceutil/trace.go:171","msg":"trace[1063268022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1191; }","duration":"2.275029418s","start":"2026-04-02T22:33:17.759246Z","end":"2026-04-02T22:33:20.034275Z","steps":["trace[1063268022] 'agreement among raft nodes before linearized reading' (duration: 2.274936547s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.034146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.419457674s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:33:20.034318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:17.759232Z","time spent":"2.275079029s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-02T22:33:20.034329Z","caller":"traceutil/trace.go:171","msg":"trace[318412127] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1191; }","duration":"2.419680167s","start":"2026-04-02T22:33:17.614642Z","end":"2026-04-02T22:33:20.034322Z","steps":["trace[318412127] 'agreement among raft nodes before linearized reading' (duration: 2.419441753s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.034345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:17.614627Z","time spent":"2.419713669s","remote":"127.0.0.1:42534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:33:20.034391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.357922551s","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-04-02T22:33:20.034428Z","caller":"traceutil/trace.go:171","msg":"trace[417716208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1191; }","duration":"2.357978302s","start":"2026-04-02T22:33:17.676439Z","end":"2026-04-02T22:33:20.034418Z","steps":["trace[417716208] 'agreement among raft nodes before linearized reading' (duration: 2.35784846s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.034457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:17.67643Z","time spent":"2.358020813s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T22:33:20.034553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331471479s","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-04-02T22:33:20.034593Z","caller":"traceutil/trace.go:171","msg":"trace[63352153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1191; }","duration":"1.331553771s","start":"2026-04-02T22:33:18.703028Z","end":"2026-04-02T22:33:20.034582Z","steps":["trace[63352153] 'agreement among raft nodes before linearized reading' (duration: 1.331414848s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.034622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:18.703Z","time spent":"1.331615031s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T22:33:20.034933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.719933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-02T22:33:20.034981Z","caller":"traceutil/trace.go:171","msg":"trace[1399194062] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:1191; }","duration":"971.805926ms","start":"2026-04-02T22:33:19.06316Z","end":"2026-04-02T22:33:20.034966Z","steps":["trace[1399194062] 'agreement among raft nodes before linearized reading' (duration: 970.94445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:20.03502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:19.063148Z","time spent":"971.863487ms","remote":"127.0.0.1:42118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" "} {"level":"info","ts":"2026-04-02T22:33:31.359295Z","caller":"traceutil/trace.go:171","msg":"trace[1101656551] linearizableReadLoop","detail":"{readStateIndex:1286; appliedIndex:1285; }","duration":"156.281632ms","start":"2026-04-02T22:33:31.202992Z","end":"2026-04-02T22:33:31.359274Z","steps":["trace[1101656551] 'read index received' (duration: 156.079688ms)","trace[1101656551] 'applied index is now lower than readState.Index' (duration: 201.204µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:33:31.359344Z","caller":"traceutil/trace.go:171","msg":"trace[1002867481] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"158.545954ms","start":"2026-04-02T22:33:31.200767Z","end":"2026-04-02T22:33:31.359313Z","steps":["trace[1002867481] 'process raft request' (duration: 158.35794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:31.359514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.496327ms","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-04-02T22:33:31.359595Z","caller":"traceutil/trace.go:171","msg":"trace[116088478] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1230; }","duration":"156.633029ms","start":"2026-04-02T22:33:31.202944Z","end":"2026-04-02T22:33:31.359577Z","steps":["trace[116088478] 'agreement among raft nodes before linearized reading' (duration: 156.455415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:32.313711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.879523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:33:32.313819Z","caller":"traceutil/trace.go:171","msg":"trace[1599548568] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"160.676603ms","start":"2026-04-02T22:33:32.153123Z","end":"2026-04-02T22:33:32.313799Z","steps":["trace[1599548568] 'process raft request' (duration: 54.624627ms)","trace[1599548568] 'compare' (duration: 105.635328ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:33:32.319057Z","caller":"traceutil/trace.go:171","msg":"trace[1273668015] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"165.845437ms","start":"2026-04-02T22:33:32.153191Z","end":"2026-04-02T22:33:32.319036Z","steps":["trace[1273668015] 'process raft request' (duration: 165.611482ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:32.319069Z","caller":"traceutil/trace.go:171","msg":"trace[277529215] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"163.469014ms","start":"2026-04-02T22:33:32.155575Z","end":"2026-04-02T22:33:32.319044Z","steps":["trace[277529215] 'process raft request' (duration: 163.425983ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:32.319366Z","caller":"traceutil/trace.go:171","msg":"trace[1001413742] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"166.03873ms","start":"2026-04-02T22:33:32.153299Z","end":"2026-04-02T22:33:32.319338Z","steps":["trace[1001413742] 'process raft request' (duration: 165.619072ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:32.319401Z","caller":"traceutil/trace.go:171","msg":"trace[756323212] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"164.715775ms","start":"2026-04-02T22:33:32.154657Z","end":"2026-04-02T22:33:32.319373Z","steps":["trace[756323212] 'process raft request' (duration: 164.295928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:34.513965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.174552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:34.514047Z","caller":"traceutil/trace.go:171","msg":"trace[536393456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"172.308075ms","start":"2026-04-02T22:33:34.34172Z","end":"2026-04-02T22:33:34.514028Z","steps":["trace[536393456] 'range keys from in-memory index tree' (duration: 172.07415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:34.514096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.579237ms","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-04-02T22:33:34.514154Z","caller":"traceutil/trace.go:171","msg":"trace[1269815627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1238; }","duration":"190.667859ms","start":"2026-04-02T22:33:34.323474Z","end":"2026-04-02T22:33:34.514142Z","steps":["trace[1269815627] 'range keys from in-memory index tree' (duration: 190.469496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:34.514328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.371724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-02T22:33:34.514333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.020206ms","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-04-02T22:33:34.514364Z","caller":"traceutil/trace.go:171","msg":"trace[1620611737] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1238; }","duration":"190.424004ms","start":"2026-04-02T22:33:34.323931Z","end":"2026-04-02T22:33:34.514355Z","steps":["trace[1620611737] 'range keys from in-memory index tree' (duration: 190.263022ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:34.514388Z","caller":"traceutil/trace.go:171","msg":"trace[180240451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1238; }","duration":"191.099258ms","start":"2026-04-02T22:33:34.323263Z","end":"2026-04-02T22:33:34.514363Z","steps":["trace[180240451] 'range keys from in-memory index tree' (duration: 190.896933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:34.51441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.125957ms","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-04-02T22:33:34.514437Z","caller":"traceutil/trace.go:171","msg":"trace[632117641] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1238; }","duration":"197.193059ms","start":"2026-04-02T22:33:34.317236Z","end":"2026-04-02T22:33:34.514429Z","steps":["trace[632117641] 'range keys from in-memory index tree' (duration: 196.994705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:34.514528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.16491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-02T22:33:34.514578Z","caller":"traceutil/trace.go:171","msg":"trace[1686255158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1238; }","duration":"190.204061ms","start":"2026-04-02T22:33:34.324338Z","end":"2026-04-02T22:33:34.514542Z","steps":["trace[1686255158] 'range keys from in-memory index tree' (duration: 190.076539ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:34.722066Z","caller":"traceutil/trace.go:171","msg":"trace[1558768546] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"203.616965ms","start":"2026-04-02T22:33:34.518426Z","end":"2026-04-02T22:33:34.722043Z","steps":["trace[1558768546] 'process raft request' (duration: 203.421222ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:34.722335Z","caller":"traceutil/trace.go:171","msg":"trace[239272867] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"203.422302ms","start":"2026-04-02T22:33:34.518882Z","end":"2026-04-02T22:33:34.722304Z","steps":["trace[239272867] 'process raft request' (duration: 203.125597ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:34.72245Z","caller":"traceutil/trace.go:171","msg":"trace[1887898167] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"203.430113ms","start":"2026-04-02T22:33:34.519007Z","end":"2026-04-02T22:33:34.722437Z","steps":["trace[1887898167] 'process raft request' (duration: 203.218838ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:34.722471Z","caller":"traceutil/trace.go:171","msg":"trace[1094567127] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"201.932075ms","start":"2026-04-02T22:33:34.520506Z","end":"2026-04-02T22:33:34.722438Z","steps":["trace[1094567127] 'process raft request' (duration: 201.846333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:36.401459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.824605ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T22:33:36.4017Z","caller":"traceutil/trace.go:171","msg":"trace[1976359341] linearizableReadLoop","detail":"{readStateIndex:1300; appliedIndex:1299; }","duration":"249.788399ms","start":"2026-04-02T22:33:36.151889Z","end":"2026-04-02T22:33:36.401678Z","steps":["trace[1976359341] 'read index received' (duration: 34.161µs)","trace[1976359341] 'applied index is now lower than readState.Index' (duration: 249.753028ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:33:36.401883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.948361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:36.402004Z","caller":"traceutil/trace.go:171","msg":"trace[292247320] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1243; }","duration":"250.123595ms","start":"2026-04-02T22:33:36.15185Z","end":"2026-04-02T22:33:36.401974Z","steps":["trace[292247320] 'agreement among raft nodes before linearized reading' (duration: 249.933712ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:36.402593Z","caller":"traceutil/trace.go:171","msg":"trace[716075089] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"184.348464ms","start":"2026-04-02T22:33:36.218226Z","end":"2026-04-02T22:33:36.402575Z","steps":["trace[716075089] 'process raft request' (duration: 183.341636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:36.516475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.666127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:36.516544Z","caller":"traceutil/trace.go:171","msg":"trace[1048315107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1244; }","duration":"174.78669ms","start":"2026-04-02T22:33:36.341744Z","end":"2026-04-02T22:33:36.516531Z","steps":["trace[1048315107] 'agreement among raft nodes before linearized reading' (duration: 60.80946ms)","trace[1048315107] 'range keys from in-memory index tree' (duration: 113.869598ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:33:36.877484Z","caller":"traceutil/trace.go:171","msg":"trace[1342367324] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"145.064358ms","start":"2026-04-02T22:33:36.732397Z","end":"2026-04-02T22:33:36.877461Z","steps":["trace[1342367324] 'process raft request' (duration: 145.023967ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:36.877503Z","caller":"traceutil/trace.go:171","msg":"trace[1821586638] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"145.594947ms","start":"2026-04-02T22:33:36.731881Z","end":"2026-04-02T22:33:36.877476Z","steps":["trace[1821586638] 'process raft request' (duration: 145.346183ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:36.877524Z","caller":"traceutil/trace.go:171","msg":"trace[610962965] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"145.446665ms","start":"2026-04-02T22:33:36.732057Z","end":"2026-04-02T22:33:36.877504Z","steps":["trace[610962965] 'process raft request' (duration: 145.326032ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:36.892281Z","caller":"traceutil/trace.go:171","msg":"trace[1440647774] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"137.521969ms","start":"2026-04-02T22:33:36.754735Z","end":"2026-04-02T22:33:36.892257Z","steps":["trace[1440647774] 'process raft request' (duration: 136.901358ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:37.071484Z","caller":"traceutil/trace.go:171","msg":"trace[1208824163] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"117.625356ms","start":"2026-04-02T22:33:36.953817Z","end":"2026-04-02T22:33:37.071443Z","steps":["trace[1208824163] 'process raft request' (duration: 117.391342ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:38.566741Z","caller":"traceutil/trace.go:171","msg":"trace[2004751217] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"159.966779ms","start":"2026-04-02T22:33:38.406748Z","end":"2026-04-02T22:33:38.566715Z","steps":["trace[2004751217] 'process raft request' (duration: 159.601012ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:39.199028Z","caller":"traceutil/trace.go:171","msg":"trace[1565250172] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1311; }","duration":"454.779909ms","start":"2026-04-02T22:33:38.744228Z","end":"2026-04-02T22:33:39.199008Z","steps":["trace[1565250172] 'read index received' (duration: 379.461025ms)","trace[1565250172] 'applied index is now lower than readState.Index' (duration: 75.318024ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:33:39.199114Z","caller":"traceutil/trace.go:171","msg":"trace[1345310384] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"605.634093ms","start":"2026-04-02T22:33:38.593473Z","end":"2026-04-02T22:33:39.199107Z","steps":["trace[1345310384] 'process raft request' (duration: 530.266068ms)","trace[1345310384] 'compare' (duration: 75.189682ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:33:39.199188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:38.593449Z","time spent":"605.689144ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:33:39.199213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.563003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:39.19929Z","caller":"traceutil/trace.go:171","msg":"trace[1790586919] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1255; }","duration":"341.693786ms","start":"2026-04-02T22:33:38.85758Z","end":"2026-04-02T22:33:39.199274Z","steps":["trace[1790586919] 'agreement among raft nodes before linearized reading' (duration: 341.556584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.199286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.056025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T22:33:39.199314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.228491ms","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-04-02T22:33:39.199343Z","caller":"traceutil/trace.go:171","msg":"trace[1461962558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1255; }","duration":"455.154346ms","start":"2026-04-02T22:33:38.744175Z","end":"2026-04-02T22:33:39.199329Z","steps":["trace[1461962558] 'agreement among raft nodes before linearized reading' (duration: 455.006834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.199393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:38.744155Z","time spent":"455.221148ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T22:33:39.19939Z","caller":"traceutil/trace.go:171","msg":"trace[1528761638] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1255; }","duration":"316.337323ms","start":"2026-04-02T22:33:38.883033Z","end":"2026-04-02T22:33:39.19937Z","steps":["trace[1528761638] 'agreement among raft nodes before linearized reading' (duration: 316.119639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.199467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.76147ms","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":"warn","ts":"2026-04-02T22:33:39.199472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.316232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-02T22:33:39.199485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:38.883023Z","time spent":"316.453716ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-02T22:33:39.199501Z","caller":"traceutil/trace.go:171","msg":"trace[178115621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1255; }","duration":"316.831972ms","start":"2026-04-02T22:33:38.88266Z","end":"2026-04-02T22:33:39.199492Z","steps":["trace[178115621] 'agreement among raft nodes before linearized reading' (duration: 316.70363ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:39.199505Z","caller":"traceutil/trace.go:171","msg":"trace[310678633] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:1255; }","duration":"134.376983ms","start":"2026-04-02T22:33:39.06512Z","end":"2026-04-02T22:33:39.199497Z","steps":["trace[310678633] 'agreement among raft nodes before linearized reading' (duration: 134.295202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.199339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:38.85756Z","time spent":"341.767477ms","remote":"127.0.0.1:34296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:33:39.199533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:38.882641Z","time spent":"316.881642ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T22:33:39.199798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.30323ms","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-04-02T22:33:39.200013Z","caller":"traceutil/trace.go:171","msg":"trace[1161247987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1255; }","duration":"317.565825ms","start":"2026-04-02T22:33:38.882437Z","end":"2026-04-02T22:33:39.200003Z","steps":["trace[1161247987] 'agreement among raft nodes before linearized reading' (duration: 317.27358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.200043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:38.882412Z","time spent":"317.623986ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T22:33:39.622334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:39.200508Z","time spent":"421.821207ms","remote":"127.0.0.1:42118","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-02T22:33:39.668921Z","caller":"traceutil/trace.go:171","msg":"trace[41652389] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"465.055327ms","start":"2026-04-02T22:33:39.203838Z","end":"2026-04-02T22:33:39.668893Z","steps":["trace[41652389] 'process raft request' (duration: 464.826073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.669055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:39.203822Z","time spent":"465.173909ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:33:39.669057Z","caller":"traceutil/trace.go:171","msg":"trace[1028675565] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"464.892014ms","start":"2026-04-02T22:33:39.204137Z","end":"2026-04-02T22:33:39.669029Z","steps":["trace[1028675565] 'process raft request' (duration: 464.66137ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:39.669139Z","caller":"traceutil/trace.go:171","msg":"trace[630767476] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"464.499597ms","start":"2026-04-02T22:33:39.204628Z","end":"2026-04-02T22:33:39.669127Z","steps":["trace[630767476] 'process raft request' (duration: 464.196061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.669204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:39.20462Z","time spent":"464.544557ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:33:39.669295Z","caller":"traceutil/trace.go:171","msg":"trace[1686786799] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"463.996778ms","start":"2026-04-02T22:33:39.205292Z","end":"2026-04-02T22:33:39.669289Z","steps":["trace[1686786799] 'process raft request' (duration: 463.781284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.669212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:39.204121Z","time spent":"465.010757ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:33:39.669334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:39.205278Z","time spent":"464.032829ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:33:39.669465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.693039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:39.669486Z","caller":"traceutil/trace.go:171","msg":"trace[980747070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1259; }","duration":"328.7489ms","start":"2026-04-02T22:33:39.340732Z","end":"2026-04-02T22:33:39.66948Z","steps":["trace[980747070] 'agreement among raft nodes before linearized reading' (duration: 328.706809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.6695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:39.34071Z","time spent":"328.78705ms","remote":"127.0.0.1:42088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T22:33:39.669494Z","caller":"traceutil/trace.go:171","msg":"trace[514870440] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1312; }","duration":"328.316782ms","start":"2026-04-02T22:33:39.340782Z","end":"2026-04-02T22:33:39.669098Z","steps":["trace[514870440] 'read index received' (duration: 195.361316ms)","trace[514870440] 'applied index is now lower than readState.Index' (duration: 132.954946ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:33:39.977675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.02285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:39.977751Z","caller":"traceutil/trace.go:171","msg":"trace[1847808463] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1260; }","duration":"235.158861ms","start":"2026-04-02T22:33:39.742575Z","end":"2026-04-02T22:33:39.977734Z","steps":["trace[1847808463] 'count revisions from in-memory index tree' (duration: 234.953838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:39.978208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.188832ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:39.978445Z","caller":"traceutil/trace.go:171","msg":"trace[397371472] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1260; }","duration":"195.433927ms","start":"2026-04-02T22:33:39.782988Z","end":"2026-04-02T22:33:39.978422Z","steps":["trace[397371472] 'range keys from in-memory index tree' (duration: 195.172911ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:40.039443Z","caller":"traceutil/trace.go:171","msg":"trace[212279662] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"296.385279ms","start":"2026-04-02T22:33:39.743033Z","end":"2026-04-02T22:33:40.039419Z","steps":["trace[212279662] 'process raft request' (duration: 296.199876ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:41.645095Z","caller":"traceutil/trace.go:171","msg":"trace[1209588879] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"165.976449ms","start":"2026-04-02T22:33:41.479094Z","end":"2026-04-02T22:33:41.64507Z","steps":["trace[1209588879] 'process raft request' (duration: 165.688424ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:43.861601Z","caller":"traceutil/trace.go:171","msg":"trace[1987882294] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"170.612724ms","start":"2026-04-02T22:33:43.690968Z","end":"2026-04-02T22:33:43.861581Z","steps":["trace[1987882294] 'process raft request' (duration: 170.578573ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:43.861727Z","caller":"traceutil/trace.go:171","msg":"trace[2134319328] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"173.935314ms","start":"2026-04-02T22:33:43.68776Z","end":"2026-04-02T22:33:43.861695Z","steps":["trace[2134319328] 'process raft request' (duration: 173.601268ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:43.861777Z","caller":"traceutil/trace.go:171","msg":"trace[1746764660] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"173.364964ms","start":"2026-04-02T22:33:43.688377Z","end":"2026-04-02T22:33:43.861742Z","steps":["trace[1746764660] 'process raft request' (duration: 173.132309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.237676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431912006s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:33:49.237823Z","caller":"traceutil/trace.go:171","msg":"trace[1588125768] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"1.895672869s","start":"2026-04-02T22:33:47.342138Z","end":"2026-04-02T22:33:49.237811Z","steps":["trace[1588125768] 'read index received' (duration: 463.515478ms)","trace[1588125768] 'applied index is now lower than readState.Index' (duration: 1.432156511s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:33:49.23792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.895789582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:49.237975Z","caller":"traceutil/trace.go:171","msg":"trace[834177575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1320; }","duration":"1.895869803s","start":"2026-04-02T22:33:47.342097Z","end":"2026-04-02T22:33:49.237967Z","steps":["trace[834177575] 'agreement among raft nodes before linearized reading' (duration: 1.895781851s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:49.237945Z","caller":"traceutil/trace.go:171","msg":"trace[4392250] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"1.927955019s","start":"2026-04-02T22:33:47.30996Z","end":"2026-04-02T22:33:49.237915Z","steps":["trace[4392250] 'process raft request' (duration: 495.724287ms)","trace[4392250] 'compare' (duration: 1.431387326s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:33:49.238044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.342083Z","time spent":"1.895936244s","remote":"127.0.0.1:42088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T22:33:49.238125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.309942Z","time spent":"1.928105341s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:33:49.601085Z","caller":"traceutil/trace.go:171","msg":"trace[480744349] linearizableReadLoop","detail":"{readStateIndex:1380; appliedIndex:1379; }","duration":"363.198474ms","start":"2026-04-02T22:33:49.237859Z","end":"2026-04-02T22:33:49.601058Z","steps":["trace[480744349] 'read index received' (duration: 357.825795ms)","trace[480744349] 'applied index is now lower than readState.Index' (duration: 5.371399ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:33:49.601272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.766361ms","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:507"} {"level":"info","ts":"2026-04-02T22:33:49.6013Z","caller":"traceutil/trace.go:171","msg":"trace[1192850854] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1321; }","duration":"469.858413ms","start":"2026-04-02T22:33:49.131432Z","end":"2026-04-02T22:33:49.601291Z","steps":["trace[1192850854] 'agreement among raft nodes before linearized reading' (duration: 469.737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.601329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.704182751s","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-04-02T22:33:49.601448Z","caller":"traceutil/trace.go:171","msg":"trace[343102069] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1321; }","duration":"1.704312823s","start":"2026-04-02T22:33:47.897112Z","end":"2026-04-02T22:33:49.601425Z","steps":["trace[343102069] 'agreement among raft nodes before linearized reading' (duration: 1.704066719s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.601511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.89705Z","time spent":"1.704448055s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T22:33:49.601757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.2240398s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-04-02T22:33:49.601831Z","caller":"traceutil/trace.go:171","msg":"trace[1290510916] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1321; }","duration":"2.224128051s","start":"2026-04-02T22:33:47.377686Z","end":"2026-04-02T22:33:49.601814Z","steps":["trace[1290510916] 'agreement among raft nodes before linearized reading' (duration: 2.223995889s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.601993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.737864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-02T22:33:49.601321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:49.131406Z","time spent":"469.910233ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-02T22:33:49.60206Z","caller":"traceutil/trace.go:171","msg":"trace[314289120] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:1321; }","duration":"536.846316ms","start":"2026-04-02T22:33:49.065197Z","end":"2026-04-02T22:33:49.602043Z","steps":["trace[314289120] 'agreement among raft nodes before linearized reading' (duration: 536.53021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.601884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.377677Z","time spent":"2.224195332s","remote":"127.0.0.1:42154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-04-02T22:33:49.602116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:49.065171Z","time spent":"536.932807ms","remote":"127.0.0.1:42118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" "} {"level":"info","ts":"2026-04-02T22:33:49.60202Z","caller":"traceutil/trace.go:171","msg":"trace[1173630157] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"1.003479409s","start":"2026-04-02T22:33:48.597604Z","end":"2026-04-02T22:33:49.601083Z","steps":["trace[1173630157] 'process raft request' (duration: 998.13712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.602256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.227405711s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:51227"} {"level":"info","ts":"2026-04-02T22:33:49.602291Z","caller":"traceutil/trace.go:171","msg":"trace[1614983297] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1321; }","duration":"2.227493922s","start":"2026-04-02T22:33:47.374788Z","end":"2026-04-02T22:33:49.602282Z","steps":["trace[1614983297] 'agreement among raft nodes before linearized reading' (duration: 2.227401161s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.602318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.374762Z","time spent":"2.227551663s","remote":"127.0.0.1:42144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":51251,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-04-02T22:33:49.602349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.709932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T22:33:49.602451Z","caller":"traceutil/trace.go:171","msg":"trace[1753111664] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1321; }","duration":"735.855475ms","start":"2026-04-02T22:33:48.866582Z","end":"2026-04-02T22:33:49.602437Z","steps":["trace[1753111664] 'agreement among raft nodes before linearized reading' (duration: 735.724373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.602497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.717504106s","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-04-02T22:33:49.602559Z","caller":"traceutil/trace.go:171","msg":"trace[472406981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1321; }","duration":"1.717608938s","start":"2026-04-02T22:33:47.884936Z","end":"2026-04-02T22:33:49.602545Z","steps":["trace[472406981] 'agreement among raft nodes before linearized reading' (duration: 1.717367804s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.602611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.884914Z","time spent":"1.717685529s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T22:33:49.6026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.830734401s","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":"warn","ts":"2026-04-02T22:33:49.602672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.633913378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:49.60272Z","caller":"traceutil/trace.go:171","msg":"trace[1661255710] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1321; }","duration":"1.830886844s","start":"2026-04-02T22:33:47.771777Z","end":"2026-04-02T22:33:49.602664Z","steps":["trace[1661255710] 'agreement among raft nodes before linearized reading' (duration: 1.830623319s)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:49.602726Z","caller":"traceutil/trace.go:171","msg":"trace[1498329587] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1321; }","duration":"1.633997569s","start":"2026-04-02T22:33:47.968713Z","end":"2026-04-02T22:33:49.60271Z","steps":["trace[1498329587] 'agreement among raft nodes before linearized reading' (duration: 1.633927428s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.602772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.968692Z","time spent":"1.634062301s","remote":"127.0.0.1:37194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:33:49.602872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:48.597573Z","time spent":"1.004700631s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:33:49.60285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.77175Z","time spent":"1.831079827s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T22:33:49.602617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.724633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:33:49.602567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.026871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:49.603052Z","caller":"traceutil/trace.go:171","msg":"trace[324884635] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1321; }","duration":"825.190883ms","start":"2026-04-02T22:33:48.777844Z","end":"2026-04-02T22:33:49.603035Z","steps":["trace[324884635] 'agreement among raft nodes before linearized reading' (duration: 824.746434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.603072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.705312332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-02T22:33:49.603114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:48.777823Z","time spent":"825.270974ms","remote":"127.0.0.1:42168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:33:49.602506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:48.86656Z","time spent":"735.932446ms","remote":"127.0.0.1:42274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-04-02T22:33:49.602627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.092964ms","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-04-02T22:33:49.603205Z","caller":"traceutil/trace.go:171","msg":"trace[1173231177] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1321; }","duration":"314.697285ms","start":"2026-04-02T22:33:49.28849Z","end":"2026-04-02T22:33:49.603187Z","steps":["trace[1173231177] 'agreement among raft nodes before linearized reading' (duration: 314.103484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.603273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:49.288469Z","time spent":"314.787298ms","remote":"127.0.0.1:42370","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-04-02T22:33:49.603133Z","caller":"traceutil/trace.go:171","msg":"trace[1880368679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"1.705408573s","start":"2026-04-02T22:33:47.89771Z","end":"2026-04-02T22:33:49.603119Z","steps":["trace[1880368679] 'agreement among raft nodes before linearized reading' (duration: 1.705206009s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.603354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:47.897693Z","time spent":"1.705636677s","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T22:33:49.602472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.407409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:33:49.603422Z","caller":"traceutil/trace.go:171","msg":"trace[1177549521] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"364.348116ms","start":"2026-04-02T22:33:49.239039Z","end":"2026-04-02T22:33:49.603387Z","steps":["trace[1177549521] 'agreement among raft nodes before linearized reading' (duration: 363.416618ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:33:49.603127Z","caller":"traceutil/trace.go:171","msg":"trace[769741783] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1321; }","duration":"754.596013ms","start":"2026-04-02T22:33:48.848494Z","end":"2026-04-02T22:33:49.60309Z","steps":["trace[769741783] 'agreement among raft nodes before linearized reading' (duration: 754.040212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:33:49.603479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:49.239028Z","time spent":"364.436537ms","remote":"127.0.0.1:42102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T22:33:49.603684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:33:48.848474Z","time spent":"755.156592ms","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-04-02T22:34:02.121743Z","caller":"traceutil/trace.go:171","msg":"trace[1654133916] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"178.819616ms","start":"2026-04-02T22:34:01.942893Z","end":"2026-04-02T22:34:02.121713Z","steps":["trace[1654133916] 'process raft request' (duration: 178.643342ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:34:13.929065Z","caller":"traceutil/trace.go:171","msg":"trace[1338019781] linearizableReadLoop","detail":"{readStateIndex:1515; appliedIndex:1514; }","duration":"145.646951ms","start":"2026-04-02T22:34:13.7834Z","end":"2026-04-02T22:34:13.929047Z","steps":["trace[1338019781] 'read index received' (duration: 116.49163ms)","trace[1338019781] 'applied index is now lower than readState.Index' (duration: 29.154661ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:34:13.929111Z","caller":"traceutil/trace.go:171","msg":"trace[746350850] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"152.259483ms","start":"2026-04-02T22:34:13.776836Z","end":"2026-04-02T22:34:13.929095Z","steps":["trace[746350850] 'process raft request' (duration: 123.060722ms)","trace[746350850] 'compare' (duration: 28.797143ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:34:13.929226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.814084ms","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-04-02T22:34:13.929249Z","caller":"traceutil/trace.go:171","msg":"trace[554778713] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1451; }","duration":"145.872645ms","start":"2026-04-02T22:34:13.78337Z","end":"2026-04-02T22:34:13.929243Z","steps":["trace[554778713] 'agreement among raft nodes before linearized reading' (duration: 145.767613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:34:13.929426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.034768ms","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-04-02T22:34:13.929468Z","caller":"traceutil/trace.go:171","msg":"trace[297461429] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1451; }","duration":"125.09841ms","start":"2026-04-02T22:34:13.804361Z","end":"2026-04-02T22:34:13.929459Z","steps":["trace[297461429] 'agreement among raft nodes before linearized reading' (duration: 124.984748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:34:13.929495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.949347ms","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-04-02T22:34:13.929513Z","caller":"traceutil/trace.go:171","msg":"trace[57268963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1451; }","duration":"111.006158ms","start":"2026-04-02T22:34:13.8185Z","end":"2026-04-02T22:34:13.929507Z","steps":["trace[57268963] 'agreement among raft nodes before linearized reading' (duration: 110.959878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:34:13.929573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.269663ms","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-04-02T22:34:13.929584Z","caller":"traceutil/trace.go:171","msg":"trace[1617403261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1451; }","duration":"111.280453ms","start":"2026-04-02T22:34:13.818299Z","end":"2026-04-02T22:34:13.92958Z","steps":["trace[1617403261] 'agreement among raft nodes before linearized reading' (duration: 111.247702ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:34:15.888063Z","caller":"traceutil/trace.go:171","msg":"trace[266950654] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"228.15448ms","start":"2026-04-02T22:34:15.659886Z","end":"2026-04-02T22:34:15.888041Z","steps":["trace[266950654] 'process raft request' (duration: 228.005638ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:34:15.891227Z","caller":"traceutil/trace.go:171","msg":"trace[429015083] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"114.395211ms","start":"2026-04-02T22:34:15.776771Z","end":"2026-04-02T22:34:15.891167Z","steps":["trace[429015083] 'process raft request' (duration: 114.271589ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:34:24.094692Z","caller":"traceutil/trace.go:171","msg":"trace[277013607] transaction","detail":"{read_only:false; response_revision:1497; number_of_response:1; }","duration":"110.391857ms","start":"2026-04-02T22:34:23.984269Z","end":"2026-04-02T22:34:24.094661Z","steps":["trace[277013607] 'process raft request' (duration: 60.193016ms)","trace[277013607] 'compare' (duration: 50.050008ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:34:24.309151Z","caller":"traceutil/trace.go:171","msg":"trace[1865821210] transaction","detail":"{read_only:false; response_revision:1499; number_of_response:1; }","duration":"210.199788ms","start":"2026-04-02T22:34:24.098921Z","end":"2026-04-02T22:34:24.309121Z","steps":["trace[1865821210] 'process raft request' (duration: 144.328426ms)","trace[1865821210] 'compare' (duration: 65.572856ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:34:24.309464Z","caller":"traceutil/trace.go:171","msg":"trace[1618275392] linearizableReadLoop","detail":"{readStateIndex:1567; appliedIndex:1563; }","duration":"172.385236ms","start":"2026-04-02T22:34:24.137053Z","end":"2026-04-02T22:34:24.309438Z","steps":["trace[1618275392] 'read index received' (duration: 4.390691ms)","trace[1618275392] 'applied index is now lower than readState.Index' (duration: 167.993435ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:34:24.309558Z","caller":"traceutil/trace.go:171","msg":"trace[694322462] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"210.527505ms","start":"2026-04-02T22:34:24.098996Z","end":"2026-04-02T22:34:24.309524Z","steps":["trace[694322462] 'process raft request' (duration: 210.047785ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:34:24.309587Z","caller":"traceutil/trace.go:171","msg":"trace[465617427] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"210.376802ms","start":"2026-04-02T22:34:24.099193Z","end":"2026-04-02T22:34:24.309569Z","steps":["trace[465617427] 'process raft request' (duration: 210.141256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:34:24.30966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.581891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:34:24.309787Z","caller":"traceutil/trace.go:171","msg":"trace[17447583] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1501; }","duration":"172.734263ms","start":"2026-04-02T22:34:24.137037Z","end":"2026-04-02T22:34:24.309771Z","steps":["trace[17447583] 'agreement among raft nodes before linearized reading' (duration: 172.57165ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:34:32.488591Z","caller":"traceutil/trace.go:171","msg":"trace[1711083289] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"129.805328ms","start":"2026-04-02T22:34:32.358757Z","end":"2026-04-02T22:34:32.488562Z","steps":["trace[1711083289] 'process raft request' (duration: 111.666601ms)","trace[1711083289] 'compare' (duration: 17.983954ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:34:32.488751Z","caller":"traceutil/trace.go:171","msg":"trace[461333286] transaction","detail":"{read_only:false; response_revision:1540; number_of_response:1; }","duration":"129.890629ms","start":"2026-04-02T22:34:32.358837Z","end":"2026-04-02T22:34:32.488728Z","steps":["trace[461333286] 'process raft request' (duration: 129.671545ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:34:36.619356Z","caller":"traceutil/trace.go:171","msg":"trace[1776978315] linearizableReadLoop","detail":"{readStateIndex:1625; appliedIndex:1624; }","duration":"117.004678ms","start":"2026-04-02T22:34:36.502325Z","end":"2026-04-02T22:34:36.61933Z","steps":["trace[1776978315] 'read index received' (duration: 94.035623ms)","trace[1776978315] 'applied index is now lower than readState.Index' (duration: 22.964915ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:34:36.619523Z","caller":"traceutil/trace.go:171","msg":"trace[1557092316] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"205.317028ms","start":"2026-04-02T22:34:36.414193Z","end":"2026-04-02T22:34:36.61951Z","steps":["trace[1557092316] 'process raft request' (duration: 182.157688ms)","trace[1557092316] 'compare' (duration: 22.730791ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:34:36.619816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.800168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-02T22:34:36.619841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.508819ms","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-04-02T22:34:36.619874Z","caller":"traceutil/trace.go:171","msg":"trace[553518430] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1556; }","duration":"115.902929ms","start":"2026-04-02T22:34:36.503956Z","end":"2026-04-02T22:34:36.619859Z","steps":["trace[553518430] 'agreement among raft nodes before linearized reading' (duration: 115.711356ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:34:36.61991Z","caller":"traceutil/trace.go:171","msg":"trace[1946383339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1556; }","duration":"117.624991ms","start":"2026-04-02T22:34:36.502269Z","end":"2026-04-02T22:34:36.619894Z","steps":["trace[1946383339] 'agreement among raft nodes before linearized reading' (duration: 117.453197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:36:03.03173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.127404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4219"} {"level":"info","ts":"2026-04-02T22:36:03.031836Z","caller":"traceutil/trace.go:171","msg":"trace[2051794046] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:1950; }","duration":"123.294087ms","start":"2026-04-02T22:36:02.908521Z","end":"2026-04-02T22:36:03.031815Z","steps":["trace[2051794046] 'range keys from in-memory index tree' (duration: 122.925881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:36:03.03182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.096171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T22:36:03.032046Z","caller":"traceutil/trace.go:171","msg":"trace[727848268] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1950; }","duration":"109.344325ms","start":"2026-04-02T22:36:02.92267Z","end":"2026-04-02T22:36:03.032015Z","steps":["trace[727848268] 'range keys from in-memory index tree' (duration: 108.891357ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:37:03.063567Z","caller":"traceutil/trace.go:171","msg":"trace[275309925] transaction","detail":"{read_only:false; response_revision:2250; number_of_response:1; }","duration":"326.689399ms","start":"2026-04-02T22:37:02.736824Z","end":"2026-04-02T22:37:03.063514Z","steps":["trace[275309925] 'process raft request' (duration: 326.441954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:37:03.064158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:37:02.736805Z","time spent":"326.899094ms","remote":"127.0.0.1:42370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:37:09.36248Z","caller":"traceutil/trace.go:171","msg":"trace[1012623044] linearizableReadLoop","detail":"{readStateIndex:2383; appliedIndex:2381; }","duration":"272.160478ms","start":"2026-04-02T22:37:09.090289Z","end":"2026-04-02T22:37:09.36245Z","steps":["trace[1012623044] 'read index received' (duration: 157.314448ms)","trace[1012623044] 'applied index is now lower than readState.Index' (duration: 114.84471ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:37:09.362622Z","caller":"traceutil/trace.go:171","msg":"trace[483344437] transaction","detail":"{read_only:false; response_revision:2282; number_of_response:1; }","duration":"277.893794ms","start":"2026-04-02T22:37:09.08471Z","end":"2026-04-02T22:37:09.362603Z","steps":["trace[483344437] 'process raft request' (duration: 258.588817ms)","trace[483344437] 'compare' (duration: 18.981772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:37:09.36293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.625117ms","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-04-02T22:37:09.363067Z","caller":"traceutil/trace.go:171","msg":"trace[552178165] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2282; }","duration":"272.80472ms","start":"2026-04-02T22:37:09.090241Z","end":"2026-04-02T22:37:09.363046Z","steps":["trace[552178165] 'agreement among raft nodes before linearized reading' (duration: 272.559456ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:37:09.374138Z","caller":"traceutil/trace.go:171","msg":"trace[1210283454] transaction","detail":"{read_only:false; response_revision:2283; number_of_response:1; }","duration":"125.497068ms","start":"2026-04-02T22:37:09.248622Z","end":"2026-04-02T22:37:09.37412Z","steps":["trace[1210283454] 'process raft request' (duration: 125.381826ms)"],"step_count":1}