{"level":"warn","ts":"2026-04-16T06:05:11.565946Z","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-16T06:05:11.566106Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.209: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.209:2380","--initial-cluster=instance=https://199.204.45.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.209: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-16T06:05:11.566213Z","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-16T06:05:11.566235Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-04-16T06:05:11.566272Z","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-16T06:05:11.568063Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"]} {"level":"info","ts":"2026-04-16T06:05:11.570911Z","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.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.209: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-16T06:05:11.57822Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.966018ms"} {"level":"info","ts":"2026-04-16T06:05:11.586757Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"} {"level":"info","ts":"2026-04-16T06:05:11.586867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T06:05:11.586898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"} {"level":"info","ts":"2026-04-16T06:05:11.586912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adfb641115bf6cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T06:05:11.586929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"} {"level":"info","ts":"2026-04-16T06:05:11.586979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"warn","ts":"2026-04-16T06:05:11.59574Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T06:05:11.597122Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T06:05:11.598309Z","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-16T06:05:11.600363Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adfb641115bf6cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T06:05:11.601148Z","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-16T06:05:11.60122Z","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-16T06:05:11.601232Z","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-16T06:05:11.602Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adfb641115bf6cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T06:05:11.604568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"info","ts":"2026-04-16T06:05:11.604856Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","added-peer-id":"adfb641115bf6cbd","added-peer-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-04-16T06:05:11.606613Z","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-16T06:05:11.606759Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-04-16T06:05:11.606829Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-04-16T06:05:11.606897Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adfb641115bf6cbd","initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T06:05:11.606929Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T06:05:12.587748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T06:05:12.5879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T06:05:12.587978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"} {"level":"info","ts":"2026-04-16T06:05:12.588022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"} {"level":"info","ts":"2026-04-16T06:05:12.588063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-04-16T06:05:12.588132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"} {"level":"info","ts":"2026-04-16T06:05:12.588179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-04-16T06:05:12.589211Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adfb641115bf6cbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.209:2379]}","request-path":"/0/members/adfb641115bf6cbd/attributes","cluster-id":"3da6b677d4b80c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T06:05:12.589218Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:05:12.589268Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:12.589452Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:05:12.589585Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T06:05:12.589619Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T06:05:12.590255Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:12.590541Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:12.59059Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:12.592779Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T06:05:12.597639Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"} {"level":"warn","ts":"2026-04-16T06:05:22.1304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.622391ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:05:22.130613Z","caller":"traceutil/trace.go:171","msg":"trace[419648592] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:396; }","duration":"184.399683ms","start":"2026-04-16T06:05:21.946182Z","end":"2026-04-16T06:05:22.130581Z","steps":["trace[419648592] 'read index received' (duration: 41.73876ms)","trace[419648592] 'applied index is now lower than readState.Index' (duration: 142.658523ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:22.130732Z","caller":"traceutil/trace.go:171","msg":"trace[988720124] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"226.885857ms","start":"2026-04-16T06:05:21.903782Z","end":"2026-04-16T06:05:22.130668Z","steps":["trace[988720124] 'process raft request' (duration: 84.228965ms)","trace[988720124] 'compare' (duration: 141.407467ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:22.130836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.255793ms","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-16T06:05:22.130872Z","caller":"traceutil/trace.go:171","msg":"trace[1636502838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:388; }","duration":"157.367965ms","start":"2026-04-16T06:05:21.973493Z","end":"2026-04-16T06:05:22.130861Z","steps":["trace[1636502838] 'agreement among raft nodes before linearized reading' (duration: 157.263683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:22.130952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.663858ms","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-16T06:05:22.131136Z","caller":"traceutil/trace.go:171","msg":"trace[965108301] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:388; }","duration":"184.994534ms","start":"2026-04-16T06:05:21.94611Z","end":"2026-04-16T06:05:22.131104Z","steps":["trace[965108301] 'agreement among raft nodes before linearized reading' (duration: 184.622108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:22.378134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.101221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-04-16T06:05:22.378245Z","caller":"traceutil/trace.go:171","msg":"trace[1233657873] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:390; }","duration":"139.283774ms","start":"2026-04-16T06:05:22.23894Z","end":"2026-04-16T06:05:22.378224Z","steps":["trace[1233657873] 'range keys from in-memory index tree' (duration: 138.934926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:22.71496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.803367ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:05:22.715088Z","caller":"traceutil/trace.go:171","msg":"trace[643975760] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"242.176107ms","start":"2026-04-16T06:05:22.472893Z","end":"2026-04-16T06:05:22.715069Z","steps":["trace[643975760] 'process raft request' (duration: 117.172196ms)","trace[643975760] 'compare' (duration: 124.626564ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:42.2485Z","caller":"traceutil/trace.go:171","msg":"trace[1712074899] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"921.504967ms","start":"2026-04-16T06:05:41.326972Z","end":"2026-04-16T06:05:42.248477Z","steps":["trace[1712074899] 'process raft request' (duration: 921.361385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.248628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.326957Z","time spent":"921.6147ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.559515Z","caller":"traceutil/trace.go:171","msg":"trace[1724740861] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.227220014s","start":"2026-04-16T06:05:41.332231Z","end":"2026-04-16T06:05:42.559451Z","steps":["trace[1724740861] 'process raft request' (duration: 1.226963069s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:42.559604Z","caller":"traceutil/trace.go:171","msg":"trace[1486194102] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.225222077s","start":"2026-04-16T06:05:41.334344Z","end":"2026-04-16T06:05:42.559566Z","steps":["trace[1486194102] 'process raft request' (duration: 1.224984394s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.559689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.332224Z","time spent":"1.227386326s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.559639Z","caller":"traceutil/trace.go:171","msg":"trace[587961416] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.220599695s","start":"2026-04-16T06:05:41.339001Z","end":"2026-04-16T06:05:42.559601Z","steps":["trace[587961416] 'process raft request' (duration: 1.220383571s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.55974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.334322Z","time spent":"1.22535281s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:42.559853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.338992Z","time spent":"1.220794948s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.55991Z","caller":"traceutil/trace.go:171","msg":"trace[873909829] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.215546007s","start":"2026-04-16T06:05:41.344352Z","end":"2026-04-16T06:05:42.559898Z","steps":["trace[873909829] 'process raft request' (duration: 1.215353403s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:42.559925Z","caller":"traceutil/trace.go:171","msg":"trace[1568701687] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.217679105s","start":"2026-04-16T06:05:41.342216Z","end":"2026-04-16T06:05:42.559895Z","steps":["trace[1568701687] 'process raft request' (duration: 1.217209986s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.559969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.344334Z","time spent":"1.215609858s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.559921Z","caller":"traceutil/trace.go:171","msg":"trace[943052848] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.216584354s","start":"2026-04-16T06:05:41.343285Z","end":"2026-04-16T06:05:42.559869Z","steps":["trace[943052848] 'process raft request' (duration: 1.216345209s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.560026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.342199Z","time spent":"1.217789266s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.560085Z","caller":"traceutil/trace.go:171","msg":"trace[403264669] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.201276223s","start":"2026-04-16T06:05:41.358789Z","end":"2026-04-16T06:05:42.560065Z","steps":["trace[403264669] 'process raft request' (duration: 1.200997537s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.560124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.343275Z","time spent":"1.216767387s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:42.560192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.358772Z","time spent":"1.201380534s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.56035Z","caller":"traceutil/trace.go:171","msg":"trace[1035359167] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.18933128s","start":"2026-04-16T06:05:41.371009Z","end":"2026-04-16T06:05:42.56034Z","steps":["trace[1035359167] 'process raft request' (duration: 1.188829322s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.560399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.370991Z","time spent":"1.189393521s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.560411Z","caller":"traceutil/trace.go:171","msg":"trace[121145792] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:522; }","duration":"330.176869ms","start":"2026-04-16T06:05:42.23022Z","end":"2026-04-16T06:05:42.560397Z","steps":["trace[121145792] 'read index received' (duration: 18.330974ms)","trace[121145792] 'applied index is now lower than readState.Index' (duration: 311.845135ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:42.560456Z","caller":"traceutil/trace.go:171","msg":"trace[157336731] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.166244909s","start":"2026-04-16T06:05:41.394198Z","end":"2026-04-16T06:05:42.560443Z","steps":["trace[157336731] 'process raft request' (duration: 1.166058656s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:42.560483Z","caller":"traceutil/trace.go:171","msg":"trace[1481466472] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.039094769s","start":"2026-04-16T06:05:41.521379Z","end":"2026-04-16T06:05:42.560474Z","steps":["trace[1481466472] 'process raft request' (duration: 1.038961257s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.560515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.394173Z","time spent":"1.166317241s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:42.560537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.521353Z","time spent":"1.039155831s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.560471Z","caller":"traceutil/trace.go:171","msg":"trace[1849634567] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.217189654s","start":"2026-04-16T06:05:41.343119Z","end":"2026-04-16T06:05:42.560309Z","steps":["trace[1849634567] 'process raft request' (duration: 1.216450661s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.560692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.476545ms","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-16T06:05:42.560742Z","caller":"traceutil/trace.go:171","msg":"trace[820328923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"330.517855ms","start":"2026-04-16T06:05:42.230205Z","end":"2026-04-16T06:05:42.560723Z","steps":["trace[820328923] 'agreement among raft nodes before linearized reading' (duration: 330.329922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.560778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:42.23014Z","time spent":"330.632927ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T06:05:42.560759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:41.343109Z","time spent":"1.217557421s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:42.565814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.776691ms","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-16T06:05:42.565871Z","caller":"traceutil/trace.go:171","msg":"trace[748605964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"204.874634ms","start":"2026-04-16T06:05:42.360983Z","end":"2026-04-16T06:05:42.565857Z","steps":["trace[748605964] 'agreement among raft nodes before linearized reading' (duration: 204.723211ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:42.566079Z","caller":"traceutil/trace.go:171","msg":"trace[178584769] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"312.212571ms","start":"2026-04-16T06:05:42.253859Z","end":"2026-04-16T06:05:42.566071Z","steps":["trace[178584769] 'process raft request' (duration: 311.661342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.566136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:42.253835Z","time spent":"312.266783ms","remote":"127.0.0.1:44818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:42.566225Z","caller":"traceutil/trace.go:171","msg":"trace[304698697] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"310.018463ms","start":"2026-04-16T06:05:42.256199Z","end":"2026-04-16T06:05:42.566218Z","steps":["trace[304698697] 'process raft request' (duration: 309.398641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.566269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:42.256175Z","time spent":"310.068174ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:42.566355Z","caller":"traceutil/trace.go:171","msg":"trace[415458091] transaction","detail":"{read_only:false; number_of_response:1; response_revision:520; }","duration":"306.713484ms","start":"2026-04-16T06:05:42.259634Z","end":"2026-04-16T06:05:42.566347Z","steps":["trace[415458091] 'process raft request' (duration: 306.005551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:42.566393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:42.259623Z","time spent":"306.750505ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:44.808568Z","caller":"traceutil/trace.go:171","msg":"trace[453659889] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"128.064213ms","start":"2026-04-16T06:05:44.680484Z","end":"2026-04-16T06:05:44.808548Z","steps":["trace[453659889] 'process raft request' (duration: 40.511668ms)","trace[453659889] 'compare' (duration: 87.463052ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:45.186805Z","caller":"traceutil/trace.go:171","msg":"trace[646533614] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"137.389314ms","start":"2026-04-16T06:05:45.049389Z","end":"2026-04-16T06:05:45.186779Z","steps":["trace[646533614] 'process raft request' (duration: 137.206401ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:45.765356Z","caller":"traceutil/trace.go:171","msg":"trace[1876127484] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"149.388863ms","start":"2026-04-16T06:05:45.615931Z","end":"2026-04-16T06:05:45.76532Z","steps":["trace[1876127484] 'process raft request' (duration: 148.930485ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:47.370107Z","caller":"traceutil/trace.go:171","msg":"trace[1231584893] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"100.708557ms","start":"2026-04-16T06:05:47.269375Z","end":"2026-04-16T06:05:47.370083Z","steps":["trace[1231584893] 'process raft request' (duration: 100.168099ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:49.826012Z","caller":"traceutil/trace.go:171","msg":"trace[1587634675] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"450.39877ms","start":"2026-04-16T06:05:49.375582Z","end":"2026-04-16T06:05:49.825981Z","steps":["trace[1587634675] 'read index received' (duration: 449.566686ms)","trace[1587634675] 'applied index is now lower than readState.Index' (duration: 831.054µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:49.826069Z","caller":"traceutil/trace.go:171","msg":"trace[495916656] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"462.966965ms","start":"2026-04-16T06:05:49.363071Z","end":"2026-04-16T06:05:49.826038Z","steps":["trace[495916656] 'process raft request' (duration: 462.336255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:49.826199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:49.363041Z","time spent":"463.085228ms","remote":"127.0.0.1:44324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:49.826241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.628444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-btnrv\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-16T06:05:49.826297Z","caller":"traceutil/trace.go:171","msg":"trace[1114665293] range","detail":"{range_begin:/registry/pods/kube-system/cilium-btnrv; range_end:; response_count:1; response_revision:620; }","duration":"450.747316ms","start":"2026-04-16T06:05:49.375529Z","end":"2026-04-16T06:05:49.826276Z","steps":["trace[1114665293] 'agreement among raft nodes before linearized reading' (duration: 450.572424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:49.82635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:49.375511Z","time spent":"450.825327ms","remote":"127.0.0.1:44432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-btnrv\" "} {"level":"info","ts":"2026-04-16T06:05:50.1355Z","caller":"traceutil/trace.go:171","msg":"trace[281735454] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"294.642927ms","start":"2026-04-16T06:05:49.840827Z","end":"2026-04-16T06:05:50.13547Z","steps":["trace[281735454] 'process raft request' (duration: 294.469374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:50.952052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.463897ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:05:50.952425Z","caller":"traceutil/trace.go:171","msg":"trace[434621745] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"1.063815142s","start":"2026-04-16T06:05:49.888569Z","end":"2026-04-16T06:05:50.952384Z","steps":["trace[434621745] 'process raft request' (duration: 344.969999ms)","trace[434621745] 'compare' (duration: 718.315255ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:50.952564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:49.888549Z","time spent":"1.063952846s","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:05:50.953113Z","caller":"traceutil/trace.go:171","msg":"trace[7552141] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"865.591201ms","start":"2026-04-16T06:05:50.087459Z","end":"2026-04-16T06:05:50.95305Z","steps":["trace[7552141] 'read index received' (duration: 47.862224ms)","trace[7552141] 'applied index is now lower than readState.Index' (duration: 817.724287ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:51.172039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.832908ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T06:05:51.172149Z","caller":"traceutil/trace.go:171","msg":"trace[1852571687] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"218.961173ms","start":"2026-04-16T06:05:50.953171Z","end":"2026-04-16T06:05:51.172132Z","steps":["trace[1852571687] 'read index received' (duration: 621.12µs)","trace[1852571687] 'applied index is now lower than readState.Index' (duration: 218.338763ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:51.172374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.247885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.172409Z","caller":"traceutil/trace.go:171","msg":"trace[1951338819] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:622; }","duration":"378.309236ms","start":"2026-04-16T06:05:50.79409Z","end":"2026-04-16T06:05:51.172399Z","steps":["trace[1951338819] 'agreement among raft nodes before linearized reading' (duration: 378.118052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.17248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.794082Z","time spent":"378.391238ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-16T06:05:51.172551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.265305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.172662Z","caller":"traceutil/trace.go:171","msg":"trace[1027878237] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:622; }","duration":"378.650361ms","start":"2026-04-16T06:05:50.793961Z","end":"2026-04-16T06:05:51.172611Z","steps":["trace[1027878237] 'agreement among raft nodes before linearized reading' (duration: 378.188053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.172731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.793918Z","time spent":"378.802094ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:05:51.173009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085556471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.173037Z","caller":"traceutil/trace.go:171","msg":"trace[1284726080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"1.085618673s","start":"2026-04-16T06:05:50.087411Z","end":"2026-04-16T06:05:51.173029Z","steps":["trace[1284726080] 'agreement among raft nodes before linearized reading' (duration: 865.842736ms)","trace[1284726080] 'range keys from in-memory index tree' (duration: 219.725736ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:51.173116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.087392Z","time spent":"1.085717875s","remote":"127.0.0.1:44182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T06:05:51.173352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.422374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.173384Z","caller":"traceutil/trace.go:171","msg":"trace[129943542] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:622; }","duration":"379.481906ms","start":"2026-04-16T06:05:50.793893Z","end":"2026-04-16T06:05:51.173375Z","steps":["trace[129943542] 'agreement among raft nodes before linearized reading' (duration: 379.435275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.17346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.793877Z","time spent":"379.575447ms","remote":"127.0.0.1:44034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:51.173575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.986488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:51.173574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.270338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.173604Z","caller":"traceutil/trace.go:171","msg":"trace[201128770] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"313.321089ms","start":"2026-04-16T06:05:50.860274Z","end":"2026-04-16T06:05:51.173596Z","steps":["trace[201128770] 'agreement among raft nodes before linearized reading' (duration: 313.275348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.173632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.860254Z","time spent":"313.37148ms","remote":"127.0.0.1:44046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T06:05:51.173673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.78362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.173696Z","caller":"traceutil/trace.go:171","msg":"trace[564338656] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"409.867412ms","start":"2026-04-16T06:05:50.763824Z","end":"2026-04-16T06:05:51.173691Z","steps":["trace[564338656] 'agreement among raft nodes before linearized reading' (duration: 409.832931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.173715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.763795Z","time spent":"409.915833ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:05:51.173807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.072526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.173824Z","caller":"traceutil/trace.go:171","msg":"trace[2128661748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"410.129367ms","start":"2026-04-16T06:05:50.763691Z","end":"2026-04-16T06:05:51.173821Z","steps":["trace[2128661748] 'agreement among raft nodes before linearized reading' (duration: 410.101216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.17382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.737883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:51.173839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.763672Z","time spent":"410.162648ms","remote":"127.0.0.1:44018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-16T06:05:51.173886Z","caller":"traceutil/trace.go:171","msg":"trace[2105297342] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"314.802145ms","start":"2026-04-16T06:05:50.859044Z","end":"2026-04-16T06:05:51.173846Z","steps":["trace[2105297342] 'agreement among raft nodes before linearized reading' (duration: 314.735754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.173925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.859025Z","time spent":"314.883736ms","remote":"127.0.0.1:44046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:51.17405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.004548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.174073Z","caller":"traceutil/trace.go:171","msg":"trace[44860872] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"315.051228ms","start":"2026-04-16T06:05:50.859017Z","end":"2026-04-16T06:05:51.174068Z","steps":["trace[44860872] 'agreement among raft nodes before linearized reading' (duration: 315.014338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.859006Z","time spent":"315.079769ms","remote":"127.0.0.1:44046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:05:51.174199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.174964ms","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-16T06:05:51.174227Z","caller":"traceutil/trace.go:171","msg":"trace[154630261] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:622; }","duration":"743.244176ms","start":"2026-04-16T06:05:50.430976Z","end":"2026-04-16T06:05:51.17422Z","steps":["trace[154630261] 'agreement among raft nodes before linearized reading' (duration: 743.195445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.17425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.430955Z","time spent":"743.288176ms","remote":"127.0.0.1:44002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:51.17425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.900176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.174279Z","caller":"traceutil/trace.go:171","msg":"trace[2050016717] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:622; }","duration":"334.953707ms","start":"2026-04-16T06:05:50.839319Z","end":"2026-04-16T06:05:51.174273Z","steps":["trace[2050016717] 'agreement among raft nodes before linearized reading' (duration: 334.918616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.755586ms","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-16T06:05:51.174301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.839286Z","time spent":"335.010618ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:05:51.174364Z","caller":"traceutil/trace.go:171","msg":"trace[146513221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"475.010321ms","start":"2026-04-16T06:05:50.699343Z","end":"2026-04-16T06:05:51.174354Z","steps":["trace[146513221] 'agreement among raft nodes before linearized reading' (duration: 474.706646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.699335Z","time spent":"475.054311ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:05:51.174419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.978245ms","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-16T06:05:51.174442Z","caller":"traceutil/trace.go:171","msg":"trace[1721910255] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"477.026846ms","start":"2026-04-16T06:05:50.69741Z","end":"2026-04-16T06:05:51.174437Z","steps":["trace[1721910255] 'agreement among raft nodes before linearized reading' (duration: 476.943874ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.17446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.697406Z","time spent":"477.050956ms","remote":"127.0.0.1:44522","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":"warn","ts":"2026-04-16T06:05:51.174451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.266853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.174511Z","caller":"traceutil/trace.go:171","msg":"trace[2091945776] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:622; }","duration":"335.340714ms","start":"2026-04-16T06:05:50.839164Z","end":"2026-04-16T06:05:51.174504Z","steps":["trace[2091945776] 'agreement among raft nodes before linearized reading' (duration: 335.269503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.516405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-16T06:05:51.174591Z","caller":"traceutil/trace.go:171","msg":"trace[1858473513] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:622; }","duration":"218.570346ms","start":"2026-04-16T06:05:50.956015Z","end":"2026-04-16T06:05:51.174585Z","steps":["trace[1858473513] 'agreement among raft nodes before linearized reading' (duration: 218.530806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.839157Z","time spent":"335.389285ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:51.174595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.058314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.174611Z","caller":"traceutil/trace.go:171","msg":"trace[241898224] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"555.101414ms","start":"2026-04-16T06:05:50.619505Z","end":"2026-04-16T06:05:51.174606Z","steps":["trace[241898224] 'agreement among raft nodes before linearized reading' (duration: 555.077343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.17463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.619489Z","time spent":"555.136775ms","remote":"127.0.0.1:44014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:05:51.174707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.299177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:51.174718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.719331ms","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-16T06:05:51.174738Z","caller":"traceutil/trace.go:171","msg":"trace[2106184616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"348.774333ms","start":"2026-04-16T06:05:50.825958Z","end":"2026-04-16T06:05:51.174733Z","steps":["trace[2106184616] 'agreement among raft nodes before linearized reading' (duration: 348.712242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.825946Z","time spent":"348.813423ms","remote":"127.0.0.1:44522","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-16T06:05:51.174779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.985108ms","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-16T06:05:51.174794Z","caller":"traceutil/trace.go:171","msg":"trace[618952196] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:622; }","duration":"714.031759ms","start":"2026-04-16T06:05:50.460758Z","end":"2026-04-16T06:05:51.174789Z","steps":["trace[618952196] 'agreement among raft nodes before linearized reading' (duration: 713.992568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.46075Z","time spent":"714.056979ms","remote":"127.0.0.1:44010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"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-16T06:05:51.174888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.149551ms","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-16T06:05:51.174905Z","caller":"traceutil/trace.go:171","msg":"trace[130686192] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:622; }","duration":"714.194901ms","start":"2026-04-16T06:05:50.460706Z","end":"2026-04-16T06:05:51.174901Z","steps":["trace[130686192] 'agreement among raft nodes before linearized reading' (duration: 714.168681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.502931ms","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-16T06:05:51.173596Z","caller":"traceutil/trace.go:171","msg":"trace[2090711465] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"409.032388ms","start":"2026-04-16T06:05:50.764558Z","end":"2026-04-16T06:05:51.17359Z","steps":["trace[2090711465] 'agreement among raft nodes before linearized reading' (duration: 408.995987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.244934ms","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":"info","ts":"2026-04-16T06:05:51.174994Z","caller":"traceutil/trace.go:171","msg":"trace[963083133] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:622; }","duration":"124.286645ms","start":"2026-04-16T06:05:51.050703Z","end":"2026-04-16T06:05:51.17499Z","steps":["trace[963083133] 'agreement among raft nodes before linearized reading' (duration: 124.263854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.764546Z","time spent":"410.436932ms","remote":"127.0.0.1:44014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-16T06:05:51.175071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.933034ms","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":"info","ts":"2026-04-16T06:05:51.175089Z","caller":"traceutil/trace.go:171","msg":"trace[1290077466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"141.967714ms","start":"2026-04-16T06:05:51.033117Z","end":"2026-04-16T06:05:51.175085Z","steps":["trace[1290077466] 'agreement among raft nodes before linearized reading' (duration: 141.939784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.175173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.21235ms","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-16T06:05:51.175191Z","caller":"traceutil/trace.go:171","msg":"trace[276864427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"142.246931ms","start":"2026-04-16T06:05:51.03294Z","end":"2026-04-16T06:05:51.175187Z","steps":["trace[276864427] 'agreement among raft nodes before linearized reading' (duration: 142.21787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.591592ms","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-16T06:05:51.175217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.543705ms","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":"info","ts":"2026-04-16T06:05:51.175236Z","caller":"traceutil/trace.go:171","msg":"trace[1672523085] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"142.587336ms","start":"2026-04-16T06:05:51.032643Z","end":"2026-04-16T06:05:51.17523Z","steps":["trace[1672523085] 'agreement among raft nodes before linearized reading' (duration: 142.556796ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:51.174724Z","caller":"traceutil/trace.go:171","msg":"trace[1916541430] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:622; }","duration":"555.317478ms","start":"2026-04-16T06:05:50.619402Z","end":"2026-04-16T06:05:51.17472Z","steps":["trace[1916541430] 'agreement among raft nodes before linearized reading' (duration: 555.292087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.175327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.227523ms","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":"info","ts":"2026-04-16T06:05:51.175346Z","caller":"traceutil/trace.go:171","msg":"trace[395320046] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"177.268094ms","start":"2026-04-16T06:05:50.998074Z","end":"2026-04-16T06:05:51.175342Z","steps":["trace[395320046] 'agreement among raft nodes before linearized reading' (duration: 177.237134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.175424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.359185ms","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-16T06:05:51.175441Z","caller":"traceutil/trace.go:171","msg":"trace[238413493] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:622; }","duration":"177.408856ms","start":"2026-04-16T06:05:50.998028Z","end":"2026-04-16T06:05:51.175437Z","steps":["trace[238413493] 'agreement among raft nodes before linearized reading' (duration: 177.382495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.175499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.181983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:51.17529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.619364Z","time spent":"555.916258ms","remote":"127.0.0.1:44014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:51.175555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.556548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.175583Z","caller":"traceutil/trace.go:171","msg":"trace[860781687] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"207.62382ms","start":"2026-04-16T06:05:50.967955Z","end":"2026-04-16T06:05:51.175578Z","steps":["trace[860781687] 'agreement among raft nodes before linearized reading' (duration: 207.589279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.285722ms","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-16T06:05:51.175659Z","caller":"traceutil/trace.go:171","msg":"trace[610110232] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:622; }","duration":"712.230618ms","start":"2026-04-16T06:05:50.46342Z","end":"2026-04-16T06:05:51.175651Z","steps":["trace[610110232] 'agreement among raft nodes before linearized reading' (duration: 711.311793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.174919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.460692Z","time spent":"714.223732ms","remote":"127.0.0.1:44010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:05:51.174567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.368341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T06:05:51.175794Z","caller":"traceutil/trace.go:171","msg":"trace[101839179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:622; }","duration":"478.587481ms","start":"2026-04-16T06:05:50.697194Z","end":"2026-04-16T06:05:51.175782Z","steps":["trace[101839179] 'agreement among raft nodes before linearized reading' (duration: 477.339891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.175812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.697136Z","time spent":"478.670612ms","remote":"127.0.0.1:44522","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-16T06:05:51.174959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.067441ms","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-16T06:05:51.175894Z","caller":"traceutil/trace.go:171","msg":"trace[1559534402] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:622; }","duration":"125.026759ms","start":"2026-04-16T06:05:51.050861Z","end":"2026-04-16T06:05:51.175888Z","steps":["trace[1559534402] 'agreement among raft nodes before linearized reading' (duration: 124.087642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.175536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.505738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:51.174225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.332757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:51.175974Z","caller":"traceutil/trace.go:171","msg":"trace[617260436] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"207.958476ms","start":"2026-04-16T06:05:50.96801Z","end":"2026-04-16T06:05:51.175968Z","steps":["trace[617260436] 'agreement among raft nodes before linearized reading' (duration: 207.515228ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:51.17599Z","caller":"traceutil/trace.go:171","msg":"trace[837578200] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:622; }","duration":"336.124057ms","start":"2026-04-16T06:05:50.839858Z","end":"2026-04-16T06:05:51.175982Z","steps":["trace[837578200] 'agreement among raft nodes before linearized reading' (duration: 334.344597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.175719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.4634Z","time spent":"712.308289ms","remote":"127.0.0.1:44002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-04-16T06:05:51.174938Z","caller":"traceutil/trace.go:171","msg":"trace[1541074852] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:622; }","duration":"123.543773ms","start":"2026-04-16T06:05:51.051389Z","end":"2026-04-16T06:05:51.174932Z","steps":["trace[1541074852] 'agreement among raft nodes before linearized reading' (duration: 123.510132ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:51.175231Z","caller":"traceutil/trace.go:171","msg":"trace[478349884] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:622; }","duration":"744.320645ms","start":"2026-04-16T06:05:50.430898Z","end":"2026-04-16T06:05:51.175219Z","steps":["trace[478349884] 'agreement among raft nodes before linearized reading' (duration: 743.601053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.176494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.43088Z","time spent":"745.606456ms","remote":"127.0.0.1:44002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:05:51.175517Z","caller":"traceutil/trace.go:171","msg":"trace[1587702734] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"207.199373ms","start":"2026-04-16T06:05:50.968312Z","end":"2026-04-16T06:05:51.175512Z","steps":["trace[1587702734] 'agreement among raft nodes before linearized reading' (duration: 207.174232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:51.176464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:50.839848Z","time spent":"336.164828ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T06:05:52.513606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.128579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:05:52.513681Z","caller":"traceutil/trace.go:171","msg":"trace[664048032] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"102.375147ms","start":"2026-04-16T06:05:52.411293Z","end":"2026-04-16T06:05:52.513669Z","steps":["trace[664048032] 'read index received' (duration: 2.075195ms)","trace[664048032] 'applied index is now lower than readState.Index' (duration: 100.299162ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:52.513879Z","caller":"traceutil/trace.go:171","msg":"trace[2140708263] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"105.289116ms","start":"2026-04-16T06:05:52.408555Z","end":"2026-04-16T06:05:52.513844Z","steps":["trace[2140708263] 'compare' (duration: 100.042317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:52.513913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.619461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:52.514098Z","caller":"traceutil/trace.go:171","msg":"trace[1319760709] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:641; }","duration":"102.825254ms","start":"2026-04-16T06:05:52.411261Z","end":"2026-04-16T06:05:52.514086Z","steps":["trace[1319760709] 'agreement among raft nodes before linearized reading' (duration: 102.54774ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:52.684411Z","caller":"traceutil/trace.go:171","msg":"trace[1240948819] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"166.409695ms","start":"2026-04-16T06:05:52.517958Z","end":"2026-04-16T06:05:52.684367Z","steps":["trace[1240948819] 'read index received' (duration: 105.980097ms)","trace[1240948819] 'applied index is now lower than readState.Index' (duration: 60.428488ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:52.684524Z","caller":"traceutil/trace.go:171","msg":"trace[521537216] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"168.41037ms","start":"2026-04-16T06:05:52.51605Z","end":"2026-04-16T06:05:52.684461Z","steps":["trace[521537216] 'process raft request' (duration: 107.949121ms)","trace[521537216] 'compare' (duration: 60.231115ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:52.684592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.61538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-6v2lh\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-04-16T06:05:52.684829Z","caller":"traceutil/trace.go:171","msg":"trace[2099597803] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-6v2lh; range_end:; response_count:1; response_revision:642; }","duration":"166.847824ms","start":"2026-04-16T06:05:52.517914Z","end":"2026-04-16T06:05:52.684762Z","steps":["trace[2099597803] 'agreement among raft nodes before linearized reading' (duration: 166.550648ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:52.932067Z","caller":"traceutil/trace.go:171","msg":"trace[264541416] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"241.293109ms","start":"2026-04-16T06:05:52.69075Z","end":"2026-04-16T06:05:52.932044Z","steps":["trace[264541416] 'process raft request' (duration: 241.162097ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:53.007903Z","caller":"traceutil/trace.go:171","msg":"trace[1710108214] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:662; }","duration":"311.179747ms","start":"2026-04-16T06:05:52.696697Z","end":"2026-04-16T06:05:53.007876Z","steps":["trace[1710108214] 'read index received' (duration: 235.207316ms)","trace[1710108214] 'applied index is now lower than readState.Index' (duration: 75.971481ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:53.007957Z","caller":"traceutil/trace.go:171","msg":"trace[1793200658] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"311.583794ms","start":"2026-04-16T06:05:52.696338Z","end":"2026-04-16T06:05:53.007922Z","steps":["trace[1793200658] 'process raft request' (duration: 311.355191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.008204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.696319Z","time spent":"311.710547ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:53.009048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.326846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:53.009043Z","caller":"traceutil/trace.go:171","msg":"trace[1030491615] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"311.472672ms","start":"2026-04-16T06:05:52.696763Z","end":"2026-04-16T06:05:53.008235Z","steps":["trace[1030491615] 'process raft request' (duration: 311.073095ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:53.009132Z","caller":"traceutil/trace.go:171","msg":"trace[532443452] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:646; }","duration":"312.432487ms","start":"2026-04-16T06:05:52.696671Z","end":"2026-04-16T06:05:53.009104Z","steps":["trace[532443452] 'agreement among raft nodes before linearized reading' (duration: 311.565943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.009201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.696665Z","time spent":"312.52444ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-04-16T06:05:53.009338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.696757Z","time spent":"312.461198ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:53.509043Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7835592189512788063,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T06:05:53.612886Z","caller":"traceutil/trace.go:171","msg":"trace[1831997655] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"677.835906ms","start":"2026-04-16T06:05:52.935025Z","end":"2026-04-16T06:05:53.612861Z","steps":["trace[1831997655] 'process raft request' (duration: 677.693863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.613044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.935004Z","time spent":"677.964038ms","remote":"127.0.0.1:44302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:53.749171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.319097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:05:53.749452Z","caller":"traceutil/trace.go:171","msg":"trace[578348880] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"736.983283ms","start":"2026-04-16T06:05:53.012446Z","end":"2026-04-16T06:05:53.74943Z","steps":["trace[578348880] 'process raft request' (duration: 634.285989ms)","trace[578348880] 'compare' (duration: 102.206016ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:53.749504Z","caller":"traceutil/trace.go:171","msg":"trace[1581672138] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"735.60215ms","start":"2026-04-16T06:05:53.013874Z","end":"2026-04-16T06:05:53.749476Z","steps":["trace[1581672138] 'process raft request' (duration: 735.426516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.749595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.012424Z","time spent":"737.099996ms","remote":"127.0.0.1:44818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":932,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:53.749616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044469498s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:53.74965Z","caller":"traceutil/trace.go:171","msg":"trace[706402951] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"1.044524708s","start":"2026-04-16T06:05:52.705115Z","end":"2026-04-16T06:05:53.749639Z","steps":["trace[706402951] 'agreement among raft nodes before linearized reading' (duration: 1.044401217s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.749657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.013862Z","time spent":"735.714452ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5562,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:53.749696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.705106Z","time spent":"1.044580289s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:05:53.749489Z","caller":"traceutil/trace.go:171","msg":"trace[1099644932] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:665; }","duration":"741.496189ms","start":"2026-04-16T06:05:53.007973Z","end":"2026-04-16T06:05:53.749469Z","steps":["trace[1099644932] 'read index received' (duration: 604.779533ms)","trace[1099644932] 'applied index is now lower than readState.Index' (duration: 136.715546ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:53.749825Z","caller":"traceutil/trace.go:171","msg":"trace[947788404] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"456.561795ms","start":"2026-04-16T06:05:53.293252Z","end":"2026-04-16T06:05:53.749814Z","steps":["trace[947788404] 'process raft request' (duration: 456.173939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.749882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.849739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:53.749907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043785586s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:53.749921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.043805057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:53.749957Z","caller":"traceutil/trace.go:171","msg":"trace[798380963] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"1.043848187s","start":"2026-04-16T06:05:52.706098Z","end":"2026-04-16T06:05:53.749946Z","steps":["trace[798380963] 'agreement among raft nodes before linearized reading' (duration: 1.043803086s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.749983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.238912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T06:05:53.749983Z","caller":"traceutil/trace.go:171","msg":"trace[262703581] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"1.043822747s","start":"2026-04-16T06:05:52.706103Z","end":"2026-04-16T06:05:53.749925Z","steps":["trace[262703581] 'agreement among raft nodes before linearized reading' (duration: 1.043772716s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.74999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.706092Z","time spent":"1.043891028s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:05:53.750001Z","caller":"traceutil/trace.go:171","msg":"trace[1502870224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"555.257202ms","start":"2026-04-16T06:05:53.194739Z","end":"2026-04-16T06:05:53.749996Z","steps":["trace[1502870224] 'agreement among raft nodes before linearized reading' (duration: 555.184851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.194683Z","time spent":"555.331253ms","remote":"127.0.0.1:44522","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-16T06:05:53.75004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.124759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-16T06:05:53.750089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.041271424s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:53.750137Z","caller":"traceutil/trace.go:171","msg":"trace[544271862] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"1.041329515s","start":"2026-04-16T06:05:52.708798Z","end":"2026-04-16T06:05:53.750128Z","steps":["trace[544271862] 'agreement among raft nodes before linearized reading' (duration: 1.041276514s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.562642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-btnrv\" ","response":"range_response_count:1 size:17524"} {"level":"warn","ts":"2026-04-16T06:05:53.75012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.2664ms","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-16T06:05:53.75017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.939848ms","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-16T06:05:53.750194Z","caller":"traceutil/trace.go:171","msg":"trace[52571927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:650; }","duration":"554.964008ms","start":"2026-04-16T06:05:53.195226Z","end":"2026-04-16T06:05:53.75019Z","steps":["trace[52571927] 'agreement among raft nodes before linearized reading' (duration: 554.889727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.75021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045008297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:53.750203Z","caller":"traceutil/trace.go:171","msg":"trace[2090279773] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"556.393382ms","start":"2026-04-16T06:05:53.193795Z","end":"2026-04-16T06:05:53.750188Z","steps":["trace[2090279773] 'agreement among raft nodes before linearized reading' (duration: 556.173507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.84798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5577"} {"level":"warn","ts":"2026-04-16T06:05:53.750219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.195206Z","time spent":"555.005958ms","remote":"127.0.0.1:44522","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-16T06:05:53.750227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.045071548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:53.750231Z","caller":"traceutil/trace.go:171","msg":"trace[373191573] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"1.045059587s","start":"2026-04-16T06:05:52.705165Z","end":"2026-04-16T06:05:53.750225Z","steps":["trace[373191573] 'agreement among raft nodes before linearized reading' (duration: 1.045028137s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:53.750237Z","caller":"traceutil/trace.go:171","msg":"trace[1703443291] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:650; }","duration":"235.915101ms","start":"2026-04-16T06:05:53.514315Z","end":"2026-04-16T06:05:53.75023Z","steps":["trace[1703443291] 'agreement among raft nodes before linearized reading' (duration: 235.86594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.705148Z","time spent":"1.045098489s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:05:53.750249Z","caller":"traceutil/trace.go:171","msg":"trace[1200558067] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"1.045100159s","start":"2026-04-16T06:05:52.705142Z","end":"2026-04-16T06:05:53.750242Z","steps":["trace[1200558067] 'agreement among raft nodes before linearized reading' (duration: 1.045064528s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.193769Z","time spent":"556.467153ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:05:53.750271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.705139Z","time spent":"1.045126829s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:05:53.749914Z","caller":"traceutil/trace.go:171","msg":"trace[47536591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"662.951591ms","start":"2026-04-16T06:05:53.086956Z","end":"2026-04-16T06:05:53.749907Z","steps":["trace[47536591] 'agreement among raft nodes before linearized reading' (duration: 662.90254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.086936Z","time spent":"663.367158ms","remote":"127.0.0.1:44198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T06:05:53.750166Z","caller":"traceutil/trace.go:171","msg":"trace[1342268639] range","detail":"{range_begin:/registry/pods/kube-system/cilium-btnrv; range_end:; response_count:1; response_revision:650; }","duration":"342.618373ms","start":"2026-04-16T06:05:53.40754Z","end":"2026-04-16T06:05:53.750158Z","steps":["trace[1342268639] 'agreement among raft nodes before linearized reading' (duration: 342.532762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.407522Z","time spent":"342.827736ms","remote":"127.0.0.1:44432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17547,"request content":"key:\"/registry/pods/kube-system/cilium-btnrv\" "} {"level":"warn","ts":"2026-04-16T06:05:53.750014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.706097Z","time spent":"1.043909248s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-04-16T06:05:53.750062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.957337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:53.750451Z","caller":"traceutil/trace.go:171","msg":"trace[1987813735] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"860.392394ms","start":"2026-04-16T06:05:52.890051Z","end":"2026-04-16T06:05:53.750444Z","steps":["trace[1987813735] 'agreement among raft nodes before linearized reading' (duration: 859.976206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.890033Z","time spent":"860.435284ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:05:53.750099Z","caller":"traceutil/trace.go:171","msg":"trace[1481219061] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"555.216811ms","start":"2026-04-16T06:05:53.19487Z","end":"2026-04-16T06:05:53.750087Z","steps":["trace[1481219061] 'agreement among raft nodes before linearized reading' (duration: 555.019717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.194863Z","time spent":"555.634359ms","remote":"127.0.0.1:44522","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":"warn","ts":"2026-04-16T06:05:53.749879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.293229Z","time spent":"456.625506ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:53.75053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044117371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:05:53.750107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.443949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:53.750593Z","caller":"traceutil/trace.go:171","msg":"trace[1215822132] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"1.044189342s","start":"2026-04-16T06:05:52.706396Z","end":"2026-04-16T06:05:53.750585Z","steps":["trace[1215822132] 'agreement among raft nodes before linearized reading' (duration: 1.044117991s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.750617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.706389Z","time spent":"1.044223153s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:05:53.750614Z","caller":"traceutil/trace.go:171","msg":"trace[881881973] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:650; }","duration":"660.969937ms","start":"2026-04-16T06:05:53.089637Z","end":"2026-04-16T06:05:53.750607Z","steps":["trace[881881973] 'agreement among raft nodes before linearized reading' (duration: 660.457169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:53.75016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:52.708791Z","time spent":"1.041364305s","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-04-16T06:05:53.751675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:53.089625Z","time spent":"661.007648ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:05:53.974059Z","caller":"traceutil/trace.go:171","msg":"trace[1058474987] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"147.965404ms","start":"2026-04-16T06:05:53.826053Z","end":"2026-04-16T06:05:53.974019Z","steps":["trace[1058474987] 'process raft request' (duration: 134.936536ms)","trace[1058474987] 'compare' (duration: 12.868836ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:54.004298Z","caller":"traceutil/trace.go:171","msg":"trace[1401427095] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"177.589562ms","start":"2026-04-16T06:05:53.826695Z","end":"2026-04-16T06:05:54.004284Z","steps":["trace[1401427095] 'process raft request' (duration: 177.454599ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:54.004688Z","caller":"traceutil/trace.go:171","msg":"trace[376325810] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"172.738621ms","start":"2026-04-16T06:05:53.831921Z","end":"2026-04-16T06:05:54.004659Z","steps":["trace[376325810] 'process raft request' (duration: 172.315184ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:54.004823Z","caller":"traceutil/trace.go:171","msg":"trace[174347219] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"110.75987ms","start":"2026-04-16T06:05:53.894028Z","end":"2026-04-16T06:05:54.004788Z","steps":["trace[174347219] 'process raft request' (duration: 110.580957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:55.159551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.315935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T06:05:55.15964Z","caller":"traceutil/trace.go:171","msg":"trace[1444702247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:685; }","duration":"146.456747ms","start":"2026-04-16T06:05:55.013161Z","end":"2026-04-16T06:05:55.159618Z","steps":["trace[1444702247] 'range keys from in-memory index tree' (duration: 146.131862ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:55.161883Z","caller":"traceutil/trace.go:171","msg":"trace[1599485587] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"139.628063ms","start":"2026-04-16T06:05:55.022222Z","end":"2026-04-16T06:05:55.16185Z","steps":["trace[1599485587] 'process raft request' (duration: 139.358529ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:55.257578Z","caller":"traceutil/trace.go:171","msg":"trace[341518247] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"163.333499ms","start":"2026-04-16T06:05:55.094167Z","end":"2026-04-16T06:05:55.257501Z","steps":["trace[341518247] 'process raft request' (duration: 163.136265ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:55.301323Z","caller":"traceutil/trace.go:171","msg":"trace[1179274890] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"137.299695ms","start":"2026-04-16T06:05:55.163988Z","end":"2026-04-16T06:05:55.301287Z","steps":["trace[1179274890] 'process raft request' (duration: 137.072452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:55.596885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.03701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:05:55.597124Z","caller":"traceutil/trace.go:171","msg":"trace[1695883373] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"339.514831ms","start":"2026-04-16T06:05:55.257572Z","end":"2026-04-16T06:05:55.597087Z","steps":["trace[1695883373] 'process raft request' (duration: 178.188045ms)","trace[1695883373] 'compare' (duration: 160.831357ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:55.597335Z","caller":"traceutil/trace.go:171","msg":"trace[964991547] linearizableReadLoop","detail":"{readStateIndex:709; appliedIndex:707; }","duration":"312.427109ms","start":"2026-04-16T06:05:55.284889Z","end":"2026-04-16T06:05:55.597317Z","steps":["trace[964991547] 'read index received' (duration: 16.2714ms)","trace[964991547] 'applied index is now lower than readState.Index' (duration: 296.154659ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:55.597356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:55.257537Z","time spent":"339.693153ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:55.597443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.580962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:55.597424Z","caller":"traceutil/trace.go:171","msg":"trace[1380904282] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"326.997892ms","start":"2026-04-16T06:05:55.270384Z","end":"2026-04-16T06:05:55.597382Z","steps":["trace[1380904282] 'process raft request' (duration: 326.612716ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:55.597479Z","caller":"traceutil/trace.go:171","msg":"trace[1236555097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:690; }","duration":"312.621562ms","start":"2026-04-16T06:05:55.284848Z","end":"2026-04-16T06:05:55.59747Z","steps":["trace[1236555097] 'agreement among raft nodes before linearized reading' (duration: 312.561871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:55.597521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:55.284805Z","time spent":"312.707313ms","remote":"127.0.0.1:44182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T06:05:55.597588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:55.270359Z","time spent":"327.137204ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13205,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:55.648919Z","caller":"traceutil/trace.go:171","msg":"trace[712583167] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"339.833756ms","start":"2026-04-16T06:05:55.309059Z","end":"2026-04-16T06:05:55.648893Z","steps":["trace[712583167] 'process raft request' (duration: 339.51764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:55.649045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:55.309032Z","time spent":"339.947478ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:55.648923Z","caller":"traceutil/trace.go:171","msg":"trace[1362348565] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"325.384526ms","start":"2026-04-16T06:05:55.323513Z","end":"2026-04-16T06:05:55.648897Z","steps":["trace[1362348565] 'process raft request' (duration: 325.235023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:55.649218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:55.323478Z","time spent":"325.6732ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:55.686123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.738147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T06:05:55.686176Z","caller":"traceutil/trace.go:171","msg":"trace[1700432336] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:694; }","duration":"183.826299ms","start":"2026-04-16T06:05:55.502336Z","end":"2026-04-16T06:05:55.686162Z","steps":["trace[1700432336] 'agreement among raft nodes before linearized reading' (duration: 183.741578ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:55.686337Z","caller":"traceutil/trace.go:171","msg":"trace[675864618] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"241.153942ms","start":"2026-04-16T06:05:55.445124Z","end":"2026-04-16T06:05:55.686277Z","steps":["trace[675864618] 'process raft request' (duration: 240.647814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:55.686046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.800204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-btnrv\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-04-16T06:05:55.68663Z","caller":"traceutil/trace.go:171","msg":"trace[138418722] range","detail":"{range_begin:/registry/pods/kube-system/cilium-btnrv; range_end:; response_count:1; response_revision:694; }","duration":"242.435625ms","start":"2026-04-16T06:05:55.444175Z","end":"2026-04-16T06:05:55.686611Z","steps":["trace[138418722] 'agreement among raft nodes before linearized reading' (duration: 241.743104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:55.686704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.938558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-16T06:05:55.686816Z","caller":"traceutil/trace.go:171","msg":"trace[714783545] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:694; }","duration":"197.09234ms","start":"2026-04-16T06:05:55.489703Z","end":"2026-04-16T06:05:55.686796Z","steps":["trace[714783545] 'agreement among raft nodes before linearized reading' (duration: 196.562321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.267372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170831523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:08.267468Z","caller":"traceutil/trace.go:171","msg":"trace[1318936835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"1.170953116s","start":"2026-04-16T06:06:07.096481Z","end":"2026-04-16T06:06:08.267434Z","steps":["trace[1318936835] 'range keys from in-memory index tree' (duration: 1.170739862s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.267509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.096463Z","time spent":"1.171034167s","remote":"127.0.0.1:44182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T06:06:08.267789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.807571ms","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-16T06:06:08.267877Z","caller":"traceutil/trace.go:171","msg":"trace[1203029396] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:786; }","duration":"679.901643ms","start":"2026-04-16T06:06:07.587966Z","end":"2026-04-16T06:06:08.267867Z","steps":["trace[1203029396] 'range keys from in-memory index tree' (duration: 679.79824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.268019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.053715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T06:06:08.268078Z","caller":"traceutil/trace.go:171","msg":"trace[180874874] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:786; }","duration":"885.333379ms","start":"2026-04-16T06:06:07.382726Z","end":"2026-04-16T06:06:08.268059Z","steps":["trace[180874874] 'range keys from in-memory index tree' (duration: 884.919932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.268127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.382711Z","time spent":"885.40851ms","remote":"127.0.0.1:44522","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-16T06:06:08.275712Z","caller":"traceutil/trace.go:171","msg":"trace[1826195115] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"431.824219ms","start":"2026-04-16T06:06:07.84387Z","end":"2026-04-16T06:06:08.275694Z","steps":["trace[1826195115] 'read index received' (duration: 431.723868ms)","trace[1826195115] 'applied index is now lower than readState.Index' (duration: 99.081µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:08.275813Z","caller":"traceutil/trace.go:171","msg":"trace[841160909] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"748.836124ms","start":"2026-04-16T06:06:07.526939Z","end":"2026-04-16T06:06:08.275775Z","steps":["trace[841160909] 'process raft request' (duration: 748.636651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.275899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.020982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T06:06:08.275958Z","caller":"traceutil/trace.go:171","msg":"trace[223503278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"432.091543ms","start":"2026-04-16T06:06:07.84384Z","end":"2026-04-16T06:06:08.275932Z","steps":["trace[223503278] 'agreement among raft nodes before linearized reading' (duration: 431.951391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.275985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.843827Z","time spent":"432.151554ms","remote":"127.0.0.1:44522","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-16T06:06:08.275994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.526916Z","time spent":"748.990797ms","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:08.278532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.959932ms","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-16T06:06:08.278622Z","caller":"traceutil/trace.go:171","msg":"trace[984136650] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:788; }","duration":"381.103135ms","start":"2026-04-16T06:06:07.897496Z","end":"2026-04-16T06:06:08.278599Z","steps":["trace[984136650] 'agreement among raft nodes before linearized reading' (duration: 380.823921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.278676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.897475Z","time spent":"381.188116ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:06:08.27905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.111754ms","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-16T06:06:08.279108Z","caller":"traceutil/trace.go:171","msg":"trace[1377230579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:788; }","duration":"379.198225ms","start":"2026-04-16T06:06:07.899896Z","end":"2026-04-16T06:06:08.279094Z","steps":["trace[1377230579] 'agreement among raft nodes before linearized reading' (duration: 379.054302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.279146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.899884Z","time spent":"379.253256ms","remote":"127.0.0.1:44522","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":"warn","ts":"2026-04-16T06:06:08.279349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.884085ms","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-16T06:06:08.279541Z","caller":"traceutil/trace.go:171","msg":"trace[201402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:788; }","duration":"366.096537ms","start":"2026-04-16T06:06:07.913434Z","end":"2026-04-16T06:06:08.279531Z","steps":["trace[201402] 'agreement among raft nodes before linearized reading' (duration: 365.789553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:08.280158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.913424Z","time spent":"366.717447ms","remote":"127.0.0.1:44522","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":"info","ts":"2026-04-16T06:06:20.647787Z","caller":"traceutil/trace.go:171","msg":"trace[1308727843] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"163.838252ms","start":"2026-04-16T06:06:20.483932Z","end":"2026-04-16T06:06:20.64777Z","steps":["trace[1308727843] 'process raft request' (duration: 163.73897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:20.848059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.675557ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T06:06:22.192361Z","caller":"traceutil/trace.go:171","msg":"trace[667707338] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"142.324531ms","start":"2026-04-16T06:06:22.050009Z","end":"2026-04-16T06:06:22.192334Z","steps":["trace[667707338] 'process raft request' (duration: 103.837582ms)","trace[667707338] 'compare' (duration: 38.314877ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:22.201932Z","caller":"traceutil/trace.go:171","msg":"trace[650887050] transaction","detail":"{read_only:false; response_revision:946; number_of_response:1; }","duration":"148.708478ms","start":"2026-04-16T06:06:22.053203Z","end":"2026-04-16T06:06:22.201911Z","steps":["trace[650887050] 'process raft request' (duration: 148.548116ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:22.202094Z","caller":"traceutil/trace.go:171","msg":"trace[16228145] transaction","detail":"{read_only:false; response_revision:947; number_of_response:1; }","duration":"147.911506ms","start":"2026-04-16T06:06:22.054169Z","end":"2026-04-16T06:06:22.20208Z","steps":["trace[16228145] 'process raft request' (duration: 147.688173ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:24.899473Z","caller":"traceutil/trace.go:171","msg":"trace[771704037] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"149.198312ms","start":"2026-04-16T06:06:24.750253Z","end":"2026-04-16T06:06:24.899451Z","steps":["trace[771704037] 'process raft request' (duration: 149.026629ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:50.74578Z","caller":"traceutil/trace.go:171","msg":"trace[448289496] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"100.058009ms","start":"2026-04-16T06:06:50.645669Z","end":"2026-04-16T06:06:50.745727Z","steps":["trace[448289496] 'process raft request' (duration: 92.94054ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:52.958008Z","caller":"traceutil/trace.go:171","msg":"trace[1079747389] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"204.989654ms","start":"2026-04-16T06:06:52.752993Z","end":"2026-04-16T06:06:52.957983Z","steps":["trace[1079747389] 'process raft request' (duration: 204.822662ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:52.959131Z","caller":"traceutil/trace.go:171","msg":"trace[1841768272] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1099; }","duration":"143.200533ms","start":"2026-04-16T06:06:52.815912Z","end":"2026-04-16T06:06:52.959112Z","steps":["trace[1841768272] 'read index received' (duration: 141.864475ms)","trace[1841768272] 'applied index is now lower than readState.Index' (duration: 1.334678ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:52.959254Z","caller":"traceutil/trace.go:171","msg":"trace[1530598472] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"206.14682ms","start":"2026-04-16T06:06:52.753071Z","end":"2026-04-16T06:06:52.959218Z","steps":["trace[1530598472] 'process raft request' (duration: 205.954307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:52.959393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.462307ms","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-16T06:06:52.959448Z","caller":"traceutil/trace.go:171","msg":"trace[1491536102] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1067; }","duration":"143.564459ms","start":"2026-04-16T06:06:52.815867Z","end":"2026-04-16T06:06:52.959432Z","steps":["trace[1491536102] 'agreement among raft nodes before linearized reading' (duration: 143.315756ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:07.183071Z","caller":"traceutil/trace.go:171","msg":"trace[1946210073] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"157.498661ms","start":"2026-04-16T06:07:07.025539Z","end":"2026-04-16T06:07:07.183038Z","steps":["trace[1946210073] 'process raft request' (duration: 157.294178ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:07.23055Z","caller":"traceutil/trace.go:171","msg":"trace[1722713793] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"202.322547ms","start":"2026-04-16T06:07:07.028203Z","end":"2026-04-16T06:07:07.230525Z","steps":["trace[1722713793] 'process raft request' (duration: 202.156504ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:07.230712Z","caller":"traceutil/trace.go:171","msg":"trace[1129053414] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1148; }","duration":"199.234806ms","start":"2026-04-16T06:07:07.031449Z","end":"2026-04-16T06:07:07.230684Z","steps":["trace[1129053414] 'read index received' (duration: 151.407449ms)","trace[1129053414] 'applied index is now lower than readState.Index' (duration: 47.825267ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:07.230758Z","caller":"traceutil/trace.go:171","msg":"trace[1421565947] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"181.697479ms","start":"2026-04-16T06:07:07.049023Z","end":"2026-04-16T06:07:07.230721Z","steps":["trace[1421565947] 'process raft request' (duration: 181.458636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:07.230918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.447479ms","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-16T06:07:07.230949Z","caller":"traceutil/trace.go:171","msg":"trace[935101306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1114; }","duration":"199.52852ms","start":"2026-04-16T06:07:07.031412Z","end":"2026-04-16T06:07:07.230941Z","steps":["trace[935101306] 'agreement among raft nodes before linearized reading' (duration: 199.366178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:05.888508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.269021ms","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-16T06:08:05.888586Z","caller":"traceutil/trace.go:171","msg":"trace[2118253392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1340; }","duration":"419.396346ms","start":"2026-04-16T06:08:05.469175Z","end":"2026-04-16T06:08:05.888571Z","steps":["trace[2118253392] 'range keys from in-memory index tree' (duration: 419.082483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:05.888616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:05.469142Z","time spent":"419.46641ms","remote":"127.0.0.1:44522","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-16T06:08:05.889063Z","caller":"traceutil/trace.go:171","msg":"trace[1053230413] linearizableReadLoop","detail":"{readStateIndex:1391; appliedIndex:1390; }","duration":"378.959334ms","start":"2026-04-16T06:08:05.510083Z","end":"2026-04-16T06:08:05.889042Z","steps":["trace[1053230413] 'read index received' (duration: 372.448462ms)","trace[1053230413] 'applied index is now lower than readState.Index' (duration: 6.509782ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:05.889111Z","caller":"traceutil/trace.go:171","msg":"trace[483566060] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"379.723674ms","start":"2026-04-16T06:08:05.509377Z","end":"2026-04-16T06:08:05.8891Z","steps":["trace[483566060] 'process raft request' (duration: 373.270375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:05.889223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:05.50935Z","time spent":"379.810397ms","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:08:05.889403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.060836ms","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-16T06:08:05.889434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.635549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T06:08:05.889495Z","caller":"traceutil/trace.go:171","msg":"trace[1216449118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1341; }","duration":"283.182181ms","start":"2026-04-16T06:08:05.606294Z","end":"2026-04-16T06:08:05.889476Z","steps":["trace[1216449118] 'agreement among raft nodes before linearized reading' (duration: 282.980533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:05.889445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.335669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.209\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T06:08:05.889478Z","caller":"traceutil/trace.go:171","msg":"trace[275449298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1341; }","duration":"283.716173ms","start":"2026-04-16T06:08:05.605751Z","end":"2026-04-16T06:08:05.889467Z","steps":["trace[275449298] 'agreement among raft nodes before linearized reading' (duration: 283.511574ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:05.889628Z","caller":"traceutil/trace.go:171","msg":"trace[2101972777] range","detail":"{range_begin:/registry/masterleases/199.204.45.209; range_end:; response_count:1; response_revision:1341; }","duration":"379.567248ms","start":"2026-04-16T06:08:05.510039Z","end":"2026-04-16T06:08:05.889606Z","steps":["trace[2101972777] 'agreement among raft nodes before linearized reading' (duration: 379.174202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:05.889743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:08:05.510022Z","time spent":"379.706374ms","remote":"127.0.0.1:44250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.209\" "} {"level":"info","ts":"2026-04-16T06:08:20.18101Z","caller":"traceutil/trace.go:171","msg":"trace[809200567] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"184.560896ms","start":"2026-04-16T06:08:19.996423Z","end":"2026-04-16T06:08:20.180984Z","steps":["trace[809200567] 'process raft request' (duration: 158.42235ms)","trace[809200567] 'compare' (duration: 25.936648ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:20.181166Z","caller":"traceutil/trace.go:171","msg":"trace[1624381830] linearizableReadLoop","detail":"{readStateIndex:1449; appliedIndex:1446; }","duration":"171.838719ms","start":"2026-04-16T06:08:20.009298Z","end":"2026-04-16T06:08:20.181137Z","steps":["trace[1624381830] 'read index received' (duration: 67.954319ms)","trace[1624381830] 'applied index is now lower than readState.Index' (duration: 103.88248ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:20.181272Z","caller":"traceutil/trace.go:171","msg":"trace[361603907] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"183.758576ms","start":"2026-04-16T06:08:19.997472Z","end":"2026-04-16T06:08:20.18123Z","steps":["trace[361603907] 'process raft request' (duration: 183.469575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:08:20.181302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.982505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:public-info-viewer\" ","response":"range_response_count:1 size:613"} {"level":"warn","ts":"2026-04-16T06:08:20.181363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.287691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:job-controller\" ","response":"range_response_count:1 size:731"} {"level":"info","ts":"2026-04-16T06:08:20.181389Z","caller":"traceutil/trace.go:171","msg":"trace[1027654208] range","detail":"{range_begin:/registry/clusterroles/system:public-info-viewer; range_end:; response_count:1; response_revision:1395; }","duration":"172.092379ms","start":"2026-04-16T06:08:20.009275Z","end":"2026-04-16T06:08:20.181367Z","steps":["trace[1027654208] 'agreement among raft nodes before linearized reading' (duration: 171.947834ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:08:20.1814Z","caller":"traceutil/trace.go:171","msg":"trace[1058834173] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:job-controller; range_end:; response_count:1; response_revision:1395; }","duration":"159.361704ms","start":"2026-04-16T06:08:20.022028Z","end":"2026-04-16T06:08:20.181389Z","steps":["trace[1058834173] 'agreement among raft nodes before linearized reading' (duration: 159.25818ms)"],"step_count":1}