{"level":"warn","ts":"2026-04-22T00:59:04.566631Z","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-22T00:59:04.566735Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-22T00:59:04.566803Z","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-22T00:59:04.566815Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-04-22T00:59:04.566832Z","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-22T00:59:04.567504Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-04-22T00:59:04.567578Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-22T00:59:04.597678Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"29.301724ms"} {"level":"info","ts":"2026-04-22T00:59:04.609598Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-04-22T00:59:04.609673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T00:59:04.609694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-04-22T00:59:04.609709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T00:59:04.609721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-04-22T00:59:04.609765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-04-22T00:59:04.660285Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T00:59:04.662275Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T00:59:04.663945Z","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-22T00:59:04.666345Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T00:59:04.66675Z","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-22T00:59:04.666862Z","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-22T00:59:04.666882Z","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-22T00:59:04.666838Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T00:59:04.667666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-04-22T00:59:04.6754Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-04-22T00:59:04.677973Z","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-22T00:59:04.678217Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-04-22T00:59:04.678269Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-04-22T00:59:04.678497Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T00:59:04.678544Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T00:59:05.50997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T00:59:05.510043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T00:59:05.51009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-04-22T00:59:05.51011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-04-22T00:59:05.510121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-04-22T00:59:05.510141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-04-22T00:59:05.51019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-04-22T00:59:05.511243Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T00:59:05.51131Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:59:05.511307Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:59:05.511358Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:59:05.511615Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T00:59:05.512111Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T00:59:05.51311Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:59:05.51327Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:59:05.51337Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:59:05.515225Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-04-22T00:59:05.5154Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T00:59:33.847816Z","caller":"traceutil/trace.go:171","msg":"trace[469686278] linearizableReadLoop","detail":"{readStateIndex:524; appliedIndex:523; }","duration":"151.033626ms","start":"2026-04-22T00:59:33.696749Z","end":"2026-04-22T00:59:33.847783Z","steps":["trace[469686278] 'read index received' (duration: 68.018903ms)","trace[469686278] 'applied index is now lower than readState.Index' (duration: 83.013173ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:59:33.84801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.23606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-22T00:59:33.848073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.413923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-04-22T00:59:33.848125Z","caller":"traceutil/trace.go:171","msg":"trace[789813146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:506; }","duration":"151.393204ms","start":"2026-04-22T00:59:33.696712Z","end":"2026-04-22T00:59:33.848105Z","steps":["trace[789813146] 'agreement among raft nodes before linearized reading' (duration: 151.18702ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:33.848132Z","caller":"traceutil/trace.go:171","msg":"trace[625487965] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:506; }","duration":"140.526096ms","start":"2026-04-22T00:59:33.707586Z","end":"2026-04-22T00:59:33.848112Z","steps":["trace[625487965] 'agreement among raft nodes before linearized reading' (duration: 140.388343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:33.848168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.848791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-04-22T00:59:33.84823Z","caller":"traceutil/trace.go:171","msg":"trace[1932732925] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:506; }","duration":"139.946553ms","start":"2026-04-22T00:59:33.708268Z","end":"2026-04-22T00:59:33.848214Z","steps":["trace[1932732925] 'agreement among raft nodes before linearized reading' (duration: 139.782449ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:35.147948Z","caller":"traceutil/trace.go:171","msg":"trace[1447700380] transaction","detail":"{read_only:false; number_of_response:1; response_revision:532; }","duration":"109.152816ms","start":"2026-04-22T00:59:35.038767Z","end":"2026-04-22T00:59:35.14792Z","steps":["trace[1447700380] 'process raft request' (duration: 93.823429ms)","trace[1447700380] 'compare' (duration: 15.020221ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:59:35.148121Z","caller":"traceutil/trace.go:171","msg":"trace[1259499365] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"102.879162ms","start":"2026-04-22T00:59:35.045229Z","end":"2026-04-22T00:59:35.148108Z","steps":["trace[1259499365] 'process raft request' (duration: 102.449134ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:35.148157Z","caller":"traceutil/trace.go:171","msg":"trace[701805542] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"102.439142ms","start":"2026-04-22T00:59:35.045702Z","end":"2026-04-22T00:59:35.148141Z","steps":["trace[701805542] 'process raft request' (duration: 102.046694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:35.730429Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512982148097391,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T00:59:35.861736Z","caller":"traceutil/trace.go:171","msg":"trace[1649104951] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"657.852079ms","start":"2026-04-22T00:59:35.203856Z","end":"2026-04-22T00:59:35.861708Z","steps":["trace[1649104951] 'process raft request' (duration: 647.592003ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:35.862003Z","caller":"traceutil/trace.go:171","msg":"trace[906479631] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"648.178776ms","start":"2026-04-22T00:59:35.213812Z","end":"2026-04-22T00:59:35.86199Z","steps":["trace[906479631] 'process raft request' (duration: 647.816888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:35.862342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:35.213792Z","time spent":"648.249467ms","remote":"127.0.0.1:45928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:59:35.862498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:35.203837Z","time spent":"657.977071ms","remote":"127.0.0.1:45928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:59:35.862541Z","caller":"traceutil/trace.go:171","msg":"trace[1546921490] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"624.436739ms","start":"2026-04-22T00:59:35.238095Z","end":"2026-04-22T00:59:35.862532Z","steps":["trace[1546921490] 'process raft request' (duration: 623.844568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:35.862575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:35.238076Z","time spent":"624.482461ms","remote":"127.0.0.1:45928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T00:59:35.863288Z","caller":"traceutil/trace.go:171","msg":"trace[1727802480] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:564; }","duration":"633.309628ms","start":"2026-04-22T00:59:35.229951Z","end":"2026-04-22T00:59:35.86326Z","steps":["trace[1727802480] 'read index received' (duration: 621.596983ms)","trace[1727802480] 'applied index is now lower than readState.Index' (duration: 11.711205ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:59:35.863563Z","caller":"traceutil/trace.go:171","msg":"trace[734990443] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"589.274716ms","start":"2026-04-22T00:59:35.274262Z","end":"2026-04-22T00:59:35.863537Z","steps":["trace[734990443] 'process raft request' (duration: 588.019431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:35.863649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:35.274238Z","time spent":"589.369577ms","remote":"127.0.0.1:45928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:59:35.86371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.735827ms","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-22T00:59:35.863783Z","caller":"traceutil/trace.go:171","msg":"trace[609825714] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:547; }","duration":"633.846448ms","start":"2026-04-22T00:59:35.22992Z","end":"2026-04-22T00:59:35.863766Z","steps":["trace[609825714] 'agreement among raft nodes before linearized reading' (duration: 633.699195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:35.863829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:35.229906Z","time spent":"633.914619ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T00:59:35.86428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.356547ms","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-22T00:59:35.864321Z","caller":"traceutil/trace.go:171","msg":"trace[1785028925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:547; }","duration":"581.417118ms","start":"2026-04-22T00:59:35.282894Z","end":"2026-04-22T00:59:35.864311Z","steps":["trace[1785028925] 'agreement among raft nodes before linearized reading' (duration: 581.345156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:35.864362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:35.282886Z","time spent":"581.459158ms","remote":"127.0.0.1:46118","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-22T00:59:35.86478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.459616ms","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-22T00:59:35.864844Z","caller":"traceutil/trace.go:171","msg":"trace[165139949] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:547; }","duration":"492.562368ms","start":"2026-04-22T00:59:35.372271Z","end":"2026-04-22T00:59:35.864833Z","steps":["trace[165139949] 'agreement among raft nodes before linearized reading' (duration: 492.386244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:35.864881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:35.372251Z","time spent":"492.623339ms","remote":"127.0.0.1:46118","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-22T00:59:37.130828Z","caller":"traceutil/trace.go:171","msg":"trace[2137234585] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"656.486712ms","start":"2026-04-22T00:59:36.474316Z","end":"2026-04-22T00:59:37.130803Z","steps":["trace[2137234585] 'process raft request' (duration: 656.190986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:37.130986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:36.474299Z","time spent":"656.601484ms","remote":"127.0.0.1:45928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T00:59:42.432564Z","caller":"traceutil/trace.go:171","msg":"trace[1642397785] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"139.999614ms","start":"2026-04-22T00:59:42.292535Z","end":"2026-04-22T00:59:42.432534Z","steps":["trace[1642397785] 'process raft request' (duration: 138.967733ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:42.761856Z","caller":"traceutil/trace.go:171","msg":"trace[355922570] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"286.261965ms","start":"2026-04-22T00:59:42.47557Z","end":"2026-04-22T00:59:42.761832Z","steps":["trace[355922570] 'process raft request' (duration: 286.034561ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:42.770596Z","caller":"traceutil/trace.go:171","msg":"trace[56419902] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"290.907828ms","start":"2026-04-22T00:59:42.479667Z","end":"2026-04-22T00:59:42.770575Z","steps":["trace[56419902] 'process raft request' (duration: 290.813076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.159375Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512982148097551,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T00:59:44.176448Z","caller":"traceutil/trace.go:171","msg":"trace[774998621] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.000260639s","start":"2026-04-22T00:59:43.176165Z","end":"2026-04-22T00:59:44.176426Z","steps":["trace[774998621] 'process raft request' (duration: 999.661357ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.176766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.176133Z","time spent":"1.000478923s","remote":"127.0.0.1:45960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:59:44.224833Z","caller":"traceutil/trace.go:171","msg":"trace[1808266567] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"566.327576ms","start":"2026-04-22T00:59:43.658483Z","end":"2026-04-22T00:59:44.224811Z","steps":["trace[1808266567] 'read index received' (duration: 517.231053ms)","trace[1808266567] 'applied index is now lower than readState.Index' (duration: 49.095353ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:59:44.224993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.448068ms","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-22T00:59:44.225023Z","caller":"traceutil/trace.go:171","msg":"trace[1292202563] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:624; }","duration":"566.503179ms","start":"2026-04-22T00:59:43.658512Z","end":"2026-04-22T00:59:44.225015Z","steps":["trace[1292202563] 'agreement among raft nodes before linearized reading' (duration: 566.423438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.485519ms","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":"warn","ts":"2026-04-22T00:59:44.225063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.658489Z","time spent":"566.566581ms","remote":"127.0.0.1:45816","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":"info","ts":"2026-04-22T00:59:44.225159Z","caller":"traceutil/trace.go:171","msg":"trace[817143368] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:624; }","duration":"566.616062ms","start":"2026-04-22T00:59:43.658447Z","end":"2026-04-22T00:59:44.225063Z","steps":["trace[817143368] 'agreement among raft nodes before linearized reading' (duration: 566.465909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.789ms","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-22T00:59:44.225256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.150924ms","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-22T00:59:44.225277Z","caller":"traceutil/trace.go:171","msg":"trace[1278636151] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"394.82214ms","start":"2026-04-22T00:59:43.830447Z","end":"2026-04-22T00:59:44.225269Z","steps":["trace[1278636151] 'agreement among raft nodes before linearized reading' (duration: 394.778049ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.225303Z","caller":"traceutil/trace.go:171","msg":"trace[2122618378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"289.186854ms","start":"2026-04-22T00:59:43.936094Z","end":"2026-04-22T00:59:44.225281Z","steps":["trace[2122618378] 'agreement among raft nodes before linearized reading' (duration: 289.099483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.830433Z","time spent":"394.882151ms","remote":"127.0.0.1:45840","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-22T00:59:44.225315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.356437ms","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-22T00:59:44.225368Z","caller":"traceutil/trace.go:171","msg":"trace[255824758] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"318.458799ms","start":"2026-04-22T00:59:43.906898Z","end":"2026-04-22T00:59:44.225357Z","steps":["trace[255824758] 'agreement among raft nodes before linearized reading' (duration: 318.330886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.906882Z","time spent":"318.511311ms","remote":"127.0.0.1:45862","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-22T00:59:44.225449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.021124ms","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-22T00:59:44.225477Z","caller":"traceutil/trace.go:171","msg":"trace[682940999] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"395.050844ms","start":"2026-04-22T00:59:43.830419Z","end":"2026-04-22T00:59:44.22547Z","steps":["trace[682940999] 'agreement among raft nodes before linearized reading' (duration: 395.009153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.688227ms","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-22T00:59:44.22552Z","caller":"traceutil/trace.go:171","msg":"trace[1677967521] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"113.722728ms","start":"2026-04-22T00:59:44.111778Z","end":"2026-04-22T00:59:44.225501Z","steps":["trace[1677967521] 'agreement among raft nodes before linearized reading' (duration: 113.688517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.374632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:59:44.225589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.218124ms","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-22T00:59:44.225595Z","caller":"traceutil/trace.go:171","msg":"trace[93854296] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:624; }","duration":"444.422533ms","start":"2026-04-22T00:59:43.781163Z","end":"2026-04-22T00:59:44.225585Z","steps":["trace[93854296] 'agreement among raft nodes before linearized reading' (duration: 444.345772ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.225609Z","caller":"traceutil/trace.go:171","msg":"trace[605232356] 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:624; }","duration":"293.267495ms","start":"2026-04-22T00:59:43.932336Z","end":"2026-04-22T00:59:44.225604Z","steps":["trace[605232356] 'agreement among raft nodes before linearized reading' (duration: 293.230734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.781119Z","time spent":"444.492035ms","remote":"127.0.0.1:45836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T00:59:44.225548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.99875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:59:44.225666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.31897ms","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-22T00:59:44.225694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.667313ms","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-22T00:59:44.225711Z","caller":"traceutil/trace.go:171","msg":"trace[1605758575] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"318.710334ms","start":"2026-04-22T00:59:43.906996Z","end":"2026-04-22T00:59:44.225707Z","steps":["trace[1605758575] 'agreement among raft nodes before linearized reading' (duration: 318.681873ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.225713Z","caller":"traceutil/trace.go:171","msg":"trace[590565106] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"114.402442ms","start":"2026-04-22T00:59:44.111301Z","end":"2026-04-22T00:59:44.225704Z","steps":["trace[590565106] 'agreement among raft nodes before linearized reading' (duration: 114.347611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.140272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:59:44.225724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.162123ms","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":"warn","ts":"2026-04-22T00:59:44.225745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.889532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:44.225764Z","caller":"traceutil/trace.go:171","msg":"trace[421090066] 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:624; }","duration":"293.238955ms","start":"2026-04-22T00:59:43.932516Z","end":"2026-04-22T00:59:44.225755Z","steps":["trace[421090066] 'agreement among raft nodes before linearized reading' (duration: 293.181394ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.22579Z","caller":"traceutil/trace.go:171","msg":"trace[1819055465] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:624; }","duration":"443.956844ms","start":"2026-04-22T00:59:43.78182Z","end":"2026-04-22T00:59:44.225777Z","steps":["trace[1819055465] 'agreement among raft nodes before linearized reading' (duration: 443.907723ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.225775Z","caller":"traceutil/trace.go:171","msg":"trace[708240607] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:624; }","duration":"540.300905ms","start":"2026-04-22T00:59:43.685453Z","end":"2026-04-22T00:59:44.225754Z","steps":["trace[708240607] 'agreement among raft nodes before linearized reading' (duration: 540.04494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.781805Z","time spent":"444.000465ms","remote":"127.0.0.1:45836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-22T00:59:44.225845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.685423Z","time spent":"540.410876ms","remote":"127.0.0.1:45824","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":"warn","ts":"2026-04-22T00:59:44.225862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.884043ms","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":"warn","ts":"2026-04-22T00:59:44.225911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.058861ms","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-22T00:59:44.225933Z","caller":"traceutil/trace.go:171","msg":"trace[1950091508] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"319.101833ms","start":"2026-04-22T00:59:43.906827Z","end":"2026-04-22T00:59:44.225929Z","steps":["trace[1950091508] 'agreement among raft nodes before linearized reading' (duration: 319.068822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.906817Z","time spent":"319.127113ms","remote":"127.0.0.1:45862","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":"info","ts":"2026-04-22T00:59:44.225898Z","caller":"traceutil/trace.go:171","msg":"trace[1973446527] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"155.955394ms","start":"2026-04-22T00:59:44.069934Z","end":"2026-04-22T00:59:44.22589Z","steps":["trace[1973446527] 'agreement among raft nodes before linearized reading' (duration: 155.903623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.848611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:44.226027Z","caller":"traceutil/trace.go:171","msg":"trace[2089229711] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:624; }","duration":"444.871502ms","start":"2026-04-22T00:59:43.781149Z","end":"2026-04-22T00:59:44.22602Z","steps":["trace[2089229711] 'agreement among raft nodes before linearized reading' (duration: 444.837241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.286903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:59:44.226051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.781105Z","time spent":"444.941163ms","remote":"127.0.0.1:45836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-22T00:59:44.22606Z","caller":"traceutil/trace.go:171","msg":"trace[193247792] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"241.315674ms","start":"2026-04-22T00:59:43.984739Z","end":"2026-04-22T00:59:44.226055Z","steps":["trace[193247792] 'agreement among raft nodes before linearized reading' (duration: 241.289734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.640418ms","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-22T00:59:44.226161Z","caller":"traceutil/trace.go:171","msg":"trace[856033294] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"156.698329ms","start":"2026-04-22T00:59:44.069458Z","end":"2026-04-22T00:59:44.226157Z","steps":["trace[856033294] 'agreement among raft nodes before linearized reading' (duration: 156.667699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.755776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-22T00:59:44.226172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.329195ms","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-22T00:59:44.226221Z","caller":"traceutil/trace.go:171","msg":"trace[310842650] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:624; }","duration":"540.402666ms","start":"2026-04-22T00:59:43.685807Z","end":"2026-04-22T00:59:44.22621Z","steps":["trace[310842650] 'agreement among raft nodes before linearized reading' (duration: 540.339175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.957366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:44.226277Z","caller":"traceutil/trace.go:171","msg":"trace[922283125] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"204.985587ms","start":"2026-04-22T00:59:44.021287Z","end":"2026-04-22T00:59:44.226273Z","steps":["trace[922283125] 'agreement among raft nodes before linearized reading' (duration: 204.931856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.6858Z","time spent":"540.446457ms","remote":"127.0.0.1:45824","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-22T00:59:44.226214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.208143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:59:44.226311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.332505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:44.226326Z","caller":"traceutil/trace.go:171","msg":"trace[632516459] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"263.331045ms","start":"2026-04-22T00:59:43.962984Z","end":"2026-04-22T00:59:44.226315Z","steps":["trace[632516459] 'agreement among raft nodes before linearized reading' (duration: 263.210943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.777272ms","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-22T00:59:44.226348Z","caller":"traceutil/trace.go:171","msg":"trace[1537013105] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"263.399727ms","start":"2026-04-22T00:59:43.962936Z","end":"2026-04-22T00:59:44.226336Z","steps":["trace[1537013105] 'agreement among raft nodes before linearized reading' (duration: 263.352856ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.226368Z","caller":"traceutil/trace.go:171","msg":"trace[1695300091] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"205.805782ms","start":"2026-04-22T00:59:44.020558Z","end":"2026-04-22T00:59:44.226364Z","steps":["trace[1695300091] 'agreement among raft nodes before linearized reading' (duration: 205.777142ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.226217Z","caller":"traceutil/trace.go:171","msg":"trace[296054709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"319.927849ms","start":"2026-04-22T00:59:43.906277Z","end":"2026-04-22T00:59:44.226204Z","steps":["trace[296054709] 'agreement among raft nodes before linearized reading' (duration: 319.564311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.489828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T00:59:44.226446Z","caller":"traceutil/trace.go:171","msg":"trace[1651797791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"263.536059ms","start":"2026-04-22T00:59:43.962905Z","end":"2026-04-22T00:59:44.226441Z","steps":["trace[1651797791] 'agreement among raft nodes before linearized reading' (duration: 263.489458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.906262Z","time spent":"320.167275ms","remote":"127.0.0.1:46118","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-22T00:59:44.225674Z","caller":"traceutil/trace.go:171","msg":"trace[674354017] 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:624; }","duration":"293.150983ms","start":"2026-04-22T00:59:43.932502Z","end":"2026-04-22T00:59:44.225653Z","steps":["trace[674354017] 'agreement among raft nodes before linearized reading' (duration: 292.974629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.456208ms","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-22T00:59:44.226517Z","caller":"traceutil/trace.go:171","msg":"trace[2123053873] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"230.489258ms","start":"2026-04-22T00:59:43.996023Z","end":"2026-04-22T00:59:44.226512Z","steps":["trace[2123053873] 'agreement among raft nodes before linearized reading' (duration: 230.458788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.204493ms","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-22T00:59:44.225728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.90698Z","time spent":"318.742665ms","remote":"127.0.0.1:45862","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":"warn","ts":"2026-04-22T00:59:44.226428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.879875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:59:44.226621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.849275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:44.226627Z","caller":"traceutil/trace.go:171","msg":"trace[669244993] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"206.084238ms","start":"2026-04-22T00:59:44.02053Z","end":"2026-04-22T00:59:44.226614Z","steps":["trace[669244993] 'agreement among raft nodes before linearized reading' (duration: 205.884834ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.226638Z","caller":"traceutil/trace.go:171","msg":"trace[1771411254] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"241.884576ms","start":"2026-04-22T00:59:43.984749Z","end":"2026-04-22T00:59:44.226633Z","steps":["trace[1771411254] 'agreement among raft nodes before linearized reading' (duration: 241.861535ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.226574Z","caller":"traceutil/trace.go:171","msg":"trace[1785609453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"260.619271ms","start":"2026-04-22T00:59:43.965943Z","end":"2026-04-22T00:59:44.226562Z","steps":["trace[1785609453] 'agreement among raft nodes before linearized reading' (duration: 260.151622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.225634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.040904ms","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-22T00:59:44.226716Z","caller":"traceutil/trace.go:171","msg":"trace[851833259] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"115.203658ms","start":"2026-04-22T00:59:44.111507Z","end":"2026-04-22T00:59:44.226711Z","steps":["trace[851833259] 'agreement among raft nodes before linearized reading' (duration: 114.109716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.05485ms","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-22T00:59:44.226743Z","caller":"traceutil/trace.go:171","msg":"trace[1409790785] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"230.357066ms","start":"2026-04-22T00:59:43.996379Z","end":"2026-04-22T00:59:44.226736Z","steps":["trace[1409790785] 'agreement among raft nodes before linearized reading' (duration: 230.0577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.398866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:44.226791Z","caller":"traceutil/trace.go:171","msg":"trace[1174272264] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"230.720962ms","start":"2026-04-22T00:59:43.996058Z","end":"2026-04-22T00:59:44.226779Z","steps":["trace[1174272264] 'agreement among raft nodes before linearized reading' (duration: 230.399346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.226602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.070079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:44.226919Z","caller":"traceutil/trace.go:171","msg":"trace[780916858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"241.402286ms","start":"2026-04-22T00:59:43.985512Z","end":"2026-04-22T00:59:44.226914Z","steps":["trace[780916858] 'agreement among raft nodes before linearized reading' (duration: 241.07595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.227105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.304765ms","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":"warn","ts":"2026-04-22T00:59:44.2272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.738286ms","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-22T00:59:44.22722Z","caller":"traceutil/trace.go:171","msg":"trace[958203000] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"343.827408ms","start":"2026-04-22T00:59:43.883388Z","end":"2026-04-22T00:59:44.227215Z","steps":["trace[958203000] 'agreement among raft nodes before linearized reading' (duration: 343.796757ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:59:44.227152Z","caller":"traceutil/trace.go:171","msg":"trace[1334286198] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:624; }","duration":"568.355696ms","start":"2026-04-22T00:59:43.658785Z","end":"2026-04-22T00:59:44.227141Z","steps":["trace[1334286198] 'agreement among raft nodes before linearized reading' (duration: 568.214664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.227233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.883364Z","time spent":"343.865388ms","remote":"127.0.0.1:45850","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-22T00:59:44.227259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.658765Z","time spent":"568.481889ms","remote":"127.0.0.1:45816","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-22T00:59:44.227384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.003911ms","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-22T00:59:44.227411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.121501ms","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-22T00:59:44.227426Z","caller":"traceutil/trace.go:171","msg":"trace[649606691] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:624; }","duration":"542.150001ms","start":"2026-04-22T00:59:43.685272Z","end":"2026-04-22T00:59:44.227422Z","steps":["trace[649606691] 'agreement among raft nodes before linearized reading' (duration: 542.12412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.227491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.685265Z","time spent":"542.221743ms","remote":"127.0.0.1:45824","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":"info","ts":"2026-04-22T00:59:44.227417Z","caller":"traceutil/trace.go:171","msg":"trace[427782981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"344.086133ms","start":"2026-04-22T00:59:43.883323Z","end":"2026-04-22T00:59:44.227409Z","steps":["trace[427782981] 'agreement among raft nodes before linearized reading' (duration: 344.017191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.227585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.883308Z","time spent":"344.271347ms","remote":"127.0.0.1:45850","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-22T00:59:44.227468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.007333ms","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-22T00:59:44.227758Z","caller":"traceutil/trace.go:171","msg":"trace[1203980395] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"396.31947ms","start":"2026-04-22T00:59:43.83143Z","end":"2026-04-22T00:59:44.227749Z","steps":["trace[1203980395] 'agreement among raft nodes before linearized reading' (duration: 396.014073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:44.227777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.831421Z","time spent":"396.350291ms","remote":"127.0.0.1:45840","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-22T00:59:44.228753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.658431Z","time spent":"566.780035ms","remote":"127.0.0.1:45816","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":"warn","ts":"2026-04-22T00:59:44.229796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:43.830384Z","time spent":"399.398491ms","remote":"127.0.0.1:45840","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-22T00:59:46.015674Z","caller":"traceutil/trace.go:171","msg":"trace[251488293] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"240.801664ms","start":"2026-04-22T00:59:45.774843Z","end":"2026-04-22T00:59:46.015644Z","steps":["trace[251488293] 'read index received' (duration: 240.781774ms)","trace[251488293] 'applied index is now lower than readState.Index' (duration: 16.55µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:59:46.015678Z","caller":"traceutil/trace.go:171","msg":"trace[1352946671] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"278.462389ms","start":"2026-04-22T00:59:45.737188Z","end":"2026-04-22T00:59:46.01565Z","steps":["trace[1352946671] 'process raft request' (duration: 278.334507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:46.015886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.014049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:46.015919Z","caller":"traceutil/trace.go:171","msg":"trace[2102628475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"241.11826ms","start":"2026-04-22T00:59:45.77479Z","end":"2026-04-22T00:59:46.015908Z","steps":["trace[2102628475] 'agreement among raft nodes before linearized reading' (duration: 240.949167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:59.345204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.583262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:59:59.345321Z","caller":"traceutil/trace.go:171","msg":"trace[980433347] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"570.760735ms","start":"2026-04-22T00:59:58.774541Z","end":"2026-04-22T00:59:59.345302Z","steps":["trace[980433347] 'range keys from in-memory index tree' (duration: 570.446589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:59:59.345365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:59:58.774522Z","time spent":"570.833846ms","remote":"127.0.0.1:45884","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-22T01:00:34.108049Z","caller":"traceutil/trace.go:171","msg":"trace[52095594] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"327.887414ms","start":"2026-04-22T01:00:33.780143Z","end":"2026-04-22T01:00:34.108031Z","steps":["trace[52095594] 'process raft request' (duration: 327.772222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:34.108193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:33.780123Z","time spent":"327.988307ms","remote":"127.0.0.1:46118","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-22T01:00:35.007212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.472322ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T01:00:35.00744Z","caller":"traceutil/trace.go:171","msg":"trace[1881337193] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1039; }","duration":"543.382814ms","start":"2026-04-22T01:00:34.464039Z","end":"2026-04-22T01:00:35.007422Z","steps":["trace[1881337193] 'read index received' (duration: 56.546555ms)","trace[1881337193] 'applied index is now lower than readState.Index' (duration: 486.835239ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:00:35.007488Z","caller":"traceutil/trace.go:171","msg":"trace[1620982149] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"1.186357715s","start":"2026-04-22T01:00:33.82109Z","end":"2026-04-22T01:00:35.007447Z","steps":["trace[1620982149] 'process raft request' (duration: 1.186221853s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:35.007616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.570868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-22T01:00:35.007624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.057648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-22T01:00:35.007631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:33.821067Z","time spent":"1.186490188s","remote":"127.0.0.1:46118","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-22T01:00:35.007633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.167035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T01:00:35.007661Z","caller":"traceutil/trace.go:171","msg":"trace[1763888170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1004; }","duration":"543.66106ms","start":"2026-04-22T01:00:34.463992Z","end":"2026-04-22T01:00:35.007653Z","steps":["trace[1763888170] 'agreement among raft nodes before linearized reading' (duration: 543.522036ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:00:35.007673Z","caller":"traceutil/trace.go:171","msg":"trace[884548704] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1004; }","duration":"114.18173ms","start":"2026-04-22T01:00:34.893479Z","end":"2026-04-22T01:00:35.007661Z","steps":["trace[884548704] 'agreement among raft nodes before linearized reading' (duration: 114.090628ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:00:35.007698Z","caller":"traceutil/trace.go:171","msg":"trace[2116146909] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1004; }","duration":"132.284527ms","start":"2026-04-22T01:00:34.875402Z","end":"2026-04-22T01:00:35.007686Z","steps":["trace[2116146909] 'agreement among raft nodes before linearized reading' (duration: 132.166145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:35.007697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.064471ms","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-22T01:00:35.007705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:34.46397Z","time spent":"543.726831ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T01:00:35.007695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.580884ms","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-22T01:00:35.007735Z","caller":"traceutil/trace.go:171","msg":"trace[1955657946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1004; }","duration":"533.120923ms","start":"2026-04-22T01:00:34.474604Z","end":"2026-04-22T01:00:35.007725Z","steps":["trace[1955657946] 'agreement among raft nodes before linearized reading' (duration: 533.017581ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:00:35.00775Z","caller":"traceutil/trace.go:171","msg":"trace[707193043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1004; }","duration":"538.658396ms","start":"2026-04-22T01:00:34.469079Z","end":"2026-04-22T01:00:35.007737Z","steps":["trace[707193043] 'agreement among raft nodes before linearized reading' (duration: 538.483473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:35.00776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:34.474595Z","time spent":"533.158374ms","remote":"127.0.0.1:46118","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-22T01:00:35.007783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:34.469069Z","time spent":"538.706577ms","remote":"127.0.0.1:46118","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-22T01:00:35.007788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.396128ms","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-22T01:00:35.007861Z","caller":"traceutil/trace.go:171","msg":"trace[1268214289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1004; }","duration":"533.498189ms","start":"2026-04-22T01:00:34.474344Z","end":"2026-04-22T01:00:35.007842Z","steps":["trace[1268214289] 'agreement among raft nodes before linearized reading' (duration: 533.273735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:35.007902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:34.474334Z","time spent":"533.559981ms","remote":"127.0.0.1:46118","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-22T01:00:56.342282Z","caller":"traceutil/trace.go:171","msg":"trace[1434455393] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"125.349758ms","start":"2026-04-22T01:00:56.216888Z","end":"2026-04-22T01:00:56.342238Z","steps":["trace[1434455393] 'process raft request' (duration: 125.166724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:57.621544Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512982148098544,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T01:00:58.041241Z","caller":"traceutil/trace.go:171","msg":"trace[78109433] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1116; }","duration":"920.483438ms","start":"2026-04-22T01:00:57.12073Z","end":"2026-04-22T01:00:58.041213Z","steps":["trace[78109433] 'read index received' (duration: 920.311384ms)","trace[78109433] 'applied index is now lower than readState.Index' (duration: 171.174µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:00:58.041363Z","caller":"traceutil/trace.go:171","msg":"trace[251750947] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"964.159702ms","start":"2026-04-22T01:00:57.077191Z","end":"2026-04-22T01:00:58.041351Z","steps":["trace[251750947] 'process raft request' (duration: 963.864856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:58.04166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:57.077146Z","time spent":"964.295965ms","remote":"127.0.0.1:46118","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-22T01:00:58.041706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.101604ms","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-22T01:00:58.041756Z","caller":"traceutil/trace.go:171","msg":"trace[1863268696] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1076; }","duration":"917.178586ms","start":"2026-04-22T01:00:57.124564Z","end":"2026-04-22T01:00:58.041742Z","steps":["trace[1863268696] 'agreement among raft nodes before linearized reading' (duration: 916.998113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:58.041788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:57.124552Z","time spent":"917.228587ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T01:00:58.041808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.62629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T01:00:58.041908Z","caller":"traceutil/trace.go:171","msg":"trace[627310945] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1076; }","duration":"490.796615ms","start":"2026-04-22T01:00:57.551084Z","end":"2026-04-22T01:00:58.041881Z","steps":["trace[627310945] 'agreement among raft nodes before linearized reading' (duration: 490.569231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:58.041935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.073089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-22T01:00:58.041975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:57.551064Z","time spent":"490.890146ms","remote":"127.0.0.1:46228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"warn","ts":"2026-04-22T01:00:58.042077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.920011ms","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-22T01:00:58.042105Z","caller":"traceutil/trace.go:171","msg":"trace[648754529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1076; }","duration":"917.99987ms","start":"2026-04-22T01:00:57.124098Z","end":"2026-04-22T01:00:58.042098Z","steps":["trace[648754529] 'agreement among raft nodes before linearized reading' (duration: 917.912829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:58.042137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:57.124083Z","time spent":"918.047111ms","remote":"127.0.0.1:46118","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-22T01:00:58.041983Z","caller":"traceutil/trace.go:171","msg":"trace[1643167153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1076; }","duration":"913.13885ms","start":"2026-04-22T01:00:57.128829Z","end":"2026-04-22T01:00:58.041968Z","steps":["trace[1643167153] 'agreement among raft nodes before linearized reading' (duration: 913.046458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:58.042285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.524017ms","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-22T01:00:58.042398Z","caller":"traceutil/trace.go:171","msg":"trace[1477213568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1076; }","duration":"921.701369ms","start":"2026-04-22T01:00:57.120673Z","end":"2026-04-22T01:00:58.042375Z","steps":["trace[1477213568] 'agreement among raft nodes before linearized reading' (duration: 921.336393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:58.042409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.934388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T01:00:58.042345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:57.128792Z","time spent":"913.532858ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T01:00:58.042466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:57.120651Z","time spent":"921.804372ms","remote":"127.0.0.1:46118","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":"info","ts":"2026-04-22T01:00:58.042461Z","caller":"traceutil/trace.go:171","msg":"trace[1307551980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1076; }","duration":"267.01165ms","start":"2026-04-22T01:00:57.775432Z","end":"2026-04-22T01:00:58.042443Z","steps":["trace[1307551980] 'agreement among raft nodes before linearized reading' (duration: 266.948239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:59.639673Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512982148098563,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T01:00:59.830434Z","caller":"traceutil/trace.go:171","msg":"trace[571529108] linearizableReadLoop","detail":"{readStateIndex:1125; appliedIndex:1124; }","duration":"691.742801ms","start":"2026-04-22T01:00:59.138665Z","end":"2026-04-22T01:00:59.830364Z","steps":["trace[571529108] 'read index received' (duration: 691.458316ms)","trace[571529108] 'applied index is now lower than readState.Index' (duration: 239.984µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:00:59.830495Z","caller":"traceutil/trace.go:171","msg":"trace[2461148] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"845.156332ms","start":"2026-04-22T01:00:58.98529Z","end":"2026-04-22T01:00:59.830446Z","steps":["trace[2461148] 'process raft request' (duration: 844.906297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:59.830656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.953301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T01:00:59.830699Z","caller":"traceutil/trace.go:171","msg":"trace[985984810] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1083; }","duration":"488.050013ms","start":"2026-04-22T01:00:59.342636Z","end":"2026-04-22T01:00:59.830686Z","steps":["trace[985984810] 'agreement among raft nodes before linearized reading' (duration: 487.927671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:59.830681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.010536ms","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":"warn","ts":"2026-04-22T01:00:59.830738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:59.342621Z","time spent":"488.106694ms","remote":"127.0.0.1:46068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-22T01:00:59.830739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:58.985264Z","time spent":"845.334975ms","remote":"127.0.0.1:46118","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-22T01:00:59.830766Z","caller":"traceutil/trace.go:171","msg":"trace[1284604279] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1083; }","duration":"692.153959ms","start":"2026-04-22T01:00:59.138592Z","end":"2026-04-22T01:00:59.830746Z","steps":["trace[1284604279] 'agreement among raft nodes before linearized reading' (duration: 691.967916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:00:59.830894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:00:59.138571Z","time spent":"692.307582ms","remote":"127.0.0.1:45888","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":"warn","ts":"2026-04-22T01:00:59.831002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.913149ms","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-22T01:00:59.831071Z","caller":"traceutil/trace.go:171","msg":"trace[1782793567] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1083; }","duration":"244.04038ms","start":"2026-04-22T01:00:59.587013Z","end":"2026-04-22T01:00:59.831053Z","steps":["trace[1782793567] 'agreement among raft nodes before linearized reading' (duration: 243.893768ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:00.148254Z","caller":"traceutil/trace.go:171","msg":"trace[192219738] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"100.532165ms","start":"2026-04-22T01:01:00.047697Z","end":"2026-04-22T01:01:00.148229Z","steps":["trace[192219738] 'process raft request' (duration: 100.343871ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:08.620917Z","caller":"traceutil/trace.go:171","msg":"trace[1019035795] linearizableReadLoop","detail":"{readStateIndex:1157; appliedIndex:1156; }","duration":"152.853851ms","start":"2026-04-22T01:01:08.468045Z","end":"2026-04-22T01:01:08.620899Z","steps":["trace[1019035795] 'read index received' (duration: 152.670748ms)","trace[1019035795] 'applied index is now lower than readState.Index' (duration: 182.263µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:08.621041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.977383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T01:01:08.621004Z","caller":"traceutil/trace.go:171","msg":"trace[499487037] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"196.75224ms","start":"2026-04-22T01:01:08.424199Z","end":"2026-04-22T01:01:08.620951Z","steps":["trace[499487037] 'process raft request' (duration: 196.589687ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:08.621076Z","caller":"traceutil/trace.go:171","msg":"trace[1182579054] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1114; }","duration":"153.061664ms","start":"2026-04-22T01:01:08.468004Z","end":"2026-04-22T01:01:08.621065Z","steps":["trace[1182579054] 'agreement among raft nodes before linearized reading' (duration: 152.989493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:08.62136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.129998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-22T01:01:08.621448Z","caller":"traceutil/trace.go:171","msg":"trace[1338832683] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:1114; }","duration":"137.23767ms","start":"2026-04-22T01:01:08.48419Z","end":"2026-04-22T01:01:08.621428Z","steps":["trace[1338832683] 'agreement among raft nodes before linearized reading' (duration: 137.004245ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:12.447008Z","caller":"traceutil/trace.go:171","msg":"trace[10131547] linearizableReadLoop","detail":"{readStateIndex:1221; appliedIndex:1220; }","duration":"155.426209ms","start":"2026-04-22T01:01:12.29156Z","end":"2026-04-22T01:01:12.446987Z","steps":["trace[10131547] 'read index received' (duration: 141.096882ms)","trace[10131547] 'applied index is now lower than readState.Index' (duration: 14.328147ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:01:12.447114Z","caller":"traceutil/trace.go:171","msg":"trace[1034687400] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"205.41166ms","start":"2026-04-22T01:01:12.241687Z","end":"2026-04-22T01:01:12.447099Z","steps":["trace[1034687400] 'process raft request' (duration: 190.93226ms)","trace[1034687400] 'compare' (duration: 14.075123ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:12.447329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.771766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-22T01:01:12.447296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.788867ms","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-22T01:01:12.44738Z","caller":"traceutil/trace.go:171","msg":"trace[962468400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1175; }","duration":"155.840167ms","start":"2026-04-22T01:01:12.291526Z","end":"2026-04-22T01:01:12.447366Z","steps":["trace[962468400] 'agreement among raft nodes before linearized reading' (duration: 155.755895ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:12.447408Z","caller":"traceutil/trace.go:171","msg":"trace[1224697945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1175; }","duration":"154.908939ms","start":"2026-04-22T01:01:12.292466Z","end":"2026-04-22T01:01:12.447375Z","steps":["trace[1224697945] 'agreement among raft nodes before linearized reading' (duration: 154.712085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:12.447507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.975771ms","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-22T01:01:12.447545Z","caller":"traceutil/trace.go:171","msg":"trace[1004868623] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1175; }","duration":"154.092164ms","start":"2026-04-22T01:01:12.293443Z","end":"2026-04-22T01:01:12.447535Z","steps":["trace[1004868623] 'agreement among raft nodes before linearized reading' (duration: 153.920601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:14.514022Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512982148098777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T01:01:15.01444Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512982148098777,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T01:01:15.312761Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.478377282s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-22T01:01:16.361872Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.04875595s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-22T01:01:16.362747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049649917s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T01:01:16.363321Z","caller":"traceutil/trace.go:171","msg":"trace[2133055509] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1226; }","duration":"2.35009861s","start":"2026-04-22T01:01:14.01319Z","end":"2026-04-22T01:01:16.363288Z","steps":["trace[2133055509] 'read index received' (duration: 1.299985795s)","trace[2133055509] 'applied index is now lower than readState.Index' (duration: 1.050111165s)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:01:16.363359Z","caller":"traceutil/trace.go:171","msg":"trace[2081062610] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"2.120437417s","start":"2026-04-22T01:01:14.242892Z","end":"2026-04-22T01:01:16.363329Z","steps":["trace[2081062610] 'process raft request' (duration: 2.120019249s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:16.363502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.350270853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-22T01:01:16.363502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:14.242873Z","time spent":"2.120550079s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T01:01:16.363576Z","caller":"traceutil/trace.go:171","msg":"trace[1007342672] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1181; }","duration":"2.350390416s","start":"2026-04-22T01:01:14.013144Z","end":"2026-04-22T01:01:16.363534Z","steps":["trace[1007342672] 'agreement among raft nodes before linearized reading' (duration: 2.350265023s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:16.363625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:14.013113Z","time spent":"2.350499467s","remote":"127.0.0.1:46048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":13,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-04-22T01:01:16.363687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.912745653s","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-22T01:01:16.363745Z","caller":"traceutil/trace.go:171","msg":"trace[1917232831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1181; }","duration":"1.912857595s","start":"2026-04-22T01:01:14.450871Z","end":"2026-04-22T01:01:16.363729Z","steps":["trace[1917232831] 'agreement among raft nodes before linearized reading' (duration: 1.912636761s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:16.36379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:14.45085Z","time spent":"1.912928106s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T01:01:16.363817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.31903762s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T01:01:16.363871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.589714588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T01:01:16.363908Z","caller":"traceutil/trace.go:171","msg":"trace[2034494635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1181; }","duration":"1.589749918s","start":"2026-04-22T01:01:14.774147Z","end":"2026-04-22T01:01:16.363897Z","steps":["trace[2034494635] 'agreement among raft nodes before linearized reading' (duration: 1.589677407s)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:16.363869Z","caller":"traceutil/trace.go:171","msg":"trace[86032965] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1181; }","duration":"1.319129501s","start":"2026-04-22T01:01:15.044722Z","end":"2026-04-22T01:01:16.363852Z","steps":["trace[86032965] 'agreement among raft nodes before linearized reading' (duration: 1.31906048s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:16.363936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:14.774103Z","time spent":"1.589827731s","remote":"127.0.0.1:45884","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-22T01:01:16.364004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:15.044701Z","time spent":"1.319282225s","remote":"127.0.0.1:46084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-22T01:01:16.364099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.904115362s","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-22T01:01:16.364144Z","caller":"traceutil/trace.go:171","msg":"trace[916189899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1181; }","duration":"1.904187413s","start":"2026-04-22T01:01:14.459943Z","end":"2026-04-22T01:01:16.364131Z","steps":["trace[916189899] 'agreement among raft nodes before linearized reading' (duration: 1.904059621s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:16.363737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.71366043s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-22T01:01:16.364182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:14.459928Z","time spent":"1.904244004s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-22T01:01:16.364247Z","caller":"traceutil/trace.go:171","msg":"trace[698376935] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1181; }","duration":"1.71419794s","start":"2026-04-22T01:01:14.650022Z","end":"2026-04-22T01:01:16.36422Z","steps":["trace[698376935] 'agreement among raft nodes before linearized reading' (duration: 1.71361657s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:16.364316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.905285115s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-22T01:01:16.364321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.906439145s","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-22T01:01:16.364349Z","caller":"traceutil/trace.go:171","msg":"trace[605785575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1181; }","duration":"1.905334785s","start":"2026-04-22T01:01:14.459005Z","end":"2026-04-22T01:01:16.36434Z","steps":["trace[605785575] 'agreement among raft nodes before linearized reading' (duration: 1.905184342s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:16.364344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:14.649991Z","time spent":"1.714319432s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T01:01:16.36438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:14.458996Z","time spent":"1.905377836s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-22T01:01:16.364391Z","caller":"traceutil/trace.go:171","msg":"trace[964989851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1181; }","duration":"1.906552887s","start":"2026-04-22T01:01:14.457812Z","end":"2026-04-22T01:01:16.364365Z","steps":["trace[964989851] 'agreement among raft nodes before linearized reading' (duration: 1.906242921s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:16.364446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:14.4578Z","time spent":"1.906635788s","remote":"127.0.0.1:46118","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-22T01:01:33.855143Z","caller":"traceutil/trace.go:171","msg":"trace[404773783] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"310.516816ms","start":"2026-04-22T01:01:33.54461Z","end":"2026-04-22T01:01:33.855126Z","steps":["trace[404773783] 'process raft request' (duration: 310.404424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:33.855784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:33.54459Z","time spent":"311.140548ms","remote":"127.0.0.1:46044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5456,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T01:01:34.154418Z","caller":"traceutil/trace.go:171","msg":"trace[967868639] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"292.980641ms","start":"2026-04-22T01:01:33.861409Z","end":"2026-04-22T01:01:34.15439Z","steps":["trace[967868639] 'process raft request' (duration: 209.684264ms)","trace[967868639] 'compare' (duration: 83.198805ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:34.723689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.655199ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T01:01:34.736856Z","caller":"traceutil/trace.go:171","msg":"trace[640325181] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1310; }","duration":"292.469672ms","start":"2026-04-22T01:01:34.444367Z","end":"2026-04-22T01:01:34.736837Z","steps":["trace[640325181] 'read index received' (duration: 114.6736ms)","trace[640325181] 'applied index is now lower than readState.Index' (duration: 177.795072ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:01:34.736975Z","caller":"traceutil/trace.go:171","msg":"trace[149138808] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"305.022015ms","start":"2026-04-22T01:01:34.431927Z","end":"2026-04-22T01:01:34.736949Z","steps":["trace[149138808] 'process raft request' (duration: 304.781441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:34.737055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.681866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-22T01:01:34.73707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.847338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T01:01:34.737089Z","caller":"traceutil/trace.go:171","msg":"trace[2106776568] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1261; }","duration":"292.91698ms","start":"2026-04-22T01:01:34.444162Z","end":"2026-04-22T01:01:34.737078Z","steps":["trace[2106776568] 'agreement among raft nodes before linearized reading' (duration: 292.790777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:34.737117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:34.431911Z","time spent":"305.133877ms","remote":"127.0.0.1:46118","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-22T01:01:34.737249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.043473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-22T01:01:34.737277Z","caller":"traceutil/trace.go:171","msg":"trace[2046652100] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1261; }","duration":"223.112264ms","start":"2026-04-22T01:01:34.51416Z","end":"2026-04-22T01:01:34.737272Z","steps":["trace[2046652100] 'agreement among raft nodes before linearized reading' (duration: 223.052262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:34.737352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.187485ms","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-22T01:01:34.737373Z","caller":"traceutil/trace.go:171","msg":"trace[54161829] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1261; }","duration":"223.242387ms","start":"2026-04-22T01:01:34.514125Z","end":"2026-04-22T01:01:34.737368Z","steps":["trace[54161829] 'agreement among raft nodes before linearized reading' (duration: 223.190376ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:34.737099Z","caller":"traceutil/trace.go:171","msg":"trace[198953570] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1261; }","duration":"250.877259ms","start":"2026-04-22T01:01:34.486213Z","end":"2026-04-22T01:01:34.737091Z","steps":["trace[198953570] 'agreement among raft nodes before linearized reading' (duration: 250.802837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:34.737511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.37387ms","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-22T01:01:34.737575Z","caller":"traceutil/trace.go:171","msg":"trace[1081813055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1261; }","duration":"243.476012ms","start":"2026-04-22T01:01:34.494084Z","end":"2026-04-22T01:01:34.73756Z","steps":["trace[1081813055] 'agreement among raft nodes before linearized reading' (duration: 243.32825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:34.91557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.235393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T01:01:34.91586Z","caller":"traceutil/trace.go:171","msg":"trace[1578170786] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"174.114473ms","start":"2026-04-22T01:01:34.74172Z","end":"2026-04-22T01:01:34.915835Z","steps":["trace[1578170786] 'process raft request' (duration: 173.94771ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:34.915962Z","caller":"traceutil/trace.go:171","msg":"trace[1873094321] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"174.190725ms","start":"2026-04-22T01:01:34.741758Z","end":"2026-04-22T01:01:34.915948Z","steps":["trace[1873094321] 'process raft request' (duration: 173.95ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:34.91604Z","caller":"traceutil/trace.go:171","msg":"trace[2017842352] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"174.49414ms","start":"2026-04-22T01:01:34.741518Z","end":"2026-04-22T01:01:34.916012Z","steps":["trace[2017842352] 'process raft request' (duration: 60.752298ms)","trace[2017842352] 'compare' (duration: 113.123011ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:01:34.91622Z","caller":"traceutil/trace.go:171","msg":"trace[1267081444] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1312; }","duration":"139.435259ms","start":"2026-04-22T01:01:34.776776Z","end":"2026-04-22T01:01:34.916211Z","steps":["trace[1267081444] 'read index received' (duration: 25.541415ms)","trace[1267081444] 'applied index is now lower than readState.Index' (duration: 113.893354ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:01:34.916269Z","caller":"traceutil/trace.go:171","msg":"trace[191266737] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"174.274456ms","start":"2026-04-22T01:01:34.741963Z","end":"2026-04-22T01:01:34.916238Z","steps":["trace[191266737] 'process raft request' (duration: 173.94922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:34.916279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.50118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T01:01:34.916342Z","caller":"traceutil/trace.go:171","msg":"trace[566992977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"139.566202ms","start":"2026-04-22T01:01:34.77677Z","end":"2026-04-22T01:01:34.916336Z","steps":["trace[566992977] 'agreement among raft nodes before linearized reading' (duration: 139.47637ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:34.916192Z","caller":"traceutil/trace.go:171","msg":"trace[14127852] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"174.386018ms","start":"2026-04-22T01:01:34.741785Z","end":"2026-04-22T01:01:34.916171Z","steps":["trace[14127852] 'process raft request' (duration: 173.94941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:36.952467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.721861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T01:01:36.952507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.533427ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T01:01:36.952547Z","caller":"traceutil/trace.go:171","msg":"trace[119443528] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1268; }","duration":"226.838313ms","start":"2026-04-22T01:01:36.725692Z","end":"2026-04-22T01:01:36.952531Z","steps":["trace[119443528] 'range keys from in-memory index tree' (duration: 226.66557ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:36.952604Z","caller":"traceutil/trace.go:171","msg":"trace[1989791596] linearizableReadLoop","detail":"{readStateIndex:1320; appliedIndex:1319; }","duration":"176.875345ms","start":"2026-04-22T01:01:36.775682Z","end":"2026-04-22T01:01:36.952557Z","steps":["trace[1989791596] 'read index received' (duration: 48.241426ms)","trace[1989791596] 'applied index is now lower than readState.Index' (duration: 128.633209ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:36.952673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.997198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T01:01:36.952716Z","caller":"traceutil/trace.go:171","msg":"trace[497496700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1269; }","duration":"177.068149ms","start":"2026-04-22T01:01:36.775638Z","end":"2026-04-22T01:01:36.952706Z","steps":["trace[497496700] 'agreement among raft nodes before linearized reading' (duration: 176.996668ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:36.952683Z","caller":"traceutil/trace.go:171","msg":"trace[1693651215] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"210.197964ms","start":"2026-04-22T01:01:36.742405Z","end":"2026-04-22T01:01:36.952603Z","steps":["trace[1693651215] 'process raft request' (duration: 81.512054ms)","trace[1693651215] 'compare' (duration: 128.434126ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:37.420764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.669542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T01:01:37.421043Z","caller":"traceutil/trace.go:171","msg":"trace[1914177561] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"462.791054ms","start":"2026-04-22T01:01:36.958234Z","end":"2026-04-22T01:01:37.421025Z","steps":["trace[1914177561] 'process raft request' (duration: 111.787676ms)","trace[1914177561] 'compare' (duration: 350.368626ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:37.421103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:36.958222Z","time spent":"462.850375ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T01:01:38.184859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.041961ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T01:01:38.185048Z","caller":"traceutil/trace.go:171","msg":"trace[157492865] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"1.226700611s","start":"2026-04-22T01:01:36.958329Z","end":"2026-04-22T01:01:38.185029Z","steps":["trace[157492865] 'process raft request' (duration: 576.411455ms)","trace[157492865] 'compare' (duration: 649.514921ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:38.185399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:36.958308Z","time spent":"1.227040847s","remote":"127.0.0.1:46118","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-22T01:01:38.185442Z","caller":"traceutil/trace.go:171","msg":"trace[1016588122] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"1.227037727s","start":"2026-04-22T01:01:36.958375Z","end":"2026-04-22T01:01:38.185413Z","steps":["trace[1016588122] 'process raft request' (duration: 1.22663513s)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:38.18553Z","caller":"traceutil/trace.go:171","msg":"trace[468883804] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"1.227013916s","start":"2026-04-22T01:01:36.958424Z","end":"2026-04-22T01:01:38.185438Z","steps":["trace[468883804] 'process raft request' (duration: 1.226931475s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:38.185584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:36.958347Z","time spent":"1.227155318s","remote":"127.0.0.1:46118","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-22T01:01:38.185719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:36.958397Z","time spent":"1.22722731s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T01:01:38.185741Z","caller":"traceutil/trace.go:171","msg":"trace[1344365843] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"1.224779954s","start":"2026-04-22T01:01:36.960941Z","end":"2026-04-22T01:01:38.18572Z","steps":["trace[1344365843] 'process raft request' (duration: 1.224629322s)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:38.185803Z","caller":"traceutil/trace.go:171","msg":"trace[356897859] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1321; }","duration":"879.393601ms","start":"2026-04-22T01:01:37.306386Z","end":"2026-04-22T01:01:38.18578Z","steps":["trace[356897859] 'read index received' (duration: 228.443862ms)","trace[356897859] 'applied index is now lower than readState.Index' (duration: 650.947389ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:01:38.185813Z","caller":"traceutil/trace.go:171","msg":"trace[1029681649] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"879.401711ms","start":"2026-04-22T01:01:37.306387Z","end":"2026-04-22T01:01:38.185789Z","steps":["trace[1029681649] 'process raft request' (duration: 879.328839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:38.185936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.536924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T01:01:38.185935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:36.960929Z","time spent":"1.224908847s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T01:01:38.185995Z","caller":"traceutil/trace.go:171","msg":"trace[743884710] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1276; }","duration":"879.634146ms","start":"2026-04-22T01:01:37.306345Z","end":"2026-04-22T01:01:38.185979Z","steps":["trace[743884710] 'agreement among raft nodes before linearized reading' (duration: 879.509874ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:38.185716Z","caller":"traceutil/trace.go:171","msg":"trace[655773639] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"1.225656561s","start":"2026-04-22T01:01:36.960027Z","end":"2026-04-22T01:01:38.185683Z","steps":["trace[655773639] 'process raft request' (duration: 1.225374216s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:38.18605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:37.306326Z","time spent":"879.710127ms","remote":"127.0.0.1:38682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-04-22T01:01:38.186098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:36.960013Z","time spent":"1.226033488s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T01:01:38.186063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:37.306362Z","time spent":"879.545795ms","remote":"127.0.0.1:45946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T01:01:38.525631Z","caller":"traceutil/trace.go:171","msg":"trace[1934323623] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"334.170466ms","start":"2026-04-22T01:01:38.191433Z","end":"2026-04-22T01:01:38.525603Z","steps":["trace[1934323623] 'process raft request' (duration: 333.992233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:38.525795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:38.191411Z","time spent":"334.293128ms","remote":"127.0.0.1:45946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T01:01:38.822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.892659ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T01:01:38.822108Z","caller":"traceutil/trace.go:171","msg":"trace[197502967] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1327; }","duration":"629.807157ms","start":"2026-04-22T01:01:38.192277Z","end":"2026-04-22T01:01:38.822084Z","steps":["trace[197502967] 'read index received' (duration: 333.099737ms)","trace[197502967] 'applied index is now lower than readState.Index' (duration: 296.70572ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:01:38.822355Z","caller":"traceutil/trace.go:171","msg":"trace[488410218] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"630.114362ms","start":"2026-04-22T01:01:38.191993Z","end":"2026-04-22T01:01:38.822108Z","steps":["trace[488410218] 'process raft request' (duration: 519.02535ms)","trace[488410218] 'compare' (duration: 110.716956ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:38.822392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.861543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T01:01:38.822494Z","caller":"traceutil/trace.go:171","msg":"trace[273587764] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1278; }","duration":"604.970275ms","start":"2026-04-22T01:01:38.21751Z","end":"2026-04-22T01:01:38.82248Z","steps":["trace[273587764] 'agreement among raft nodes before linearized reading' (duration: 604.835033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:38.822676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:38.217466Z","time spent":"605.196209ms","remote":"127.0.0.1:50908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-04-22T01:01:38.822859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.091671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-22T01:01:38.822647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:38.191975Z","time spent":"630.484709ms","remote":"127.0.0.1:45946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T01:01:38.822905Z","caller":"traceutil/trace.go:171","msg":"trace[745698907] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:1278; }","duration":"337.175241ms","start":"2026-04-22T01:01:38.485718Z","end":"2026-04-22T01:01:38.822894Z","steps":["trace[745698907] 'agreement among raft nodes before linearized reading' (duration: 337.051728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:38.82238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.087752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-04-22T01:01:38.822938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:38.485701Z","time spent":"337.229673ms","remote":"127.0.0.1:45906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"info","ts":"2026-04-22T01:01:38.823186Z","caller":"traceutil/trace.go:171","msg":"trace[1427125410] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1278; }","duration":"630.703844ms","start":"2026-04-22T01:01:38.192273Z","end":"2026-04-22T01:01:38.822977Z","steps":["trace[1427125410] 'agreement among raft nodes before linearized reading' (duration: 629.913499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:38.823255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:38.192245Z","time spent":"630.99029ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-22T01:01:39.257885Z","caller":"traceutil/trace.go:171","msg":"trace[1541452531] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"397.029413ms","start":"2026-04-22T01:01:38.860829Z","end":"2026-04-22T01:01:39.257858Z","steps":["trace[1541452531] 'process raft request' (duration: 300.213114ms)","trace[1541452531] 'compare' (duration: 96.457723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:39.257993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:38.86081Z","time spent":"397.130565ms","remote":"127.0.0.1:45906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T01:01:39.323762Z","caller":"traceutil/trace.go:171","msg":"trace[164388679] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"365.528058ms","start":"2026-04-22T01:01:38.958212Z","end":"2026-04-22T01:01:39.323741Z","steps":["trace[164388679] 'process raft request' (duration: 365.272464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:39.323869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:38.958191Z","time spent":"365.62654ms","remote":"127.0.0.1:46118","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-22T01:01:44.000842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.293685ms","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-22T01:01:44.001125Z","caller":"traceutil/trace.go:171","msg":"trace[2137498864] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1323; }","duration":"560.631622ms","start":"2026-04-22T01:01:43.440476Z","end":"2026-04-22T01:01:44.001107Z","steps":["trace[2137498864] 'range keys from in-memory index tree' (duration: 560.154213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.001272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:43.440457Z","time spent":"560.802575ms","remote":"127.0.0.1:46118","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-22T01:01:44.911982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.827101ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T01:01:44.912194Z","caller":"traceutil/trace.go:171","msg":"trace[282742825] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"1.002237933s","start":"2026-04-22T01:01:43.909936Z","end":"2026-04-22T01:01:44.912174Z","steps":["trace[282742825] 'read index received' (duration: 82.145035ms)","trace[282742825] 'applied index is now lower than readState.Index' (duration: 920.091838ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T01:01:44.912381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002440277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-22T01:01:44.912415Z","caller":"traceutil/trace.go:171","msg":"trace[2053874094] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1323; }","duration":"1.002508608s","start":"2026-04-22T01:01:43.909896Z","end":"2026-04-22T01:01:44.912405Z","steps":["trace[2053874094] 'agreement among raft nodes before linearized reading' (duration: 1.002381986s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.912448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:43.909877Z","time spent":"1.002563609s","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-22T01:01:44.912425Z","caller":"traceutil/trace.go:171","msg":"trace[804499878] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"907.326729ms","start":"2026-04-22T01:01:44.005065Z","end":"2026-04-22T01:01:44.912392Z","steps":["trace[804499878] 'process raft request' (duration: 907.014544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.912551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:44.005049Z","time spent":"907.436442ms","remote":"127.0.0.1:46118","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-22T01:01:44.961447Z","caller":"traceutil/trace.go:171","msg":"trace[1590175605] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"670.695767ms","start":"2026-04-22T01:01:44.290724Z","end":"2026-04-22T01:01:44.96142Z","steps":["trace[1590175605] 'process raft request' (duration: 670.389291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.961581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.579377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-m5mc5\" ","response":"range_response_count:1 size:12641"} {"level":"warn","ts":"2026-04-22T01:01:44.961592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:44.290691Z","time spent":"670.831878ms","remote":"127.0.0.1:46044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6319,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T01:01:44.961605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.053696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T01:01:44.961696Z","caller":"traceutil/trace.go:171","msg":"trace[1893000912] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1325; }","duration":"717.171789ms","start":"2026-04-22T01:01:44.244505Z","end":"2026-04-22T01:01:44.961677Z","steps":["trace[1893000912] 'agreement among raft nodes before linearized reading' (duration: 716.948975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.961697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.290311ms","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-22T01:01:44.96175Z","caller":"traceutil/trace.go:171","msg":"trace[1626126084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1325; }","duration":"717.383452ms","start":"2026-04-22T01:01:44.244355Z","end":"2026-04-22T01:01:44.961738Z","steps":["trace[1626126084] 'agreement among raft nodes before linearized reading' (duration: 717.26233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.961794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:44.244336Z","time spent":"717.449414ms","remote":"127.0.0.1:46118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T01:01:44.961839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.769688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T01:01:44.961871Z","caller":"traceutil/trace.go:171","msg":"trace[289729843] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1325; }","duration":"186.801218ms","start":"2026-04-22T01:01:44.775061Z","end":"2026-04-22T01:01:44.961862Z","steps":["trace[289729843] 'agreement among raft nodes before linearized reading' (duration: 186.756118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.961845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:44.244499Z","time spent":"717.24345ms","remote":"127.0.0.1:46118","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-22T01:01:44.961971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.064757ms","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-22T01:01:44.961643Z","caller":"traceutil/trace.go:171","msg":"trace[1787627032] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-m5mc5; range_end:; response_count:1; response_revision:1325; }","duration":"605.660249ms","start":"2026-04-22T01:01:44.355956Z","end":"2026-04-22T01:01:44.961616Z","steps":["trace[1787627032] 'agreement among raft nodes before linearized reading' (duration: 605.496796ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:01:44.96201Z","caller":"traceutil/trace.go:171","msg":"trace[70361019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1325; }","duration":"717.139538ms","start":"2026-04-22T01:01:44.244861Z","end":"2026-04-22T01:01:44.962Z","steps":["trace[70361019] 'agreement among raft nodes before linearized reading' (duration: 717.033016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.962031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:44.355943Z","time spent":"606.077376ms","remote":"127.0.0.1:46048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":12664,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-m5mc5\" "} {"level":"warn","ts":"2026-04-22T01:01:44.962044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:44.24484Z","time spent":"717.19729ms","remote":"127.0.0.1:46118","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-22T01:01:44.961918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.055925ms","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-22T01:01:44.96215Z","caller":"traceutil/trace.go:171","msg":"trace[783668767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1325; }","duration":"740.462811ms","start":"2026-04-22T01:01:44.221669Z","end":"2026-04-22T01:01:44.962132Z","steps":["trace[783668767] 'agreement among raft nodes before linearized reading' (duration: 739.750429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T01:01:44.962217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T01:01:44.221645Z","time spent":"740.559494ms","remote":"127.0.0.1:46118","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-22T01:02:08.653203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.77576ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T01:02:08.653352Z","caller":"traceutil/trace.go:171","msg":"trace[1166314660] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"138.239207ms","start":"2026-04-22T01:02:08.515086Z","end":"2026-04-22T01:02:08.653325Z","steps":["trace[1166314660] 'process raft request' (duration: 28.256424ms)","trace[1166314660] 'compare' (duration: 109.649588ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T01:02:10.619073Z","caller":"traceutil/trace.go:171","msg":"trace[612069643] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"191.050839ms","start":"2026-04-22T01:02:10.427997Z","end":"2026-04-22T01:02:10.619048Z","steps":["trace[612069643] 'process raft request' (duration: 190.811165ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:04:30.117418Z","caller":"traceutil/trace.go:171","msg":"trace[485941927] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"164.782557ms","start":"2026-04-22T01:04:29.95261Z","end":"2026-04-22T01:04:30.117393Z","steps":["trace[485941927] 'process raft request' (duration: 164.634204ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T01:04:32.065709Z","caller":"traceutil/trace.go:171","msg":"trace[1167356000] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"111.699329ms","start":"2026-04-22T01:04:31.95398Z","end":"2026-04-22T01:04:32.065679Z","steps":["trace[1167356000] 'process raft request' (duration: 91.955271ms)","trace[1167356000] 'compare' (duration: 19.456812ms)"],"step_count":2}