{"level":"warn","ts":"2026-04-22T16:30:20.278739Z","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-22T16:30:20.278866Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.20: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.19.213.20:2380","--initial-cluster=instance=https://199.19.213.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.20: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-22T16:30:20.278978Z","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-22T16:30:20.279061Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-04-22T16:30:20.279091Z","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-22T16:30:20.279966Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"]} {"level":"info","ts":"2026-04-22T16:30:20.280152Z","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.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.20: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-22T16:30:20.285828Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.391982ms"} {"level":"info","ts":"2026-04-22T16:30:20.292324Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"185293d8d40ffce0","cluster-id":"cc857afa6e1fa648"} {"level":"info","ts":"2026-04-22T16:30:20.292404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T16:30:20.292425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 0"} {"level":"info","ts":"2026-04-22T16:30:20.292443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 185293d8d40ffce0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T16:30:20.292457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 1"} {"level":"info","ts":"2026-04-22T16:30:20.292499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"warn","ts":"2026-04-22T16:30:20.305478Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T16:30:20.307019Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T16:30:20.30788Z","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-22T16:30:20.310928Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"185293d8d40ffce0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T16:30:20.32613Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"185293d8d40ffce0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T16:30:20.326286Z","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-22T16:30:20.326355Z","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-22T16:30:20.326367Z","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-22T16:30:20.327798Z","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-22T16:30:20.327971Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-04-22T16:30:20.328013Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-04-22T16:30:20.328308Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"185293d8d40ffce0","initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T16:30:20.328357Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T16:30:20.328773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"info","ts":"2026-04-22T16:30:20.329016Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","added-peer-id":"185293d8d40ffce0","added-peer-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-04-22T16:30:20.99341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T16:30:20.993454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T16:30:20.993492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgPreVoteResp from 185293d8d40ffce0 at term 1"} {"level":"info","ts":"2026-04-22T16:30:20.993506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became candidate at term 2"} {"level":"info","ts":"2026-04-22T16:30:20.993514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgVoteResp from 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-04-22T16:30:20.993524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became leader at term 2"} {"level":"info","ts":"2026-04-22T16:30:20.993547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 185293d8d40ffce0 elected leader 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-04-22T16:30:20.995103Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"185293d8d40ffce0","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.20:2379]}","request-path":"/0/members/185293d8d40ffce0/attributes","cluster-id":"cc857afa6e1fa648","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T16:30:20.995937Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T16:30:20.996128Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T16:30:20.996217Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T16:30:20.99885Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.20:2379"} {"level":"info","ts":"2026-04-22T16:30:20.998939Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T16:30:20.998973Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T16:30:21.00067Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T16:30:21.000754Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T16:30:21.000794Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T16:30:21.001379Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T16:30:25.252988Z","caller":"traceutil/trace.go:171","msg":"trace[1612425994] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"308.792344ms","start":"2026-04-22T16:30:24.944169Z","end":"2026-04-22T16:30:25.252962Z","steps":["trace[1612425994] 'process raft request' (duration: 308.747063ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:30:25.253025Z","caller":"traceutil/trace.go:171","msg":"trace[910622052] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"331.994254ms","start":"2026-04-22T16:30:24.921007Z","end":"2026-04-22T16:30:25.253001Z","steps":["trace[910622052] 'process raft request' (duration: 331.764478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:25.254099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:24.944143Z","time spent":"309.0148ms","remote":"127.0.0.1:51984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T16:30:25.254285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:24.920986Z","time spent":"332.289221ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:30:27.118731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.43586116s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T16:30:27.118904Z","caller":"traceutil/trace.go:171","msg":"trace[1767034311] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"1.845945038s","start":"2026-04-22T16:30:25.272922Z","end":"2026-04-22T16:30:27.118867Z","steps":["trace[1767034311] 'process raft request' (duration: 409.726958ms)","trace[1767034311] 'compare' (duration: 1.435680216s)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:30:27.118993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:25.272903Z","time spent":"1.84603982s","remote":"127.0.0.1:51982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3694,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:30:27.205377Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.174773431s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T16:30:27.20582Z","caller":"traceutil/trace.go:171","msg":"trace[188412807] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"1.175298215s","start":"2026-04-22T16:30:26.030492Z","end":"2026-04-22T16:30:27.205791Z","steps":["trace[188412807] 'process raft request' (duration: 1.17510842s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:27.206045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:26.030468Z","time spent":"1.175425678s","remote":"127.0.0.1:51984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T16:30:28.356389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.0379ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-22T16:30:28.356476Z","caller":"traceutil/trace.go:171","msg":"trace[473131043] linearizableReadLoop","detail":"{readStateIndex:218; appliedIndex:216; }","duration":"1.364267761s","start":"2026-04-22T16:30:26.992193Z","end":"2026-04-22T16:30:28.356461Z","steps":["trace[473131043] 'read index received' (duration: 213.385338ms)","trace[473131043] 'applied index is now lower than readState.Index' (duration: 1.150881083s)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:30:28.356548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:26.682569Z","time spent":"1.673976098s","remote":"127.0.0.1:51896","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-22T16:30:28.356796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.347128809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:30:28.356874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099266957s","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-22T16:30:28.35699Z","caller":"traceutil/trace.go:171","msg":"trace[1153683583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:212; }","duration":"1.099460491s","start":"2026-04-22T16:30:27.257503Z","end":"2026-04-22T16:30:28.356963Z","steps":["trace[1153683583] 'agreement among raft nodes before linearized reading' (duration: 1.099225275s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:28.357048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:27.257489Z","time spent":"1.099545204s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-22T16:30:28.357003Z","caller":"traceutil/trace.go:171","msg":"trace[255758910] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:212; }","duration":"1.347319974s","start":"2026-04-22T16:30:27.009604Z","end":"2026-04-22T16:30:28.356924Z","steps":["trace[255758910] 'agreement among raft nodes before linearized reading' (duration: 1.347107559s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:28.357212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:27.009587Z","time spent":"1.347606752s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T16:30:28.357057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.234418367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-sr8mrp\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:30:28.356836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.36463345s","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-22T16:30:28.357431Z","caller":"traceutil/trace.go:171","msg":"trace[584335258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:212; }","duration":"1.365264797s","start":"2026-04-22T16:30:26.992154Z","end":"2026-04-22T16:30:28.357418Z","steps":["trace[584335258] 'agreement among raft nodes before linearized reading' (duration: 1.36462794s)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:30:28.357476Z","caller":"traceutil/trace.go:171","msg":"trace[1925589777] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-sr8mrp; range_end:; response_count:0; response_revision:212; }","duration":"1.234837219s","start":"2026-04-22T16:30:27.122522Z","end":"2026-04-22T16:30:28.357359Z","steps":["trace[1925589777] 'agreement among raft nodes before linearized reading' (duration: 1.234325055s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:28.357569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:26.992135Z","time spent":"1.365330908s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T16:30:28.357697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:27.122506Z","time spent":"1.235102316s","remote":"127.0.0.1:51906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-sr8mrp\" "} {"level":"warn","ts":"2026-04-22T16:30:28.356839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.142619296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:30:28.357806Z","caller":"traceutil/trace.go:171","msg":"trace[1958654803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:212; }","duration":"1.143595732s","start":"2026-04-22T16:30:27.214199Z","end":"2026-04-22T16:30:28.357794Z","steps":["trace[1958654803] 'agreement among raft nodes before linearized reading' (duration: 1.142564954s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:30:28.357844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:30:27.214149Z","time spent":"1.143684644s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-22T16:31:12.879138Z","caller":"traceutil/trace.go:171","msg":"trace[644634915] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:522; }","duration":"253.496375ms","start":"2026-04-22T16:31:12.625614Z","end":"2026-04-22T16:31:12.87911Z","steps":["trace[644634915] 'read index received' (duration: 39.220035ms)","trace[644634915] 'applied index is now lower than readState.Index' (duration: 214.27512ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:12.879261Z","caller":"traceutil/trace.go:171","msg":"trace[898426293] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"256.892126ms","start":"2026-04-22T16:31:12.622331Z","end":"2026-04-22T16:31:12.879223Z","steps":["trace[898426293] 'process raft request' (duration: 208.852716ms)","trace[898426293] 'compare' (duration: 47.797074ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:12.879381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.295641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:31:12.879375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.69832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-22T16:31:12.880076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.176906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T16:31:12.880943Z","caller":"traceutil/trace.go:171","msg":"trace[1969401326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:505; }","duration":"208.395803ms","start":"2026-04-22T16:31:12.671024Z","end":"2026-04-22T16:31:12.87942Z","steps":["trace[1969401326] 'agreement among raft nodes before linearized reading' (duration: 208.311091ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:12.881109Z","caller":"traceutil/trace.go:171","msg":"trace[6253835] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:505; }","duration":"254.831141ms","start":"2026-04-22T16:31:12.62615Z","end":"2026-04-22T16:31:12.880981Z","steps":["trace[6253835] 'agreement among raft nodes before linearized reading' (duration: 253.141536ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:12.879452Z","caller":"traceutil/trace.go:171","msg":"trace[1526090867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:505; }","duration":"253.857595ms","start":"2026-04-22T16:31:12.625584Z","end":"2026-04-22T16:31:12.879442Z","steps":["trace[1526090867] 'agreement among raft nodes before linearized reading' (duration: 253.68176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:20.608519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.834049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T16:31:20.60863Z","caller":"traceutil/trace.go:171","msg":"trace[211847641] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"206.831253ms","start":"2026-04-22T16:31:20.401779Z","end":"2026-04-22T16:31:20.608611Z","steps":["trace[211847641] 'process raft request' (duration: 49.830478ms)","trace[211847641] 'compare' (duration: 156.730217ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:20.865999Z","caller":"traceutil/trace.go:171","msg":"trace[1192744151] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"157.300852ms","start":"2026-04-22T16:31:20.708654Z","end":"2026-04-22T16:31:20.865955Z","steps":["trace[1192744151] 'process raft request' (duration: 89.262489ms)","trace[1192744151] 'compare' (duration: 67.832768ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:21.071297Z","caller":"traceutil/trace.go:171","msg":"trace[241033328] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:545; }","duration":"135.291165ms","start":"2026-04-22T16:31:20.935974Z","end":"2026-04-22T16:31:21.071266Z","steps":["trace[241033328] 'read index received' (duration: 4.9014ms)","trace[241033328] 'applied index is now lower than readState.Index' (duration: 130.388435ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:21.071546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.550162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T16:31:21.07161Z","caller":"traceutil/trace.go:171","msg":"trace[59073214] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:526; }","duration":"135.654145ms","start":"2026-04-22T16:31:20.935934Z","end":"2026-04-22T16:31:21.071588Z","steps":["trace[59073214] 'agreement among raft nodes before linearized reading' (duration: 135.529812ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:21.071997Z","caller":"traceutil/trace.go:171","msg":"trace[1410712944] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"143.246028ms","start":"2026-04-22T16:31:20.928201Z","end":"2026-04-22T16:31:21.071447Z","steps":["trace[1410712944] 'process raft request' (duration: 78.267626ms)","trace[1410712944] 'compare' (duration: 64.650802ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:22.087151Z","caller":"traceutil/trace.go:171","msg":"trace[923086058] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"136.710403ms","start":"2026-04-22T16:31:21.950408Z","end":"2026-04-22T16:31:22.087119Z","steps":["trace[923086058] 'process raft request' (duration: 136.465127ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:36.211134Z","caller":"traceutil/trace.go:171","msg":"trace[844223784] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"863.348817ms","start":"2026-04-22T16:31:35.347767Z","end":"2026-04-22T16:31:36.211116Z","steps":["trace[844223784] 'process raft request' (duration: 863.132812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:36.211256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.347744Z","time spent":"863.45188ms","remote":"127.0.0.1:51874","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-22T16:31:36.219336Z","caller":"traceutil/trace.go:171","msg":"trace[471502322] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"869.457831ms","start":"2026-04-22T16:31:35.349842Z","end":"2026-04-22T16:31:36.2193Z","steps":["trace[471502322] 'process raft request' (duration: 869.115501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:36.219498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.349817Z","time spent":"869.595944ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:31:36.219861Z","caller":"traceutil/trace.go:171","msg":"trace[637720049] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"867.875858ms","start":"2026-04-22T16:31:35.351976Z","end":"2026-04-22T16:31:36.219852Z","steps":["trace[637720049] 'process raft request' (duration: 867.172059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:36.219926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.351958Z","time spent":"867.94744ms","remote":"127.0.0.1:52360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T16:31:36.220249Z","caller":"traceutil/trace.go:171","msg":"trace[567089363] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"734.810762ms","start":"2026-04-22T16:31:35.485421Z","end":"2026-04-22T16:31:36.220232Z","steps":["trace[567089363] 'process raft request' (duration: 734.72179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:36.220349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.485393Z","time spent":"734.911755ms","remote":"127.0.0.1:51874","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-22T16:31:36.220483Z","caller":"traceutil/trace.go:171","msg":"trace[21304927] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"865.187107ms","start":"2026-04-22T16:31:35.35529Z","end":"2026-04-22T16:31:36.220477Z","steps":["trace[21304927] 'process raft request' (duration: 864.101719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:36.220516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.355274Z","time spent":"865.226358ms","remote":"127.0.0.1:52360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T16:31:36.220596Z","caller":"traceutil/trace.go:171","msg":"trace[862259036] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"858.267772ms","start":"2026-04-22T16:31:35.362319Z","end":"2026-04-22T16:31:36.220587Z","steps":["trace[862259036] 'process raft request' (duration: 857.308817ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:36.22064Z","caller":"traceutil/trace.go:171","msg":"trace[1438885833] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"854.393039ms","start":"2026-04-22T16:31:35.366239Z","end":"2026-04-22T16:31:36.220632Z","steps":["trace[1438885833] 'process raft request' (duration: 853.722001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:36.220654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.362314Z","time spent":"858.312243ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:31:36.223369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.366231Z","time spent":"854.43232ms","remote":"127.0.0.1:51874","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-22T16:31:36.223575Z","caller":"traceutil/trace.go:171","msg":"trace[739148512] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"861.53177ms","start":"2026-04-22T16:31:35.362024Z","end":"2026-04-22T16:31:36.223556Z","steps":["trace[739148512] 'process raft request' (duration: 857.42401ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:36.223547Z","caller":"traceutil/trace.go:171","msg":"trace[1149237419] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"849.51703ms","start":"2026-04-22T16:31:35.373961Z","end":"2026-04-22T16:31:36.223478Z","steps":["trace[1149237419] 'process raft request' (duration: 846.076688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:36.223627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.362005Z","time spent":"861.595181ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:31:36.223731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.373951Z","time spent":"849.700724ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T16:31:36.223494Z","caller":"traceutil/trace.go:171","msg":"trace[1865882190] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"861.389916ms","start":"2026-04-22T16:31:35.362083Z","end":"2026-04-22T16:31:36.223472Z","steps":["trace[1865882190] 'process raft request' (duration: 857.477191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:36.223841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:35.362079Z","time spent":"861.739144ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:31:37.132629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.919702ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T16:31:37.132725Z","caller":"traceutil/trace.go:171","msg":"trace[1733796754] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:717; }","duration":"128.110753ms","start":"2026-04-22T16:31:37.004603Z","end":"2026-04-22T16:31:37.132713Z","steps":["trace[1733796754] 'read index received' (duration: 27.98µs)","trace[1733796754] 'applied index is now lower than readState.Index' (duration: 128.081933ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:37.132921Z","caller":"traceutil/trace.go:171","msg":"trace[722288545] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"187.920858ms","start":"2026-04-22T16:31:36.94499Z","end":"2026-04-22T16:31:37.132911Z","steps":["trace[722288545] 'process raft request' (duration: 36.644556ms)","trace[722288545] 'compare' (duration: 150.792119ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:37.133142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.515276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T16:31:37.133251Z","caller":"traceutil/trace.go:171","msg":"trace[1774325379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:691; }","duration":"128.657539ms","start":"2026-04-22T16:31:37.004574Z","end":"2026-04-22T16:31:37.133231Z","steps":["trace[1774325379] 'agreement among raft nodes before linearized reading' (duration: 128.413562ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:37.171975Z","caller":"traceutil/trace.go:171","msg":"trace[1328712093] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"146.816421ms","start":"2026-04-22T16:31:37.02514Z","end":"2026-04-22T16:31:37.171956Z","steps":["trace[1328712093] 'process raft request' (duration: 146.706158ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:37.462531Z","caller":"traceutil/trace.go:171","msg":"trace[828720678] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"341.603944ms","start":"2026-04-22T16:31:37.120898Z","end":"2026-04-22T16:31:37.462502Z","steps":["trace[828720678] 'process raft request' (duration: 277.453115ms)","trace[828720678] 'compare' (duration: 63.249735ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:37.462691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:37.120867Z","time spent":"341.745937ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:31:37.46269Z","caller":"traceutil/trace.go:171","msg":"trace[347930184] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:718; }","duration":"329.898602ms","start":"2026-04-22T16:31:37.132756Z","end":"2026-04-22T16:31:37.462655Z","steps":["trace[347930184] 'read index received' (duration: 39.163413ms)","trace[347930184] 'applied index is now lower than readState.Index' (duration: 290.733479ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:37.462789Z","caller":"traceutil/trace.go:171","msg":"trace[638107957] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"325.549885ms","start":"2026-04-22T16:31:37.137212Z","end":"2026-04-22T16:31:37.462761Z","steps":["trace[638107957] 'process raft request' (duration: 325.233477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:37.462933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:37.137201Z","time spent":"325.652038ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:31:37.462934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.157725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T16:31:37.462997Z","caller":"traceutil/trace.go:171","msg":"trace[1245422187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:694; }","duration":"331.265198ms","start":"2026-04-22T16:31:37.131716Z","end":"2026-04-22T16:31:37.462981Z","steps":["trace[1245422187] 'agreement among raft nodes before linearized reading' (duration: 331.072533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:37.46304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:37.131707Z","time spent":"331.324319ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T16:31:37.500335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.215978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-22T16:31:37.500414Z","caller":"traceutil/trace.go:171","msg":"trace[2036197608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:695; }","duration":"271.337271ms","start":"2026-04-22T16:31:37.229058Z","end":"2026-04-22T16:31:37.500396Z","steps":["trace[2036197608] 'agreement among raft nodes before linearized reading' (duration: 271.163896ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:37.50079Z","caller":"traceutil/trace.go:171","msg":"trace[862100078] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"165.791769ms","start":"2026-04-22T16:31:37.33499Z","end":"2026-04-22T16:31:37.500782Z","steps":["trace[862100078] 'process raft request' (duration: 165.09631ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:37.692619Z","caller":"traceutil/trace.go:171","msg":"trace[230388860] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:723; }","duration":"156.889971ms","start":"2026-04-22T16:31:37.535709Z","end":"2026-04-22T16:31:37.692599Z","steps":["trace[230388860] 'read index received' (duration: 70.1848ms)","trace[230388860] 'applied index is now lower than readState.Index' (duration: 86.704231ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:37.69269Z","caller":"traceutil/trace.go:171","msg":"trace[1237847200] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"163.685162ms","start":"2026-04-22T16:31:37.528966Z","end":"2026-04-22T16:31:37.692651Z","steps":["trace[1237847200] 'process raft request' (duration: 163.556319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:37.6928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.072806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-22T16:31:37.692857Z","caller":"traceutil/trace.go:171","msg":"trace[1165527497] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:698; }","duration":"157.160318ms","start":"2026-04-22T16:31:37.535669Z","end":"2026-04-22T16:31:37.69283Z","steps":["trace[1165527497] 'agreement among raft nodes before linearized reading' (duration: 157.016184ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:37.693026Z","caller":"traceutil/trace.go:171","msg":"trace[1498728442] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"183.521031ms","start":"2026-04-22T16:31:37.509489Z","end":"2026-04-22T16:31:37.69301Z","steps":["trace[1498728442] 'process raft request' (duration: 96.394269ms)","trace[1498728442] 'compare' (duration: 86.412023ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:38.006782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.347094ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T16:31:38.006924Z","caller":"traceutil/trace.go:171","msg":"trace[143379200] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:725; }","duration":"300.294323ms","start":"2026-04-22T16:31:37.706596Z","end":"2026-04-22T16:31:38.00689Z","steps":["trace[143379200] 'read index received' (duration: 181.672191ms)","trace[143379200] 'applied index is now lower than readState.Index' (duration: 118.620872ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:38.006957Z","caller":"traceutil/trace.go:171","msg":"trace[1197841330] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"307.101795ms","start":"2026-04-22T16:31:37.699817Z","end":"2026-04-22T16:31:38.006919Z","steps":["trace[1197841330] 'process raft request' (duration: 188.521435ms)","trace[1197841330] 'compare' (duration: 117.772498ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:38.007133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.487378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10870"} {"level":"warn","ts":"2026-04-22T16:31:38.007166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:37.699789Z","time spent":"307.238857ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:31:38.007185Z","caller":"traceutil/trace.go:171","msg":"trace[875077411] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:699; }","duration":"300.59552ms","start":"2026-04-22T16:31:37.706575Z","end":"2026-04-22T16:31:38.007171Z","steps":["trace[875077411] 'agreement among raft nodes before linearized reading' (duration: 300.389375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:38.007245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:37.706562Z","time spent":"300.670312ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":10893,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-22T16:31:38.211944Z","caller":"traceutil/trace.go:171","msg":"trace[80216221] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"147.796949ms","start":"2026-04-22T16:31:38.064124Z","end":"2026-04-22T16:31:38.211921Z","steps":["trace[80216221] 'process raft request' (duration: 147.743127ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:38.212121Z","caller":"traceutil/trace.go:171","msg":"trace[1305593097] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"479.815537ms","start":"2026-04-22T16:31:37.732153Z","end":"2026-04-22T16:31:38.211969Z","steps":["trace[1305593097] 'process raft request' (duration: 397.655367ms)","trace[1305593097] 'compare' (duration: 81.871472ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:38.212039Z","caller":"traceutil/trace.go:171","msg":"trace[127583811] linearizableReadLoop","detail":"{readStateIndex:727; appliedIndex:726; }","duration":"182.137013ms","start":"2026-04-22T16:31:38.029878Z","end":"2026-04-22T16:31:38.212015Z","steps":["trace[127583811] 'read index received' (duration: 99.893851ms)","trace[127583811] 'applied index is now lower than readState.Index' (duration: 82.238982ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:38.212287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:37.732125Z","time spent":"480.084844ms","remote":"127.0.0.1:51874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:31:38.212366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.466882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-04-22T16:31:38.213783Z","caller":"traceutil/trace.go:171","msg":"trace[1077896717] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:701; }","duration":"183.91776ms","start":"2026-04-22T16:31:38.029843Z","end":"2026-04-22T16:31:38.213761Z","steps":["trace[1077896717] 'agreement among raft nodes before linearized reading' (duration: 182.330398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:42.669955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.564795ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T16:31:42.670194Z","caller":"traceutil/trace.go:171","msg":"trace[1962704803] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"185.773382ms","start":"2026-04-22T16:31:42.484396Z","end":"2026-04-22T16:31:42.67017Z","steps":["trace[1962704803] 'process raft request' (duration: 17.875207ms)","trace[1962704803] 'compare' (duration: 167.3394ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:43.659836Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18221737497471912753,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T16:31:43.733521Z","caller":"traceutil/trace.go:171","msg":"trace[434586223] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:757; }","duration":"573.954406ms","start":"2026-04-22T16:31:43.159532Z","end":"2026-04-22T16:31:43.733487Z","steps":["trace[434586223] 'read index received' (duration: 572.149968ms)","trace[434586223] 'applied index is now lower than readState.Index' (duration: 1.802898ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:31:43.733628Z","caller":"traceutil/trace.go:171","msg":"trace[849624492] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"653.220078ms","start":"2026-04-22T16:31:43.080378Z","end":"2026-04-22T16:31:43.733598Z","steps":["trace[849624492] 'process raft request' (duration: 651.463741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:43.73382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:43.080347Z","time spent":"653.34448ms","remote":"127.0.0.1:51906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:31:43.7338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.246043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-22T16:31:43.734095Z","caller":"traceutil/trace.go:171","msg":"trace[186793213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:730; }","duration":"574.403637ms","start":"2026-04-22T16:31:43.159472Z","end":"2026-04-22T16:31:43.733876Z","steps":["trace[186793213] 'agreement among raft nodes before linearized reading' (duration: 574.152911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:43.73416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:43.159447Z","time spent":"574.701856ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T16:31:43.734229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.997916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-22T16:31:43.734262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.366173ms","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-22T16:31:43.734293Z","caller":"traceutil/trace.go:171","msg":"trace[2087874191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:730; }","duration":"222.079708ms","start":"2026-04-22T16:31:43.512194Z","end":"2026-04-22T16:31:43.734274Z","steps":["trace[2087874191] 'agreement among raft nodes before linearized reading' (duration: 221.938394ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:43.734319Z","caller":"traceutil/trace.go:171","msg":"trace[823279477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:730; }","duration":"193.465387ms","start":"2026-04-22T16:31:43.540838Z","end":"2026-04-22T16:31:43.734303Z","steps":["trace[823279477] 'agreement among raft nodes before linearized reading' (duration: 193.012624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:43.73409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.455777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:31:43.734437Z","caller":"traceutil/trace.go:171","msg":"trace[1660177366] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:730; }","duration":"280.042853ms","start":"2026-04-22T16:31:43.454382Z","end":"2026-04-22T16:31:43.734425Z","steps":["trace[1660177366] 'agreement among raft nodes before linearized reading' (duration: 279.453657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:44.785752Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18221737497471912757,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T16:31:44.970768Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.179276916s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-22T16:31:45.006638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253052562s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T16:31:45.007042Z","caller":"traceutil/trace.go:171","msg":"trace[587646754] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"1.267596301s","start":"2026-04-22T16:31:43.739412Z","end":"2026-04-22T16:31:45.007009Z","steps":["trace[587646754] 'process raft request' (duration: 14.069846ms)","trace[587646754] 'compare' (duration: 1.251984204s)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:45.007288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:43.739387Z","time spent":"1.267724173s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:31:45.007477Z","caller":"traceutil/trace.go:171","msg":"trace[416599971] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"1.268036632s","start":"2026-04-22T16:31:43.73941Z","end":"2026-04-22T16:31:45.007447Z","steps":["trace[416599971] 'process raft request' (duration: 1.267498068s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:45.007636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:43.739381Z","time spent":"1.268178135s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:31:45.007783Z","caller":"traceutil/trace.go:171","msg":"trace[1699743726] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"1.257709427s","start":"2026-04-22T16:31:43.750062Z","end":"2026-04-22T16:31:45.007772Z","steps":["trace[1699743726] 'process raft request' (duration: 1.257510212s)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:45.007807Z","caller":"traceutil/trace.go:171","msg":"trace[412647706] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:758; }","duration":"723.13048ms","start":"2026-04-22T16:31:44.284658Z","end":"2026-04-22T16:31:45.007789Z","steps":["trace[412647706] 'read index received' (duration: 686.252967ms)","trace[412647706] 'applied index is now lower than readState.Index' (duration: 36.876783ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:31:45.00784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:43.750035Z","time spent":"1.257776769s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:31:45.007914Z","caller":"traceutil/trace.go:171","msg":"trace[950875528] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"1.2642399s","start":"2026-04-22T16:31:43.743659Z","end":"2026-04-22T16:31:45.007899Z","steps":["trace[950875528] 'process raft request' (duration: 1.263686635s)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:45.007974Z","caller":"traceutil/trace.go:171","msg":"trace[485713545] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"1.21656473s","start":"2026-04-22T16:31:43.791399Z","end":"2026-04-22T16:31:45.007964Z","steps":["trace[485713545] 'process raft request' (duration: 1.216296753s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:45.008005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:43.743629Z","time spent":"1.264334033s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:31:45.00802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.832986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.20\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-22T16:31:45.00803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:43.791376Z","time spent":"1.216628562s","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T16:31:45.008058Z","caller":"traceutil/trace.go:171","msg":"trace[352330073] range","detail":"{range_begin:/registry/masterleases/199.19.213.20; range_end:; response_count:1; response_revision:736; }","duration":"527.903198ms","start":"2026-04-22T16:31:44.48014Z","end":"2026-04-22T16:31:45.008043Z","steps":["trace[352330073] 'agreement among raft nodes before linearized reading' (duration: 527.846626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:45.00809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:44.480119Z","time spent":"527.965559ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.19.213.20\" "} {"level":"warn","ts":"2026-04-22T16:31:45.008219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.213122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:31:45.008249Z","caller":"traceutil/trace.go:171","msg":"trace[1590141397] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:736; }","duration":"374.290414ms","start":"2026-04-22T16:31:44.633952Z","end":"2026-04-22T16:31:45.008243Z","steps":["trace[1590141397] 'agreement among raft nodes before linearized reading' (duration: 374.242683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:45.008268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:44.633928Z","time spent":"374.336136ms","remote":"127.0.0.1:51842","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-22T16:31:45.008241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.563321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T16:31:45.008325Z","caller":"traceutil/trace.go:171","msg":"trace[1099537387] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:736; }","duration":"723.660684ms","start":"2026-04-22T16:31:44.284648Z","end":"2026-04-22T16:31:45.008309Z","steps":["trace[1099537387] 'agreement among raft nodes before linearized reading' (duration: 723.492849ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:31:45.008355Z","caller":"traceutil/trace.go:171","msg":"trace[1112139118] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"525.605596ms","start":"2026-04-22T16:31:44.482736Z","end":"2026-04-22T16:31:45.008342Z","steps":["trace[1112139118] 'process raft request' (duration: 525.01123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:31:45.008377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:44.284612Z","time spent":"723.754157ms","remote":"127.0.0.1:52080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:31:45.00841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:31:44.482704Z","time spent":"525.674968ms","remote":"127.0.0.1:52078","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-22T16:31:47.045613Z","caller":"traceutil/trace.go:171","msg":"trace[913075691] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"259.125504ms","start":"2026-04-22T16:31:46.786461Z","end":"2026-04-22T16:31:47.045586Z","steps":["trace[913075691] 'process raft request' (duration: 258.935188ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:02.772086Z","caller":"traceutil/trace.go:171","msg":"trace[240861403] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:931; }","duration":"141.838478ms","start":"2026-04-22T16:32:02.630233Z","end":"2026-04-22T16:32:02.772071Z","steps":["trace[240861403] 'read index received' (duration: 141.705035ms)","trace[240861403] 'applied index is now lower than readState.Index' (duration: 132.853µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:32:02.772244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.993922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:02.772318Z","caller":"traceutil/trace.go:171","msg":"trace[769200669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:899; }","duration":"142.103225ms","start":"2026-04-22T16:32:02.630201Z","end":"2026-04-22T16:32:02.772305Z","steps":["trace[769200669] 'agreement among raft nodes before linearized reading' (duration: 141.980142ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:02.772524Z","caller":"traceutil/trace.go:171","msg":"trace[990712983] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"312.650225ms","start":"2026-04-22T16:32:02.459862Z","end":"2026-04-22T16:32:02.772512Z","steps":["trace[990712983] 'process raft request' (duration: 312.119791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:02.772613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.459844Z","time spent":"312.715777ms","remote":"127.0.0.1:52078","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-22T16:32:03.322036Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18221737497471913099,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T16:32:03.381061Z","caller":"traceutil/trace.go:171","msg":"trace[1641173940] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:932; }","duration":"559.756099ms","start":"2026-04-22T16:32:02.821275Z","end":"2026-04-22T16:32:03.381031Z","steps":["trace[1641173940] 'read index received' (duration: 559.570333ms)","trace[1641173940] 'applied index is now lower than readState.Index' (duration: 184.416µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:32:03.381098Z","caller":"traceutil/trace.go:171","msg":"trace[1824755099] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"603.394538ms","start":"2026-04-22T16:32:02.777681Z","end":"2026-04-22T16:32:03.381075Z","steps":["trace[1824755099] 'process raft request' (duration: 603.172812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.381245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.777663Z","time spent":"603.50189ms","remote":"127.0.0.1:51984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:32:03.381298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.955054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.381361Z","caller":"traceutil/trace.go:171","msg":"trace[637092829] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:900; }","duration":"560.045066ms","start":"2026-04-22T16:32:02.8213Z","end":"2026-04-22T16:32:03.381345Z","steps":["trace[637092829] 'agreement among raft nodes before linearized reading' (duration: 559.913042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.381421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.821297Z","time spent":"560.107757ms","remote":"127.0.0.1:50482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:32:03.381425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.131148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.381563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.770558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.381743Z","caller":"traceutil/trace.go:171","msg":"trace[1051955208] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:900; }","duration":"275.073106ms","start":"2026-04-22T16:32:03.106649Z","end":"2026-04-22T16:32:03.381722Z","steps":["trace[1051955208] 'agreement among raft nodes before linearized reading' (duration: 274.668375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.381772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.334018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.381833Z","caller":"traceutil/trace.go:171","msg":"trace[1766848864] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:900; }","duration":"169.413911ms","start":"2026-04-22T16:32:03.212405Z","end":"2026-04-22T16:32:03.381819Z","steps":["trace[1766848864] 'agreement among raft nodes before linearized reading' (duration: 169.325568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.381852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.160859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.381914Z","caller":"traceutil/trace.go:171","msg":"trace[1226636623] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:900; }","duration":"275.250191ms","start":"2026-04-22T16:32:03.106649Z","end":"2026-04-22T16:32:03.381899Z","steps":["trace[1226636623] 'agreement among raft nodes before linearized reading' (duration: 275.141148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.381984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.003014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.382054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.892458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.382119Z","caller":"traceutil/trace.go:171","msg":"trace[1517699397] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:900; }","duration":"307.9556ms","start":"2026-04-22T16:32:03.074147Z","end":"2026-04-22T16:32:03.382102Z","steps":["trace[1517699397] 'agreement among raft nodes before linearized reading' (duration: 307.868418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.382122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.732688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.382174Z","caller":"traceutil/trace.go:171","msg":"trace[457939900] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:900; }","duration":"169.80426ms","start":"2026-04-22T16:32:03.21236Z","end":"2026-04-22T16:32:03.382164Z","steps":["trace[457939900] 'agreement among raft nodes before linearized reading' (duration: 169.736199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.382172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:03.074086Z","time spent":"308.070903ms","remote":"127.0.0.1:50554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T16:32:03.382323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.653828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-22T16:32:03.38238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.969096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.382418Z","caller":"traceutil/trace.go:171","msg":"trace[505956963] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:900; }","duration":"155.015408ms","start":"2026-04-22T16:32:03.227392Z","end":"2026-04-22T16:32:03.382407Z","steps":["trace[505956963] 'agreement among raft nodes before linearized reading' (duration: 154.972387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.382412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.250178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.382394Z","caller":"traceutil/trace.go:171","msg":"trace[146361616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:900; }","duration":"250.744401ms","start":"2026-04-22T16:32:03.131638Z","end":"2026-04-22T16:32:03.382383Z","steps":["trace[146361616] 'agreement among raft nodes before linearized reading' (duration: 250.593086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.38249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.659651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.382538Z","caller":"traceutil/trace.go:171","msg":"trace[1491016536] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:900; }","duration":"197.726432ms","start":"2026-04-22T16:32:03.184798Z","end":"2026-04-22T16:32:03.382525Z","steps":["trace[1491016536] 'agreement among raft nodes before linearized reading' (duration: 197.65338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.38263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.244094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.382669Z","caller":"traceutil/trace.go:171","msg":"trace[78623760] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:900; }","duration":"155.286035ms","start":"2026-04-22T16:32:03.227375Z","end":"2026-04-22T16:32:03.382661Z","steps":["trace[78623760] 'agreement among raft nodes before linearized reading' (duration: 155.230103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.382715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.195575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.381635Z","caller":"traceutil/trace.go:171","msg":"trace[2084124534] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:900; }","duration":"560.328665ms","start":"2026-04-22T16:32:02.821249Z","end":"2026-04-22T16:32:03.381578Z","steps":["trace[2084124534] 'agreement among raft nodes before linearized reading' (duration: 559.935374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.38276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.821234Z","time spent":"561.512265ms","remote":"127.0.0.1:50482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T16:32:03.382817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.079078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.382854Z","caller":"traceutil/trace.go:171","msg":"trace[1927155135] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:900; }","duration":"170.127749ms","start":"2026-04-22T16:32:03.212717Z","end":"2026-04-22T16:32:03.382845Z","steps":["trace[1927155135] 'agreement among raft nodes before linearized reading' (duration: 170.077338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.382339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.805219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.382992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.921855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-22T16:32:03.38302Z","caller":"traceutil/trace.go:171","msg":"trace[2016946995] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:900; }","duration":"253.961605ms","start":"2026-04-22T16:32:03.129051Z","end":"2026-04-22T16:32:03.383013Z","steps":["trace[2016946995] 'agreement among raft nodes before linearized reading' (duration: 253.906854ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:03.383056Z","caller":"traceutil/trace.go:171","msg":"trace[2004364399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:900; }","duration":"153.494308ms","start":"2026-04-22T16:32:03.229505Z","end":"2026-04-22T16:32:03.382999Z","steps":["trace[2004364399] 'agreement among raft nodes before linearized reading' (duration: 152.79964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.884166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.383159Z","caller":"traceutil/trace.go:171","msg":"trace[522363575] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:900; }","duration":"334.942637ms","start":"2026-04-22T16:32:03.048203Z","end":"2026-04-22T16:32:03.383146Z","steps":["trace[522363575] 'agreement among raft nodes before linearized reading' (duration: 334.890676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:03.048195Z","time spent":"334.991289ms","remote":"127.0.0.1:50548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-22T16:32:03.383235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.005407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.382464Z","caller":"traceutil/trace.go:171","msg":"trace[511652313] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:900; }","duration":"308.34034ms","start":"2026-04-22T16:32:03.07411Z","end":"2026-04-22T16:32:03.382451Z","steps":["trace[511652313] 'agreement among raft nodes before linearized reading' (duration: 308.261948ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:03.383262Z","caller":"traceutil/trace.go:171","msg":"trace[1075243908] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:900; }","duration":"513.055238ms","start":"2026-04-22T16:32:02.870199Z","end":"2026-04-22T16:32:03.383254Z","steps":["trace[1075243908] 'agreement among raft nodes before linearized reading' (duration: 513.019257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.38328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.870184Z","time spent":"513.090499ms","remote":"127.0.0.1:50482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-22T16:32:03.383368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.690332ms","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":"warn","ts":"2026-04-22T16:32:03.383102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.764287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-22T16:32:03.383392Z","caller":"traceutil/trace.go:171","msg":"trace[1169938117] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:900; }","duration":"470.715413ms","start":"2026-04-22T16:32:02.912671Z","end":"2026-04-22T16:32:03.383386Z","steps":["trace[1169938117] 'agreement among raft nodes before linearized reading' (duration: 470.681282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.629525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.383411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.91259Z","time spent":"470.815985ms","remote":"127.0.0.1:50506","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":"info","ts":"2026-04-22T16:32:03.383427Z","caller":"traceutil/trace.go:171","msg":"trace[1106481782] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:900; }","duration":"335.681226ms","start":"2026-04-22T16:32:03.047737Z","end":"2026-04-22T16:32:03.383419Z","steps":["trace[1106481782] 'agreement among raft nodes before linearized reading' (duration: 335.645155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:03.047722Z","time spent":"335.795479ms","remote":"127.0.0.1:50548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T16:32:03.383567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.234267ms","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-22T16:32:03.383591Z","caller":"traceutil/trace.go:171","msg":"trace[402256158] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:900; }","duration":"471.284138ms","start":"2026-04-22T16:32:02.912301Z","end":"2026-04-22T16:32:03.383585Z","steps":["trace[402256158] 'agreement among raft nodes before linearized reading' (duration: 471.246037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.912283Z","time spent":"471.328029ms","remote":"127.0.0.1:50506","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-22T16:32:03.3837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.909683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.383722Z","caller":"traceutil/trace.go:171","msg":"trace[1106286642] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:900; }","duration":"492.941144ms","start":"2026-04-22T16:32:02.890775Z","end":"2026-04-22T16:32:03.383717Z","steps":["trace[1106286642] 'agreement among raft nodes before linearized reading' (duration: 492.907823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.890772Z","time spent":"492.962605ms","remote":"127.0.0.1:50498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-22T16:32:03.383768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.454732ms","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-22T16:32:03.383806Z","caller":"traceutil/trace.go:171","msg":"trace[1828726069] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:900; }","duration":"387.505713ms","start":"2026-04-22T16:32:02.996291Z","end":"2026-04-22T16:32:03.383797Z","steps":["trace[1828726069] 'agreement among raft nodes before linearized reading' (duration: 387.446802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.996286Z","time spent":"387.540304ms","remote":"127.0.0.1:50534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-04-22T16:32:03.38364Z","caller":"traceutil/trace.go:171","msg":"trace[538614117] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:900; }","duration":"255.061564ms","start":"2026-04-22T16:32:03.128333Z","end":"2026-04-22T16:32:03.383394Z","steps":["trace[538614117] 'agreement among raft nodes before linearized reading' (duration: 254.729186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.279323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.383889Z","caller":"traceutil/trace.go:171","msg":"trace[1928250545] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:900; }","duration":"493.324214ms","start":"2026-04-22T16:32:02.89056Z","end":"2026-04-22T16:32:03.383884Z","steps":["trace[1928250545] 'agreement among raft nodes before linearized reading' (duration: 493.296474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.890542Z","time spent":"493.358915ms","remote":"127.0.0.1:50498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:32:03.383065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.19427ms","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-22T16:32:03.384015Z","caller":"traceutil/trace.go:171","msg":"trace[384473449] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:900; }","duration":"471.171615ms","start":"2026-04-22T16:32:02.912837Z","end":"2026-04-22T16:32:03.384009Z","steps":["trace[384473449] 'agreement among raft nodes before linearized reading' (duration: 470.170479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.216562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.384043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.912833Z","time spent":"471.203786ms","remote":"127.0.0.1:50506","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":"info","ts":"2026-04-22T16:32:03.384052Z","caller":"traceutil/trace.go:171","msg":"trace[217666054] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:900; }","duration":"388.268033ms","start":"2026-04-22T16:32:02.995775Z","end":"2026-04-22T16:32:03.384043Z","steps":["trace[217666054] 'agreement among raft nodes before linearized reading' (duration: 388.233032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.995759Z","time spent":"388.319485ms","remote":"127.0.0.1:50534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T16:32:03.383362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.401559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.384181Z","caller":"traceutil/trace.go:171","msg":"trace[119185611] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:900; }","duration":"336.261481ms","start":"2026-04-22T16:32:03.047908Z","end":"2026-04-22T16:32:03.38417Z","steps":["trace[119185611] 'agreement among raft nodes before linearized reading' (duration: 335.42761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.383129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.463907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.384203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:03.047883Z","time spent":"336.312552ms","remote":"127.0.0.1:50548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-22T16:32:03.38421Z","caller":"traceutil/trace.go:171","msg":"trace[1794727503] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:900; }","duration":"276.577296ms","start":"2026-04-22T16:32:03.107623Z","end":"2026-04-22T16:32:03.384201Z","steps":["trace[1794727503] 'agreement among raft nodes before linearized reading' (duration: 275.489518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.844664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.383303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:03.074086Z","time spent":"309.187053ms","remote":"127.0.0.1:50554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-22T16:32:03.383842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.195661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.384393Z","caller":"traceutil/trace.go:171","msg":"trace[587651069] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:900; }","duration":"493.753196ms","start":"2026-04-22T16:32:02.890631Z","end":"2026-04-22T16:32:03.384384Z","steps":["trace[587651069] 'agreement among raft nodes before linearized reading' (duration: 493.193981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.890627Z","time spent":"493.791157ms","remote":"127.0.0.1:50498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-22T16:32:03.384341Z","caller":"traceutil/trace.go:171","msg":"trace[1783319692] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:900; }","duration":"457.035988ms","start":"2026-04-22T16:32:02.927294Z","end":"2026-04-22T16:32:03.384329Z","steps":["trace[1783319692] 'agreement among raft nodes before linearized reading' (duration: 456.848774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.927278Z","time spent":"457.217475ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T16:32:03.38399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.15355ms","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-22T16:32:03.384562Z","caller":"traceutil/trace.go:171","msg":"trace[1283495717] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:900; }","duration":"388.735945ms","start":"2026-04-22T16:32:02.995817Z","end":"2026-04-22T16:32:03.384553Z","steps":["trace[1283495717] 'agreement among raft nodes before linearized reading' (duration: 388.148239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.995814Z","time spent":"388.776266ms","remote":"127.0.0.1:50534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:32:03.384717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.334454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.384746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.576418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.384804Z","caller":"traceutil/trace.go:171","msg":"trace[529134714] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:900; }","duration":"514.886716ms","start":"2026-04-22T16:32:02.869905Z","end":"2026-04-22T16:32:03.384791Z","steps":["trace[529134714] 'agreement among raft nodes before linearized reading' (duration: 513.963002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.945311ms","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-22T16:32:03.384877Z","caller":"traceutil/trace.go:171","msg":"trace[252666848] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:900; }","duration":"421.046403ms","start":"2026-04-22T16:32:02.963825Z","end":"2026-04-22T16:32:03.384871Z","steps":["trace[252666848] 'agreement among raft nodes before linearized reading' (duration: 420.955831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.05124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.384937Z","caller":"traceutil/trace.go:171","msg":"trace[1301502115] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:900; }","duration":"515.117801ms","start":"2026-04-22T16:32:02.869811Z","end":"2026-04-22T16:32:03.384928Z","steps":["trace[1301502115] 'agreement among raft nodes before linearized reading' (duration: 515.07257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.384959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.869787Z","time spent":"515.166433ms","remote":"127.0.0.1:50494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T16:32:03.384919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.963803Z","time spent":"421.108455ms","remote":"127.0.0.1:50522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T16:32:03.385028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.676466ms","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-22T16:32:03.385067Z","caller":"traceutil/trace.go:171","msg":"trace[781813085] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:900; }","duration":"457.717488ms","start":"2026-04-22T16:32:02.92734Z","end":"2026-04-22T16:32:03.385058Z","steps":["trace[781813085] 'agreement among raft nodes before linearized reading' (duration: 457.660175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.385102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.9273Z","time spent":"457.79336ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:32:03.385127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.063106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.385145Z","caller":"traceutil/trace.go:171","msg":"trace[645359762] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:900; }","duration":"220.081307ms","start":"2026-04-22T16:32:03.165057Z","end":"2026-04-22T16:32:03.385138Z","steps":["trace[645359762] 'agreement among raft nodes before linearized reading' (duration: 220.052836ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:03.382051Z","caller":"traceutil/trace.go:171","msg":"trace[463256585] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:900; }","duration":"217.110497ms","start":"2026-04-22T16:32:03.164927Z","end":"2026-04-22T16:32:03.382038Z","steps":["trace[463256585] 'agreement among raft nodes before linearized reading' (duration: 217.018955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.385194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.713142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:03.385225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.996503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.385232Z","caller":"traceutil/trace.go:171","msg":"trace[269679769] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:900; }","duration":"200.783653ms","start":"2026-04-22T16:32:03.184441Z","end":"2026-04-22T16:32:03.385224Z","steps":["trace[269679769] 'agreement among raft nodes before linearized reading' (duration: 200.726491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.38526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.418761ms","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-22T16:32:03.385295Z","caller":"traceutil/trace.go:171","msg":"trace[1298724965] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:900; }","duration":"457.516823ms","start":"2026-04-22T16:32:02.92777Z","end":"2026-04-22T16:32:03.385286Z","steps":["trace[1298724965] 'agreement among raft nodes before linearized reading' (duration: 457.467952ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:03.384767Z","caller":"traceutil/trace.go:171","msg":"trace[1142369541] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:900; }","duration":"420.415476ms","start":"2026-04-22T16:32:02.964342Z","end":"2026-04-22T16:32:03.384758Z","steps":["trace[1142369541] 'agreement among raft nodes before linearized reading' (duration: 420.352795ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:03.385238Z","caller":"traceutil/trace.go:171","msg":"trace[1195170752] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:900; }","duration":"220.029395ms","start":"2026-04-22T16:32:03.165205Z","end":"2026-04-22T16:32:03.385235Z","steps":["trace[1195170752] 'agreement among raft nodes before linearized reading' (duration: 220.008265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.385331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.927752Z","time spent":"457.568444ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-22T16:32:03.385349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.96432Z","time spent":"421.021323ms","remote":"127.0.0.1:50522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:32:03.384847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:02.869859Z","time spent":"514.976028ms","remote":"127.0.0.1:50494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:32:03.382946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.829162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T16:32:03.385728Z","caller":"traceutil/trace.go:171","msg":"trace[1415722514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:900; }","duration":"256.631985ms","start":"2026-04-22T16:32:03.129085Z","end":"2026-04-22T16:32:03.385717Z","steps":["trace[1415722514] 'agreement among raft nodes before linearized reading' (duration: 253.78474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.382526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.447213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:03.386056Z","caller":"traceutil/trace.go:171","msg":"trace[138024447] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:900; }","duration":"311.982056ms","start":"2026-04-22T16:32:03.074064Z","end":"2026-04-22T16:32:03.386047Z","steps":["trace[138024447] 'agreement among raft nodes before linearized reading' (duration: 308.425962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:03.386129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:03.074023Z","time spent":"312.067569ms","remote":"127.0.0.1:50554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-22T16:32:03.382745Z","caller":"traceutil/trace.go:171","msg":"trace[261544686] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:900; }","duration":"198.243136ms","start":"2026-04-22T16:32:03.184493Z","end":"2026-04-22T16:32:03.382736Z","steps":["trace[261544686] 'agreement among raft nodes before linearized reading' (duration: 198.195344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:05.782335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.041939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:32:05.782429Z","caller":"traceutil/trace.go:171","msg":"trace[461001991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:913; }","duration":"149.174772ms","start":"2026-04-22T16:32:05.633233Z","end":"2026-04-22T16:32:05.782408Z","steps":["trace[461001991] 'range keys from in-memory index tree' (duration: 148.947396ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:32.576811Z","caller":"traceutil/trace.go:171","msg":"trace[1698141907] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"119.37587ms","start":"2026-04-22T16:32:32.457418Z","end":"2026-04-22T16:32:32.576794Z","steps":["trace[1698141907] 'process raft request' (duration: 119.282768ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:38.196712Z","caller":"traceutil/trace.go:171","msg":"trace[1704597506] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"141.084599ms","start":"2026-04-22T16:32:38.055607Z","end":"2026-04-22T16:32:38.196691Z","steps":["trace[1704597506] 'process raft request' (duration: 140.951364ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:39.7966Z","caller":"traceutil/trace.go:171","msg":"trace[1500545668] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"851.349854ms","start":"2026-04-22T16:32:38.945232Z","end":"2026-04-22T16:32:39.796581Z","steps":["trace[1500545668] 'process raft request' (duration: 851.240621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:39.796717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:32:38.945213Z","time spent":"851.443876ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:32:39.872989Z","caller":"traceutil/trace.go:171","msg":"trace[385732555] linearizableReadLoop","detail":"{readStateIndex:1164; appliedIndex:1163; }","duration":"289.644834ms","start":"2026-04-22T16:32:39.583319Z","end":"2026-04-22T16:32:39.872964Z","steps":["trace[385732555] 'read index received' (duration: 213.279475ms)","trace[385732555] 'applied index is now lower than readState.Index' (duration: 76.364029ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:32:39.873241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.894401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T16:32:39.873318Z","caller":"traceutil/trace.go:171","msg":"trace[1900792038] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1122; }","duration":"290.019124ms","start":"2026-04-22T16:32:39.583281Z","end":"2026-04-22T16:32:39.8733Z","steps":["trace[1900792038] 'agreement among raft nodes before linearized reading' (duration: 289.781387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:39.873524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.740771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T16:32:39.873638Z","caller":"traceutil/trace.go:171","msg":"trace[1404815826] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1122; }","duration":"277.139231ms","start":"2026-04-22T16:32:39.596479Z","end":"2026-04-22T16:32:39.873618Z","steps":["trace[1404815826] 'agreement among raft nodes before linearized reading' (duration: 276.655678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:39.873615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.329547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:32:39.873766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.110935ms","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-22T16:32:39.873852Z","caller":"traceutil/trace.go:171","msg":"trace[369950744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1122; }","duration":"273.180247ms","start":"2026-04-22T16:32:39.600648Z","end":"2026-04-22T16:32:39.873828Z","steps":["trace[369950744] 'agreement among raft nodes before linearized reading' (duration: 273.033683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:32:39.873765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.099915ms","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-22T16:32:39.873948Z","caller":"traceutil/trace.go:171","msg":"trace[1481621164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1122; }","duration":"273.296049ms","start":"2026-04-22T16:32:39.600628Z","end":"2026-04-22T16:32:39.873924Z","steps":["trace[1481621164] 'agreement among raft nodes before linearized reading' (duration: 273.011192ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:39.873772Z","caller":"traceutil/trace.go:171","msg":"trace[76142743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1122; }","duration":"242.551863ms","start":"2026-04-22T16:32:39.631205Z","end":"2026-04-22T16:32:39.873757Z","steps":["trace[76142743] 'agreement among raft nodes before linearized reading' (duration: 242.299706ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:52.125767Z","caller":"traceutil/trace.go:171","msg":"trace[1434406328] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"109.037801ms","start":"2026-04-22T16:32:52.016697Z","end":"2026-04-22T16:32:52.125735Z","steps":["trace[1434406328] 'process raft request' (duration: 88.347143ms)","trace[1434406328] 'compare' (duration: 20.38238ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:32:53.016443Z","caller":"traceutil/trace.go:171","msg":"trace[401145293] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"192.431324ms","start":"2026-04-22T16:32:52.823986Z","end":"2026-04-22T16:32:53.016418Z","steps":["trace[401145293] 'process raft request' (duration: 192.231128ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:32:58.482284Z","caller":"traceutil/trace.go:171","msg":"trace[11028199] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"192.635719ms","start":"2026-04-22T16:32:58.289627Z","end":"2026-04-22T16:32:58.482263Z","steps":["trace[11028199] 'process raft request' (duration: 192.507566ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:03.865189Z","caller":"traceutil/trace.go:171","msg":"trace[146588859] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"528.589238ms","start":"2026-04-22T16:33:03.336574Z","end":"2026-04-22T16:33:03.865164Z","steps":["trace[146588859] 'process raft request' (duration: 528.296591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:03.865353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:03.336548Z","time spent":"528.720402ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:33:04.909007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.61914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:33:04.909067Z","caller":"traceutil/trace.go:171","msg":"trace[282454653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"275.727893ms","start":"2026-04-22T16:33:04.633325Z","end":"2026-04-22T16:33:04.909053Z","steps":["trace[282454653] 'range keys from in-memory index tree' (duration: 275.527038ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:06.302291Z","caller":"traceutil/trace.go:171","msg":"trace[919684227] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"146.194258ms","start":"2026-04-22T16:33:06.156048Z","end":"2026-04-22T16:33:06.302242Z","steps":["trace[919684227] 'process raft request' (duration: 146.021963ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:10.702076Z","caller":"traceutil/trace.go:171","msg":"trace[1956508927] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"125.632063ms","start":"2026-04-22T16:33:10.576414Z","end":"2026-04-22T16:33:10.702046Z","steps":["trace[1956508927] 'process raft request' (duration: 125.407346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:20.924994Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18221737497471914011,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T16:33:21.426011Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18221737497471914011,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T16:33:21.533639Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.110289955s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T16:33:21.534153Z","caller":"traceutil/trace.go:171","msg":"trace[914298507] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"1.110891321s","start":"2026-04-22T16:33:20.423234Z","end":"2026-04-22T16:33:21.534125Z","steps":["trace[914298507] 'process raft request' (duration: 1.110655266s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:21.534378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:20.423209Z","time spent":"1.111058876s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:33:21.842275Z","caller":"traceutil/trace.go:171","msg":"trace[1228825337] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1356; }","duration":"1.417970445s","start":"2026-04-22T16:33:20.424211Z","end":"2026-04-22T16:33:21.842181Z","steps":["trace[1228825337] 'read index received' (duration: 1.109619518s)","trace[1228825337] 'applied index is now lower than readState.Index' (duration: 308.349817ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:33:21.842317Z","caller":"traceutil/trace.go:171","msg":"trace[814838741] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"1.109820093s","start":"2026-04-22T16:33:20.732459Z","end":"2026-04-22T16:33:21.842279Z","steps":["trace[814838741] 'process raft request' (duration: 1.109370551s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:21.842533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.418287723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T16:33:21.842604Z","caller":"traceutil/trace.go:171","msg":"trace[512900887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1306; }","duration":"1.41845415s","start":"2026-04-22T16:33:20.424134Z","end":"2026-04-22T16:33:21.842589Z","steps":["trace[512900887] 'agreement among raft nodes before linearized reading' (duration: 1.418253324s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:21.842629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:20.732443Z","time spent":"1.110097649s","remote":"127.0.0.1:52078","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-22T16:33:21.842663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:20.424118Z","time spent":"1.418532121s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T16:33:21.842863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.318857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:33:21.842911Z","caller":"traceutil/trace.go:171","msg":"trace[257014542] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1306; }","duration":"989.420259ms","start":"2026-04-22T16:33:20.853475Z","end":"2026-04-22T16:33:21.842895Z","steps":["trace[257014542] 'agreement among raft nodes before linearized reading' (duration: 989.345847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:21.84296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:20.853451Z","time spent":"989.496972ms","remote":"127.0.0.1:50720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:33:21.843154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.418902319s","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-22T16:33:21.84331Z","caller":"traceutil/trace.go:171","msg":"trace[2058486305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1306; }","duration":"1.419095915s","start":"2026-04-22T16:33:20.424193Z","end":"2026-04-22T16:33:21.843289Z","steps":["trace[2058486305] 'agreement among raft nodes before linearized reading' (duration: 1.418556921s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:21.843519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.419261389s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T16:33:21.843584Z","caller":"traceutil/trace.go:171","msg":"trace[2033431312] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1306; }","duration":"1.419351992s","start":"2026-04-22T16:33:20.424217Z","end":"2026-04-22T16:33:21.843569Z","steps":["trace[2033431312] 'agreement among raft nodes before linearized reading' (duration: 1.419203148s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:21.843626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:20.424201Z","time spent":"1.419414393s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T16:33:21.843484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:20.424179Z","time spent":"1.41928796s","remote":"127.0.0.1:52078","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-22T16:33:21.843416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210830792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:33:21.843826Z","caller":"traceutil/trace.go:171","msg":"trace[131287723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1306; }","duration":"1.211261153s","start":"2026-04-22T16:33:20.63255Z","end":"2026-04-22T16:33:21.843811Z","steps":["trace[131287723] 'agreement among raft nodes before linearized reading' (duration: 1.210837223s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:21.843358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.413719354s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-22T16:33:21.84388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:20.632533Z","time spent":"1.211332916s","remote":"127.0.0.1:51842","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-22T16:33:21.843896Z","caller":"traceutil/trace.go:171","msg":"trace[980942054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1306; }","duration":"1.414271817s","start":"2026-04-22T16:33:20.429603Z","end":"2026-04-22T16:33:21.843875Z","steps":["trace[980942054] 'agreement among raft nodes before linearized reading' (duration: 1.41364161s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:21.843948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:20.429589Z","time spent":"1.414344009s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T16:33:21.843203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.235772ms","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-22T16:33:21.844278Z","caller":"traceutil/trace.go:171","msg":"trace[1814594856] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1306; }","duration":"126.33009ms","start":"2026-04-22T16:33:21.717927Z","end":"2026-04-22T16:33:21.844257Z","steps":["trace[1814594856] 'agreement among raft nodes before linearized reading' (duration: 125.230751ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:22.024578Z","caller":"traceutil/trace.go:171","msg":"trace[605528988] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"176.748397ms","start":"2026-04-22T16:33:21.847795Z","end":"2026-04-22T16:33:22.024543Z","steps":["trace[605528988] 'process raft request' (duration: 176.076009ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:22.033995Z","caller":"traceutil/trace.go:171","msg":"trace[594186119] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1358; }","duration":"181.560425ms","start":"2026-04-22T16:33:21.852417Z","end":"2026-04-22T16:33:22.033977Z","steps":["trace[594186119] 'read index received' (duration: 171.466377ms)","trace[594186119] 'applied index is now lower than readState.Index' (duration: 10.093228ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:33:22.034042Z","caller":"traceutil/trace.go:171","msg":"trace[1807385832] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"185.742026ms","start":"2026-04-22T16:33:21.848269Z","end":"2026-04-22T16:33:22.034011Z","steps":["trace[1807385832] 'process raft request' (duration: 185.5105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:22.03416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.717549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:33:22.034189Z","caller":"traceutil/trace.go:171","msg":"trace[1108294407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"181.788761ms","start":"2026-04-22T16:33:21.852392Z","end":"2026-04-22T16:33:22.034181Z","steps":["trace[1108294407] 'agreement among raft nodes before linearized reading' (duration: 181.654098ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:22.03425Z","caller":"traceutil/trace.go:171","msg":"trace[1617550313] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"185.056188ms","start":"2026-04-22T16:33:21.849147Z","end":"2026-04-22T16:33:22.034203Z","steps":["trace[1617550313] 'process raft request' (duration: 184.779431ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:22.034306Z","caller":"traceutil/trace.go:171","msg":"trace[575380887] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"184.244496ms","start":"2026-04-22T16:33:21.850021Z","end":"2026-04-22T16:33:22.034265Z","steps":["trace[575380887] 'process raft request' (duration: 183.930998ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:37.906674Z","caller":"traceutil/trace.go:171","msg":"trace[1875642560] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"297.52881ms","start":"2026-04-22T16:33:37.60912Z","end":"2026-04-22T16:33:37.906649Z","steps":["trace[1875642560] 'process raft request' (duration: 297.385136ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:37.906723Z","caller":"traceutil/trace.go:171","msg":"trace[1425987052] linearizableReadLoop","detail":"{readStateIndex:1428; appliedIndex:1428; }","duration":"275.194818ms","start":"2026-04-22T16:33:37.631515Z","end":"2026-04-22T16:33:37.906709Z","steps":["trace[1425987052] 'read index received' (duration: 275.187287ms)","trace[1425987052] 'applied index is now lower than readState.Index' (duration: 6.371µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:33:37.906848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.324851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:33:37.906884Z","caller":"traceutil/trace.go:171","msg":"trace[1814966828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1373; }","duration":"275.405864ms","start":"2026-04-22T16:33:37.631469Z","end":"2026-04-22T16:33:37.906875Z","steps":["trace[1814966828] 'agreement among raft nodes before linearized reading' (duration: 275.309121ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:37.926292Z","caller":"traceutil/trace.go:171","msg":"trace[1898963960] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"269.591559ms","start":"2026-04-22T16:33:37.656669Z","end":"2026-04-22T16:33:37.92626Z","steps":["trace[1898963960] 'process raft request' (duration: 269.429755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:40.00395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.525597ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T16:33:40.004375Z","caller":"traceutil/trace.go:171","msg":"trace[425348619] linearizableReadLoop","detail":"{readStateIndex:1437; appliedIndex:1436; }","duration":"371.000979ms","start":"2026-04-22T16:33:39.633343Z","end":"2026-04-22T16:33:40.004344Z","steps":["trace[425348619] 'read index received' (duration: 141.057721ms)","trace[425348619] 'applied index is now lower than readState.Index' (duration: 229.939208ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:33:40.004603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.242136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:33:40.004635Z","caller":"traceutil/trace.go:171","msg":"trace[1252274498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1382; }","duration":"371.330438ms","start":"2026-04-22T16:33:39.633294Z","end":"2026-04-22T16:33:40.004625Z","steps":["trace[1252274498] 'agreement among raft nodes before linearized reading' (duration: 371.241466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:40.004672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:39.633269Z","time spent":"371.39583ms","remote":"127.0.0.1:51842","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-22T16:33:40.164923Z","caller":"traceutil/trace.go:171","msg":"trace[1054236583] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"151.470698ms","start":"2026-04-22T16:33:40.013426Z","end":"2026-04-22T16:33:40.164896Z","steps":["trace[1054236583] 'process raft request' (duration: 101.839702ms)","trace[1054236583] 'compare' (duration: 49.487622ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T16:33:51.600543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.453913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T16:33:51.600645Z","caller":"traceutil/trace.go:171","msg":"trace[124978471] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1467; }","duration":"152.620918ms","start":"2026-04-22T16:33:51.448Z","end":"2026-04-22T16:33:51.600621Z","steps":["trace[124978471] 'count revisions from in-memory index tree' (duration: 152.391582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:51.600771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.815867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:33:51.600814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.501955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"warn","ts":"2026-04-22T16:33:51.600885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.246565419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T16:33:51.601Z","caller":"traceutil/trace.go:171","msg":"trace[1980081657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1467; }","duration":"1.246718853s","start":"2026-04-22T16:33:50.354251Z","end":"2026-04-22T16:33:51.60097Z","steps":["trace[1980081657] 'range keys from in-memory index tree' (duration: 1.246359423s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:51.60101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.213297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-22T16:33:51.601054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:50.354234Z","time spent":"1.246805205s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-22T16:33:51.601071Z","caller":"traceutil/trace.go:171","msg":"trace[394138481] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1467; }","duration":"330.29556ms","start":"2026-04-22T16:33:51.270763Z","end":"2026-04-22T16:33:51.601058Z","steps":["trace[394138481] 'range keys from in-memory index tree' (duration: 330.114545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:51.601106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.27075Z","time spent":"330.346241ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-22T16:33:51.601206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.245607413s","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-22T16:33:51.600933Z","caller":"traceutil/trace.go:171","msg":"trace[1110285819] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1467; }","duration":"341.676291ms","start":"2026-04-22T16:33:51.259232Z","end":"2026-04-22T16:33:51.600908Z","steps":["trace[1110285819] 'range keys from in-memory index tree' (duration: 341.295401ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:51.601251Z","caller":"traceutil/trace.go:171","msg":"trace[1289912247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1467; }","duration":"1.245656825s","start":"2026-04-22T16:33:50.355581Z","end":"2026-04-22T16:33:51.601238Z","steps":["trace[1289912247] 'range keys from in-memory index tree' (duration: 1.245435349s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:51.601265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.259211Z","time spent":"342.03951ms","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-22T16:33:51.601292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:50.355577Z","time spent":"1.245702526s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T16:33:51.601377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.988281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:33:51.601404Z","caller":"traceutil/trace.go:171","msg":"trace[1337824894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1467; }","duration":"258.064283ms","start":"2026-04-22T16:33:51.343332Z","end":"2026-04-22T16:33:51.601396Z","steps":["trace[1337824894] 'range keys from in-memory index tree' (duration: 257.886438ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:51.600861Z","caller":"traceutil/trace.go:171","msg":"trace[1020170892] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1467; }","duration":"458.986462ms","start":"2026-04-22T16:33:51.141852Z","end":"2026-04-22T16:33:51.600838Z","steps":["trace[1020170892] 'count revisions from in-memory index tree' (duration: 458.716115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:51.601586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.141827Z","time spent":"459.697141ms","remote":"127.0.0.1:51942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:33:51.601814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.244203966s","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-22T16:33:51.602114Z","caller":"traceutil/trace.go:171","msg":"trace[626303410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1467; }","duration":"1.244501274s","start":"2026-04-22T16:33:50.35758Z","end":"2026-04-22T16:33:51.602081Z","steps":["trace[626303410] 'range keys from in-memory index tree' (duration: 1.244118274s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:51.602222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:50.35757Z","time spent":"1.244605687s","remote":"127.0.0.1:52078","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-22T16:33:51.60236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.245328556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-22T16:33:51.602448Z","caller":"traceutil/trace.go:171","msg":"trace[864755503] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1467; }","duration":"1.24547667s","start":"2026-04-22T16:33:50.356941Z","end":"2026-04-22T16:33:51.602418Z","steps":["trace[864755503] 'range keys from in-memory index tree' (duration: 1.2443398s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:51.602483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:50.356909Z","time spent":"1.245566052s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-22T16:33:51.845609Z","caller":"traceutil/trace.go:171","msg":"trace[2048636113] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"237.774445ms","start":"2026-04-22T16:33:51.607806Z","end":"2026-04-22T16:33:51.84558Z","steps":["trace[2048636113] 'process raft request' (duration: 237.56281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.633579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000233557s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-22T16:33:53.633655Z","caller":"traceutil/trace.go:171","msg":"trace[1306580732] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.0003631s","start":"2026-04-22T16:33:51.633277Z","end":"2026-04-22T16:33:53.63364Z","steps":["trace[1306580732] 'agreement among raft nodes before linearized reading' (duration: 2.000269808s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.63369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.633268Z","time spent":"2.000415751s","remote":"127.0.0.1:51832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T16:33:53.660864Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.815476607s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T16:33:53.661319Z","caller":"traceutil/trace.go:171","msg":"trace[195382686] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"2.053395336s","start":"2026-04-22T16:33:51.607906Z","end":"2026-04-22T16:33:53.661301Z","steps":["trace[195382686] 'process raft request' (duration: 2.053181149s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.661568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.607873Z","time spent":"2.053494659s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:33:53.661855Z","caller":"traceutil/trace.go:171","msg":"trace[1425117276] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"2.052985025s","start":"2026-04-22T16:33:51.608851Z","end":"2026-04-22T16:33:53.661836Z","steps":["trace[1425117276] 'process raft request' (duration: 2.052734599s)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:53.66187Z","caller":"traceutil/trace.go:171","msg":"trace[598119929] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"2.051840735s","start":"2026-04-22T16:33:51.610012Z","end":"2026-04-22T16:33:53.661852Z","steps":["trace[598119929] 'process raft request' (duration: 2.051756253s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.661966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.608841Z","time spent":"2.053082318s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:33:53.661865Z","caller":"traceutil/trace.go:171","msg":"trace[438643526] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"2.053405506s","start":"2026-04-22T16:33:51.608433Z","end":"2026-04-22T16:33:53.661838Z","steps":["trace[438643526] 'process raft request' (duration: 2.052823262s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.662023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.610003Z","time spent":"2.051945738s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:33:53.662139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.60842Z","time spent":"2.053639344s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":492,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:33:53.662402Z","caller":"traceutil/trace.go:171","msg":"trace[1427564712] linearizableReadLoop","detail":"{readStateIndex:1531; appliedIndex:1525; }","duration":"2.029056251s","start":"2026-04-22T16:33:51.633332Z","end":"2026-04-22T16:33:53.662388Z","steps":["trace[1427564712] 'read index received' (duration: 212.055954ms)","trace[1427564712] 'applied index is now lower than readState.Index' (duration: 1.816999417s)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:33:53.66242Z","caller":"traceutil/trace.go:171","msg":"trace[470719659] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"2.052350039s","start":"2026-04-22T16:33:51.610056Z","end":"2026-04-22T16:33:53.662406Z","steps":["trace[470719659] 'process raft request' (duration: 2.051748062s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.662849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.610052Z","time spent":"2.05243048s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T16:33:53.666389Z","caller":"traceutil/trace.go:171","msg":"trace[629175259] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"1.612199826s","start":"2026-04-22T16:33:52.054167Z","end":"2026-04-22T16:33:53.666367Z","steps":["trace[629175259] 'process raft request' (duration: 1.612024311s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.66643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.670366838s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-04-22T16:33:53.666457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.775386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-22T16:33:53.666482Z","caller":"traceutil/trace.go:171","msg":"trace[549930262] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1475; }","duration":"1.67044928s","start":"2026-04-22T16:33:51.996018Z","end":"2026-04-22T16:33:53.666468Z","steps":["trace[549930262] 'agreement among raft nodes before linearized reading' (duration: 1.670290646s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.666573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:51.996002Z","time spent":"1.670560353s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-04-22T16:33:53.666546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:52.054141Z","time spent":"1.612306928s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T16:33:53.666735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.431059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:33:53.66678Z","caller":"traceutil/trace.go:171","msg":"trace[1228616228] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1475; }","duration":"581.510941ms","start":"2026-04-22T16:33:53.08526Z","end":"2026-04-22T16:33:53.666771Z","steps":["trace[1228616228] 'agreement among raft nodes before linearized reading' (duration: 581.366267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.666794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.256047631s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T16:33:53.666804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:53.085234Z","time spent":"581.561454ms","remote":"127.0.0.1:50622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-04-22T16:33:53.666493Z","caller":"traceutil/trace.go:171","msg":"trace[713597676] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1475; }","duration":"303.849568ms","start":"2026-04-22T16:33:53.362634Z","end":"2026-04-22T16:33:53.666484Z","steps":["trace[713597676] 'agreement among raft nodes before linearized reading' (duration: 303.691454ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:33:53.666851Z","caller":"traceutil/trace.go:171","msg":"trace[2083348104] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1475; }","duration":"1.256095052s","start":"2026-04-22T16:33:52.410731Z","end":"2026-04-22T16:33:53.666826Z","steps":["trace[2083348104] 'agreement among raft nodes before linearized reading' (duration: 1.256018909s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.666851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.548730943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-22T16:33:53.666888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:52.410674Z","time spent":"1.256203846s","remote":"127.0.0.1:52222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-22T16:33:53.666886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:53.36261Z","time spent":"304.260419ms","remote":"127.0.0.1:52356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":163,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-04-22T16:33:53.666922Z","caller":"traceutil/trace.go:171","msg":"trace[1460406092] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1475; }","duration":"1.548848236s","start":"2026-04-22T16:33:52.118056Z","end":"2026-04-22T16:33:53.666904Z","steps":["trace[1460406092] 'agreement among raft nodes before linearized reading' (duration: 1.54862279s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.666972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:52.118035Z","time spent":"1.548923569s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T16:33:53.667329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.211105119s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-04-22T16:33:53.667363Z","caller":"traceutil/trace.go:171","msg":"trace[277007718] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1475; }","duration":"1.211174331s","start":"2026-04-22T16:33:52.456177Z","end":"2026-04-22T16:33:53.667352Z","steps":["trace[277007718] 'agreement among raft nodes before linearized reading' (duration: 1.211088678s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:33:53.668297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T16:33:52.456149Z","time spent":"1.212127257s","remote":"127.0.0.1:52078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-22T16:35:00.10658Z","caller":"traceutil/trace.go:171","msg":"trace[554203284] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"130.482359ms","start":"2026-04-22T16:34:59.976064Z","end":"2026-04-22T16:35:00.106547Z","steps":["trace[554203284] 'process raft request' (duration: 130.17857ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:35:00.106737Z","caller":"traceutil/trace.go:171","msg":"trace[164128850] transaction","detail":"{read_only:false; response_revision:1782; number_of_response:1; }","duration":"129.301327ms","start":"2026-04-22T16:34:59.977378Z","end":"2026-04-22T16:35:00.106679Z","steps":["trace[164128850] 'process raft request' (duration: 129.040279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:35:00.106747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.289483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-22T16:35:00.107005Z","caller":"traceutil/trace.go:171","msg":"trace[880723072] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1782; }","duration":"130.56404ms","start":"2026-04-22T16:34:59.976411Z","end":"2026-04-22T16:35:00.106975Z","steps":["trace[880723072] 'agreement among raft nodes before linearized reading' (duration: 130.17774ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T16:37:00.742601Z","caller":"traceutil/trace.go:171","msg":"trace[376002957] linearizableReadLoop","detail":"{readStateIndex:2453; appliedIndex:2452; }","duration":"109.882684ms","start":"2026-04-22T16:37:00.632697Z","end":"2026-04-22T16:37:00.74258Z","steps":["trace[376002957] 'read index received' (duration: 109.692619ms)","trace[376002957] 'applied index is now lower than readState.Index' (duration: 189.075µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T16:37:00.742717Z","caller":"traceutil/trace.go:171","msg":"trace[1673385930] transaction","detail":"{read_only:false; response_revision:2356; number_of_response:1; }","duration":"130.921771ms","start":"2026-04-22T16:37:00.611782Z","end":"2026-04-22T16:37:00.742704Z","steps":["trace[1673385930] 'process raft request' (duration: 130.660724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T16:37:00.742877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.167662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T16:37:00.74292Z","caller":"traceutil/trace.go:171","msg":"trace[263523569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2356; }","duration":"110.252075ms","start":"2026-04-22T16:37:00.632658Z","end":"2026-04-22T16:37:00.74291Z","steps":["trace[263523569] 'agreement among raft nodes before linearized reading' (duration: 110.177984ms)"],"step_count":1}