{"level":"warn","ts":"2026-06-22T15:43:56.905648Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T15:43:56.905739Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-06-22T15:43:56.905812Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T15:43:56.905823Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-06-22T15:43:56.905847Z","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-06-22T15:43:56.906668Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-06-22T15:43:56.906769Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-06-22T15:43:56.918762Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"11.005504ms"} {"level":"info","ts":"2026-06-22T15:43:56.933276Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-06-22T15:43:56.933368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T15:43:56.933392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-06-22T15:43:56.933403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T15:43:56.933411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-06-22T15:43:56.93345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-06-22T15:43:56.945461Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T15:43:56.948172Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T15:43:56.949992Z","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-06-22T15:43:56.95352Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T15:43:56.953802Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T15:43:56.954118Z","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-06-22T15:43:56.954413Z","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-06-22T15:43:56.954431Z","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-06-22T15:43:56.956664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-06-22T15:43:56.956895Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-06-22T15:43:56.958053Z","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-06-22T15:43:56.95825Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T15:43:56.958275Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T15:43:56.95839Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-06-22T15:43:56.958404Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-06-22T15:43:57.734676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T15:43:57.734766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T15:43:57.734789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-06-22T15:43:57.734817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-06-22T15:43:57.734834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-06-22T15:43:57.734851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-06-22T15:43:57.734869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-06-22T15:43:57.736081Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T15:43:57.737124Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T15:43:57.737194Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T15:43:57.737305Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T15:43:57.737415Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T15:43:57.737467Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T15:43:57.737625Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T15:43:57.737725Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T15:43:57.737751Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T15:43:57.739619Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-06-22T15:43:57.739761Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-22T15:44:01.088554Z","caller":"traceutil/trace.go:171","msg":"trace[558645382] transaction","detail":"{read_only:false; response_revision:170; number_of_response:1; }","duration":"357.553544ms","start":"2026-06-22T15:44:00.730965Z","end":"2026-06-22T15:44:01.088519Z","steps":["trace[558645382] 'process raft request' (duration: 349.361055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:01.089324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:00.730935Z","time spent":"357.752695ms","remote":"127.0.0.1:60336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":744,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T15:44:04.728232Z","caller":"traceutil/trace.go:171","msg":"trace[1450266728] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"219.359599ms","start":"2026-06-22T15:44:04.508854Z","end":"2026-06-22T15:44:04.728213Z","steps":["trace[1450266728] 'read index received' (duration: 202.15481ms)","trace[1450266728] 'applied index is now lower than readState.Index' (duration: 17.204059ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:04.728348Z","caller":"traceutil/trace.go:171","msg":"trace[1254778631] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"248.670341ms","start":"2026-06-22T15:44:04.479645Z","end":"2026-06-22T15:44:04.728315Z","steps":["trace[1254778631] 'process raft request' (duration: 231.445281ms)","trace[1254778631] 'compare' (duration: 17.015649ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:04.728489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.415392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T15:44:04.728554Z","caller":"traceutil/trace.go:171","msg":"trace[2039685524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:307; }","duration":"112.581011ms","start":"2026-06-22T15:44:04.61596Z","end":"2026-06-22T15:44:04.728541Z","steps":["trace[2039685524] 'agreement among raft nodes before linearized reading' (duration: 112.419862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:04.728537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.588321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:04.728672Z","caller":"traceutil/trace.go:171","msg":"trace[393928121] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:0; response_revision:307; }","duration":"219.807732ms","start":"2026-06-22T15:44:04.508821Z","end":"2026-06-22T15:44:04.728629Z","steps":["trace[393928121] 'agreement among raft nodes before linearized reading' (duration: 219.537398ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:04.98153Z","caller":"traceutil/trace.go:171","msg":"trace[1575788124] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"243.408667ms","start":"2026-06-22T15:44:04.738093Z","end":"2026-06-22T15:44:04.981502Z","steps":["trace[1575788124] 'process raft request' (duration: 243.322633ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:04.981543Z","caller":"traceutil/trace.go:171","msg":"trace[727394832] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"246.015889ms","start":"2026-06-22T15:44:04.735492Z","end":"2026-06-22T15:44:04.981508Z","steps":["trace[727394832] 'process raft request' (duration: 230.827758ms)","trace[727394832] 'compare' (duration: 14.937897ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:05.327332Z","caller":"traceutil/trace.go:171","msg":"trace[1173582226] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:327; }","duration":"113.172982ms","start":"2026-06-22T15:44:05.214141Z","end":"2026-06-22T15:44:05.327314Z","steps":["trace[1173582226] 'read index received' (duration: 39.839027ms)","trace[1173582226] 'applied index is now lower than readState.Index' (duration: 73.333355ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:05.327455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.292918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:05.327486Z","caller":"traceutil/trace.go:171","msg":"trace[1015341479] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:316; }","duration":"113.361772ms","start":"2026-06-22T15:44:05.214116Z","end":"2026-06-22T15:44:05.327478Z","steps":["trace[1015341479] 'agreement among raft nodes before linearized reading' (duration: 113.269157ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:05.327669Z","caller":"traceutil/trace.go:171","msg":"trace[1929384166] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"114.853972ms","start":"2026-06-22T15:44:05.212806Z","end":"2026-06-22T15:44:05.32766Z","steps":["trace[1929384166] 'process raft request' (duration: 114.397037ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:05.447779Z","caller":"traceutil/trace.go:171","msg":"trace[669389557] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"115.57592ms","start":"2026-06-22T15:44:05.332183Z","end":"2026-06-22T15:44:05.447759Z","steps":["trace[669389557] 'process raft request' (duration: 108.188376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:07.856506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.906031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-22T15:44:07.856529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.066058158s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T15:44:07.856597Z","caller":"traceutil/trace.go:171","msg":"trace[1302040200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:323; }","duration":"1.066178144s","start":"2026-06-22T15:44:06.790402Z","end":"2026-06-22T15:44:07.856581Z","steps":["trace[1302040200] 'range keys from in-memory index tree' (duration: 1.065970613s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:07.856589Z","caller":"traceutil/trace.go:171","msg":"trace[1615720043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:323; }","duration":"277.037799ms","start":"2026-06-22T15:44:07.579533Z","end":"2026-06-22T15:44:07.85657Z","steps":["trace[1615720043] 'range keys from in-memory index tree' (duration: 276.745734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:07.856639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:06.790385Z","time spent":"1.066246248s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T15:44:07.856737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.094876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-22T15:44:07.856758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.488956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-22T15:44:07.856766Z","caller":"traceutil/trace.go:171","msg":"trace[553028195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:323; }","duration":"595.16558ms","start":"2026-06-22T15:44:07.261593Z","end":"2026-06-22T15:44:07.856758Z","steps":["trace[553028195] 'range keys from in-memory index tree' (duration: 595.008281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:07.85679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:07.26157Z","time spent":"595.213622ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-22T15:44:07.856791Z","caller":"traceutil/trace.go:171","msg":"trace[351497478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:323; }","duration":"525.546659ms","start":"2026-06-22T15:44:07.331234Z","end":"2026-06-22T15:44:07.856781Z","steps":["trace[351497478] 'range keys from in-memory index tree' (duration: 525.410522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:07.856814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:07.331219Z","time spent":"525.590081ms","remote":"127.0.0.1:60244","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-06-22T15:44:07.856919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.448674296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-22T15:44:07.856948Z","caller":"traceutil/trace.go:171","msg":"trace[1631118105] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:323; }","duration":"1.448732379s","start":"2026-06-22T15:44:06.408208Z","end":"2026-06-22T15:44:07.85694Z","steps":["trace[1631118105] 'range keys from in-memory index tree' (duration: 1.448581851s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:07.856968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:06.40819Z","time spent":"1.448772931s","remote":"127.0.0.1:60194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":238,"request content":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" "} {"level":"info","ts":"2026-06-22T15:44:08.219075Z","caller":"traceutil/trace.go:171","msg":"trace[1099856830] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"358.313637ms","start":"2026-06-22T15:44:07.860739Z","end":"2026-06-22T15:44:08.219052Z","steps":["trace[1099856830] 'process raft request' (duration: 358.19049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:08.219542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:07.860733Z","time spent":"358.412581ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:09.564635Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.308063917s","expected-duration":"1s"} {"level":"info","ts":"2026-06-22T15:44:09.565139Z","caller":"traceutil/trace.go:171","msg":"trace[735223126] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"1.70451278s","start":"2026-06-22T15:44:07.860597Z","end":"2026-06-22T15:44:09.56511Z","steps":["trace[735223126] 'process raft request' (duration: 1.704267427s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:09.565289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:07.860578Z","time spent":"1.704624665s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:44:09.565227Z","caller":"traceutil/trace.go:171","msg":"trace[853874970] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"1.704247266s","start":"2026-06-22T15:44:07.860933Z","end":"2026-06-22T15:44:09.565181Z","steps":["trace[853874970] 'process raft request' (duration: 1.704094408s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:09.565428Z","caller":"traceutil/trace.go:171","msg":"trace[207637471] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"1.704109128s","start":"2026-06-22T15:44:07.861189Z","end":"2026-06-22T15:44:09.565299Z","steps":["trace[207637471] 'process raft request' (duration: 1.703866146s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:09.565543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695371783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:09.565592Z","caller":"traceutil/trace.go:171","msg":"trace[1435194864] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:0; response_revision:327; }","duration":"1.695466708s","start":"2026-06-22T15:44:07.870115Z","end":"2026-06-22T15:44:09.565582Z","steps":["trace[1435194864] 'agreement among raft nodes before linearized reading' (duration: 1.695304079s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:09.56562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:07.870102Z","time spent":"1.69551155s","remote":"127.0.0.1:60194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-06-22T15:44:09.565413Z","caller":"traceutil/trace.go:171","msg":"trace[649967604] linearizableReadLoop","detail":"{readStateIndex:340; appliedIndex:336; }","duration":"1.694937871s","start":"2026-06-22T15:44:07.870141Z","end":"2026-06-22T15:44:09.565078Z","steps":["trace[649967604] 'read index received' (duration: 348.863734ms)","trace[649967604] 'applied index is now lower than readState.Index' (duration: 1.346073417s)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:09.565658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:07.860914Z","time spent":"1.704498289s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:09.565774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:07.861182Z","time spent":"1.704364302s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:10.1391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.574782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T15:44:10.139281Z","caller":"traceutil/trace.go:171","msg":"trace[861307078] linearizableReadLoop","detail":"{readStateIndex:341; appliedIndex:340; }","duration":"571.574397ms","start":"2026-06-22T15:44:09.567691Z","end":"2026-06-22T15:44:10.139265Z","steps":["trace[861307078] 'read index received' (duration: 412.543343ms)","trace[861307078] 'applied index is now lower than readState.Index' (duration: 159.029614ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:10.139345Z","caller":"traceutil/trace.go:171","msg":"trace[649488088] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"889.518219ms","start":"2026-06-22T15:44:09.249791Z","end":"2026-06-22T15:44:10.139309Z","steps":["trace[649488088] 'process raft request' (duration: 730.515716ms)","trace[649488088] 'compare' (duration: 158.461286ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:10.139418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.727785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-06-22T15:44:10.139616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:09.249758Z","time spent":"889.722149ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:10.139633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.657065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4325"} {"level":"info","ts":"2026-06-22T15:44:10.139703Z","caller":"traceutil/trace.go:171","msg":"trace[1199440910] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:328; }","duration":"273.75899ms","start":"2026-06-22T15:44:09.865922Z","end":"2026-06-22T15:44:10.139681Z","steps":["trace[1199440910] 'agreement among raft nodes before linearized reading' (duration: 273.590742ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:10.139545Z","caller":"traceutil/trace.go:171","msg":"trace[2006245178] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:328; }","duration":"571.882963ms","start":"2026-06-22T15:44:09.567651Z","end":"2026-06-22T15:44:10.139534Z","steps":["trace[2006245178] 'agreement among raft nodes before linearized reading' (duration: 571.723395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:10.140042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:09.567636Z","time spent":"572.390238ms","remote":"127.0.0.1:60118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-22T15:44:17.816391Z","caller":"traceutil/trace.go:171","msg":"trace[849445195] linearizableReadLoop","detail":"{readStateIndex:419; appliedIndex:417; }","duration":"204.055158ms","start":"2026-06-22T15:44:17.612309Z","end":"2026-06-22T15:44:17.816364Z","steps":["trace[849445195] 'read index received' (duration: 66.121048ms)","trace[849445195] 'applied index is now lower than readState.Index' (duration: 137.93319ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:17.816567Z","caller":"traceutil/trace.go:171","msg":"trace[1552054373] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"204.297718ms","start":"2026-06-22T15:44:17.612227Z","end":"2026-06-22T15:44:17.816525Z","steps":["trace[1552054373] 'process raft request' (duration: 124.090095ms)","trace[1552054373] 'compare' (duration: 79.92301ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:17.8167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.254337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T15:44:17.816819Z","caller":"traceutil/trace.go:171","msg":"trace[629264163] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:403; }","duration":"204.532269ms","start":"2026-06-22T15:44:17.612268Z","end":"2026-06-22T15:44:17.816801Z","steps":["trace[629264163] 'agreement among raft nodes before linearized reading' (duration: 204.191393ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:38.227412Z","caller":"traceutil/trace.go:171","msg":"trace[2021029011] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:498; }","duration":"240.501582ms","start":"2026-06-22T15:44:37.986886Z","end":"2026-06-22T15:44:38.227388Z","steps":["trace[2021029011] 'read index received' (duration: 239.270216ms)","trace[2021029011] 'applied index is now lower than readState.Index' (duration: 1.230346ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:38.227465Z","caller":"traceutil/trace.go:171","msg":"trace[728427999] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"440.178372ms","start":"2026-06-22T15:44:37.787267Z","end":"2026-06-22T15:44:38.227446Z","steps":["trace[728427999] 'process raft request' (duration: 439.686903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:38.227569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:37.787241Z","time spent":"440.265665ms","remote":"127.0.0.1:60100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317296,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T15:44:38.22776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.865366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-22T15:44:38.227892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.487733ms","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-06-22T15:44:38.227932Z","caller":"traceutil/trace.go:171","msg":"trace[1584825063] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:479; }","duration":"171.556535ms","start":"2026-06-22T15:44:38.056368Z","end":"2026-06-22T15:44:38.227925Z","steps":["trace[1584825063] 'agreement among raft nodes before linearized reading' (duration: 171.494783ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:38.227879Z","caller":"traceutil/trace.go:171","msg":"trace[1474927875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:479; }","duration":"241.022092ms","start":"2026-06-22T15:44:37.986835Z","end":"2026-06-22T15:44:38.227857Z","steps":["trace[1474927875] 'agreement among raft nodes before linearized reading' (duration: 240.673299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:38.228374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.910448ms","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-06-22T15:44:38.228506Z","caller":"traceutil/trace.go:171","msg":"trace[1060388425] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:479; }","duration":"169.077993ms","start":"2026-06-22T15:44:38.059404Z","end":"2026-06-22T15:44:38.228482Z","steps":["trace[1060388425] 'agreement among raft nodes before linearized reading' (duration: 168.639897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:38.522235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.354908ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:38.522413Z","caller":"traceutil/trace.go:171","msg":"trace[283308607] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:479; }","duration":"116.559115ms","start":"2026-06-22T15:44:38.405839Z","end":"2026-06-22T15:44:38.522398Z","steps":["trace[283308607] 'range keys from in-memory index tree' (duration: 116.333117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:38.522338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.074754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T15:44:38.522676Z","caller":"traceutil/trace.go:171","msg":"trace[1370015064] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"290.190649ms","start":"2026-06-22T15:44:38.232471Z","end":"2026-06-22T15:44:38.522662Z","steps":["trace[1370015064] 'process raft request' (duration: 157.751111ms)","trace[1370015064] 'compare' (duration: 132.002242ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:38.52274Z","caller":"traceutil/trace.go:171","msg":"trace[332709338] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"288.272748ms","start":"2026-06-22T15:44:38.234384Z","end":"2026-06-22T15:44:38.522656Z","steps":["trace[332709338] 'process raft request' (duration: 288.152233ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:38.522787Z","caller":"traceutil/trace.go:171","msg":"trace[65435335] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"269.677754ms","start":"2026-06-22T15:44:38.253102Z","end":"2026-06-22T15:44:38.52278Z","steps":["trace[65435335] 'process raft request' (duration: 269.475827ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:38.522945Z","caller":"traceutil/trace.go:171","msg":"trace[256296367] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"288.539228ms","start":"2026-06-22T15:44:38.234377Z","end":"2026-06-22T15:44:38.522917Z","steps":["trace[256296367] 'process raft request' (duration: 288.187084ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:38.522808Z","caller":"traceutil/trace.go:171","msg":"trace[581393846] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"269.606211ms","start":"2026-06-22T15:44:38.253198Z","end":"2026-06-22T15:44:38.522804Z","steps":["trace[581393846] 'process raft request' (duration: 269.423355ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:39.540256Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.012696716s","expected-duration":"1s"} {"level":"info","ts":"2026-06-22T15:44:39.55234Z","caller":"traceutil/trace.go:171","msg":"trace[1511346176] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"1.024838085s","start":"2026-06-22T15:44:38.527471Z","end":"2026-06-22T15:44:39.552309Z","steps":["trace[1511346176] 'process raft request' (duration: 1.012995638s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:39.552466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:38.527454Z","time spent":"1.024952318s","remote":"127.0.0.1:60104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6516,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T15:44:39.55264Z","caller":"traceutil/trace.go:171","msg":"trace[220570364] linearizableReadLoop","detail":"{readStateIndex:506; appliedIndex:504; }","duration":"271.609136ms","start":"2026-06-22T15:44:39.281003Z","end":"2026-06-22T15:44:39.552613Z","steps":["trace[220570364] 'read index received' (duration: 259.429487ms)","trace[220570364] 'applied index is now lower than readState.Index' (duration: 12.178919ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:39.552886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.875735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:39.552884Z","caller":"traceutil/trace.go:171","msg":"trace[693417776] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"1.024675959s","start":"2026-06-22T15:44:38.528192Z","end":"2026-06-22T15:44:39.552868Z","steps":["trace[693417776] 'process raft request' (duration: 1.023712053s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:39.552914Z","caller":"traceutil/trace.go:171","msg":"trace[1820880113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"271.949819ms","start":"2026-06-22T15:44:39.280955Z","end":"2026-06-22T15:44:39.552904Z","steps":["trace[1820880113] 'agreement among raft nodes before linearized reading' (duration: 271.878836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:39.55296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:38.528183Z","time spent":"1.02473104s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:41.850277Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727127701359265,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-22T15:44:42.567237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.223848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T15:44:42.567713Z","caller":"traceutil/trace.go:171","msg":"trace[382565199] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"1.230257085s","start":"2026-06-22T15:44:41.337424Z","end":"2026-06-22T15:44:42.567681Z","steps":["trace[382565199] 'process raft request' (duration: 1.230028087s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:42.567894Z","caller":"traceutil/trace.go:171","msg":"trace[1675799019] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"1.224953784s","start":"2026-06-22T15:44:41.342912Z","end":"2026-06-22T15:44:42.567866Z","steps":["trace[1675799019] 'process raft request' (duration: 1.224692105s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:42.567936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.337411Z","time spent":"1.230390521s","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T15:44:42.567739Z","caller":"traceutil/trace.go:171","msg":"trace[2012204252] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"1.220835105s","start":"2026-06-22T15:44:41.346882Z","end":"2026-06-22T15:44:42.567717Z","steps":["trace[2012204252] 'process raft request' (duration: 1.220783473s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:42.568009Z","caller":"traceutil/trace.go:171","msg":"trace[364381264] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"1.230051678s","start":"2026-06-22T15:44:41.337897Z","end":"2026-06-22T15:44:42.567949Z","steps":["trace[364381264] 'process raft request' (duration: 1.229641773s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:42.568098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.346864Z","time spent":"1.221151076s","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T15:44:42.568104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.342893Z","time spent":"1.22515184s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:44:42.567604Z","caller":"traceutil/trace.go:171","msg":"trace[988219408] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"1.230224424s","start":"2026-06-22T15:44:41.337349Z","end":"2026-06-22T15:44:42.567573Z","steps":["trace[988219408] 'process raft request' (duration: 609.54436ms)","trace[988219408] 'compare' (duration: 619.984539ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:42.568625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.337866Z","time spent":"1.230301027s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T15:44:42.568858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.337328Z","time spent":"1.231371326s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:43.460773Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.513312136s","expected-duration":"1s"} {"level":"info","ts":"2026-06-22T15:44:43.546771Z","caller":"traceutil/trace.go:171","msg":"trace[1095746798] transaction","detail":"{read_only:false; number_of_response:1; response_revision:541; }","duration":"2.194060313s","start":"2026-06-22T15:44:41.352637Z","end":"2026-06-22T15:44:43.546697Z","steps":["trace[1095746798] 'process raft request' (duration: 2.193432461s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:43.546814Z","caller":"traceutil/trace.go:171","msg":"trace[345808447] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:558; }","duration":"2.197612252s","start":"2026-06-22T15:44:41.349183Z","end":"2026-06-22T15:44:43.546795Z","steps":["trace[345808447] 'read index received' (duration: 597.749094ms)","trace[345808447] 'applied index is now lower than readState.Index' (duration: 1.599861558s)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:43.546945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.352626Z","time spent":"2.194223739s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7376,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:44:43.54697Z","caller":"traceutil/trace.go:171","msg":"trace[1704287832] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"2.177750843s","start":"2026-06-22T15:44:41.369204Z","end":"2026-06-22T15:44:43.546954Z","steps":["trace[1704287832] 'process raft request' (duration: 2.17710847s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:43.546906Z","caller":"traceutil/trace.go:171","msg":"trace[47069758] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"2.177781654s","start":"2026-06-22T15:44:41.369078Z","end":"2026-06-22T15:44:43.54686Z","steps":["trace[47069758] 'process raft request' (duration: 2.177084949s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.547416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.351581Z","time spent":"2.195831817s","remote":"127.0.0.1:60052","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-22T15:44:43.547422Z","caller":"traceutil/trace.go:171","msg":"trace[325871372] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"2.17436184s","start":"2026-06-22T15:44:41.373047Z","end":"2026-06-22T15:44:43.547409Z","steps":["trace[325871372] 'process raft request' (duration: 2.173328533s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.547614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.373018Z","time spent":"2.174520655s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T15:44:43.547894Z","caller":"traceutil/trace.go:171","msg":"trace[888496880] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"2.172821894s","start":"2026-06-22T15:44:41.375056Z","end":"2026-06-22T15:44:43.547877Z","steps":["trace[888496880] 'process raft request' (duration: 2.171371983s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.548041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.375027Z","time spent":"2.172916568s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:44:43.548296Z","caller":"traceutil/trace.go:171","msg":"trace[628388705] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"2.061276536s","start":"2026-06-22T15:44:41.486967Z","end":"2026-06-22T15:44:43.548244Z","steps":["trace[628388705] 'process raft request' (duration: 2.059613337s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.548383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.486946Z","time spent":"2.061399911s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-22T15:44:43.548557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.199334713s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:1019"} {"level":"info","ts":"2026-06-22T15:44:43.548609Z","caller":"traceutil/trace.go:171","msg":"trace[773493334] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:546; }","duration":"2.199431617s","start":"2026-06-22T15:44:41.34916Z","end":"2026-06-22T15:44:43.548591Z","steps":["trace[773493334] 'agreement among raft nodes before linearized reading' (duration: 2.199314062s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.548653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.349153Z","time spent":"2.199488188s","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1043,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" "} {"level":"warn","ts":"2026-06-22T15:44:43.547366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.369195Z","time spent":"2.178076905s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:43.549127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.369052Z","time spent":"2.178360015s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:44:43.555772Z","caller":"traceutil/trace.go:171","msg":"trace[22821721] transaction","detail":"{read_only:false; number_of_response:0; response_revision:546; }","duration":"984.18738ms","start":"2026-06-22T15:44:42.571569Z","end":"2026-06-22T15:44:43.555757Z","steps":["trace[22821721] 'process raft request' (duration: 983.713103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.555863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:42.571547Z","time spent":"984.275493ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T15:44:43.556862Z","caller":"traceutil/trace.go:171","msg":"trace[1913170483] transaction","detail":"{read_only:false; number_of_response:0; response_revision:546; }","duration":"984.730959ms","start":"2026-06-22T15:44:42.572114Z","end":"2026-06-22T15:44:43.556845Z","steps":["trace[1913170483] 'process raft request' (duration: 983.242096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.556938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:42.572103Z","time spent":"984.795141ms","remote":"127.0.0.1:60496","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T15:44:43.557432Z","caller":"traceutil/trace.go:171","msg":"trace[1522997859] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"952.65586ms","start":"2026-06-22T15:44:42.604764Z","end":"2026-06-22T15:44:43.55742Z","steps":["trace[1522997859] 'process raft request' (duration: 951.478358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.5575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:42.60474Z","time spent":"952.720231ms","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:43.561101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.208500326s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10078"} {"level":"info","ts":"2026-06-22T15:44:43.561142Z","caller":"traceutil/trace.go:171","msg":"trace[69459494] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:548; }","duration":"2.20860179s","start":"2026-06-22T15:44:41.352529Z","end":"2026-06-22T15:44:43.561131Z","steps":["trace[69459494] 'agreement among raft nodes before linearized reading' (duration: 2.205259851s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.561165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.352514Z","time spent":"2.208644911s","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":10102,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-06-22T15:44:43.56156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.025682156s","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-06-22T15:44:43.561586Z","caller":"traceutil/trace.go:171","msg":"trace[1748926943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:548; }","duration":"1.025746028s","start":"2026-06-22T15:44:42.535833Z","end":"2026-06-22T15:44:43.561579Z","steps":["trace[1748926943] 'agreement among raft nodes before linearized reading' (duration: 1.021962433s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.56163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:42.53581Z","time spent":"1.025789589s","remote":"127.0.0.1:60244","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-06-22T15:44:43.561925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026046989s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T15:44:43.561953Z","caller":"traceutil/trace.go:171","msg":"trace[1339615709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:548; }","duration":"1.026112571s","start":"2026-06-22T15:44:42.535833Z","end":"2026-06-22T15:44:43.561945Z","steps":["trace[1339615709] 'agreement among raft nodes before linearized reading' (duration: 1.021964833s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.561972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:42.535812Z","time spent":"1.026155632s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T15:44:43.562085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.300929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:43.562157Z","caller":"traceutil/trace.go:171","msg":"trace[933654062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"280.422043ms","start":"2026-06-22T15:44:43.281708Z","end":"2026-06-22T15:44:43.56213Z","steps":["trace[933654062] 'agreement among raft nodes before linearized reading' (duration: 276.081149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.562444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026057698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T15:44:43.562469Z","caller":"traceutil/trace.go:171","msg":"trace[898157719] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"970.037952ms","start":"2026-06-22T15:44:42.587766Z","end":"2026-06-22T15:44:43.557804Z","steps":["trace[898157719] 'process raft request' (duration: 967.655308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.562519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00637356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-22T15:44:43.562537Z","caller":"traceutil/trace.go:171","msg":"trace[223758935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:548; }","duration":"2.006458962s","start":"2026-06-22T15:44:41.556074Z","end":"2026-06-22T15:44:43.562533Z","steps":["trace[223758935] 'agreement among raft nodes before linearized reading' (duration: 2.001724844s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:43.562478Z","caller":"traceutil/trace.go:171","msg":"trace[126820168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"1.02609843s","start":"2026-06-22T15:44:42.536362Z","end":"2026-06-22T15:44:43.56246Z","steps":["trace[126820168] 'agreement among raft nodes before linearized reading' (duration: 1.021431404s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:43.562555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:42.587756Z","time spent":"974.748399ms","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:43.56257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:41.556053Z","time spent":"2.006510485s","remote":"127.0.0.1:60244","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-06-22T15:44:43.562587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:42.536355Z","time spent":"1.026223514s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-22T15:44:48.91054Z","caller":"traceutil/trace.go:171","msg":"trace[641833539] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"141.891001ms","start":"2026-06-22T15:44:48.768619Z","end":"2026-06-22T15:44:48.91051Z","steps":["trace[641833539] 'process raft request' (duration: 77.800802ms)","trace[641833539] 'compare' (duration: 63.976295ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:49.57849Z","caller":"traceutil/trace.go:171","msg":"trace[1949981013] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"185.668295ms","start":"2026-06-22T15:44:49.392796Z","end":"2026-06-22T15:44:49.578464Z","steps":["trace[1949981013] 'process raft request' (duration: 185.159387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:50.128644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.049145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-22T15:44:50.128701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.710759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-22T15:44:50.12872Z","caller":"traceutil/trace.go:171","msg":"trace[146486287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"469.156589ms","start":"2026-06-22T15:44:49.659545Z","end":"2026-06-22T15:44:50.128701Z","steps":["trace[146486287] 'range keys from in-memory index tree' (duration: 468.91515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:50.128774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:49.659531Z","time spent":"469.234781ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-22T15:44:50.128779Z","caller":"traceutil/trace.go:171","msg":"trace[2144156684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"461.785161ms","start":"2026-06-22T15:44:49.666948Z","end":"2026-06-22T15:44:50.128733Z","steps":["trace[2144156684] 'range keys from in-memory index tree' (duration: 461.591414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:50.128811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:49.666933Z","time spent":"461.869844ms","remote":"127.0.0.1:60244","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-06-22T15:44:50.128945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.320564ms","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-06-22T15:44:50.129017Z","caller":"traceutil/trace.go:171","msg":"trace[1815639799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"469.445148ms","start":"2026-06-22T15:44:49.659554Z","end":"2026-06-22T15:44:50.129Z","steps":["trace[1815639799] 'range keys from in-memory index tree' (duration: 469.159369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:50.129101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:49.65954Z","time spent":"469.552182ms","remote":"127.0.0.1:60244","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-06-22T15:44:50.1291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.47416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T15:44:50.129242Z","caller":"traceutil/trace.go:171","msg":"trace[353219302] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"469.688946ms","start":"2026-06-22T15:44:49.659522Z","end":"2026-06-22T15:44:50.129211Z","steps":["trace[353219302] 'range keys from in-memory index tree' (duration: 469.149678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:50.129306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:49.659508Z","time spent":"469.78645ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-22T15:44:50.248529Z","caller":"traceutil/trace.go:171","msg":"trace[1630121502] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"176.45106ms","start":"2026-06-22T15:44:50.072057Z","end":"2026-06-22T15:44:50.248508Z","steps":["trace[1630121502] 'process raft request' (duration: 175.736636ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:50.259214Z","caller":"traceutil/trace.go:171","msg":"trace[1796746598] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"125.798988ms","start":"2026-06-22T15:44:50.133393Z","end":"2026-06-22T15:44:50.259192Z","steps":["trace[1796746598] 'process raft request' (duration: 125.627712ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:50.259327Z","caller":"traceutil/trace.go:171","msg":"trace[823536004] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"126.109759ms","start":"2026-06-22T15:44:50.133195Z","end":"2026-06-22T15:44:50.259305Z","steps":["trace[823536004] 'process raft request' (duration: 125.763987ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:50.259432Z","caller":"traceutil/trace.go:171","msg":"trace[1086506283] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"126.119579ms","start":"2026-06-22T15:44:50.133304Z","end":"2026-06-22T15:44:50.259423Z","steps":["trace[1086506283] 'process raft request' (duration: 125.689774ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:50.259666Z","caller":"traceutil/trace.go:171","msg":"trace[1940181927] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"126.556253ms","start":"2026-06-22T15:44:50.133085Z","end":"2026-06-22T15:44:50.259641Z","steps":["trace[1940181927] 'process raft request' (duration: 125.747296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:52.440445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.430135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-22T15:44:52.440545Z","caller":"traceutil/trace.go:171","msg":"trace[3224438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"177.59142ms","start":"2026-06-22T15:44:52.262936Z","end":"2026-06-22T15:44:52.440528Z","steps":["trace[3224438] 'range keys from in-memory index tree' (duration: 177.181727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:52.440581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174191638s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bfl98\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-22T15:44:52.440596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.159609738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:52.440636Z","caller":"traceutil/trace.go:171","msg":"trace[1723307415] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bfl98; range_end:; response_count:1; response_revision:641; }","duration":"1.174321742s","start":"2026-06-22T15:44:51.2663Z","end":"2026-06-22T15:44:52.440622Z","steps":["trace[1723307415] 'range keys from in-memory index tree' (duration: 1.174059344s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:52.440662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:51.266286Z","time spent":"1.174370683s","remote":"127.0.0.1:60180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-bfl98\" "} {"level":"info","ts":"2026-06-22T15:44:52.440643Z","caller":"traceutil/trace.go:171","msg":"trace[253910905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"1.159696321s","start":"2026-06-22T15:44:51.280932Z","end":"2026-06-22T15:44:52.440629Z","steps":["trace[253910905] 'range keys from in-memory index tree' (duration: 1.159513615s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:52.441016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:51.280903Z","time spent":"1.160108054s","remote":"127.0.0.1:60016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T15:44:52.440878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.113910804s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-22T15:44:52.441137Z","caller":"traceutil/trace.go:171","msg":"trace[392992015] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:641; }","duration":"1.114219174s","start":"2026-06-22T15:44:51.32689Z","end":"2026-06-22T15:44:52.441109Z","steps":["trace[392992015] 'range keys from in-memory index tree' (duration: 1.113722108s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:52.440933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.330042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-22T15:44:52.441209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:51.326865Z","time spent":"1.114321388s","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.138\" "} {"level":"info","ts":"2026-06-22T15:44:52.441225Z","caller":"traceutil/trace.go:171","msg":"trace[518022290] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"177.630432ms","start":"2026-06-22T15:44:52.263581Z","end":"2026-06-22T15:44:52.441211Z","steps":["trace[518022290] 'range keys from in-memory index tree' (duration: 177.252959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:52.441231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.214861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-22T15:44:52.440982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.166977ms","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-06-22T15:44:52.441308Z","caller":"traceutil/trace.go:171","msg":"trace[1491575791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"177.539069ms","start":"2026-06-22T15:44:52.263752Z","end":"2026-06-22T15:44:52.441291Z","steps":["trace[1491575791] 'range keys from in-memory index tree' (duration: 177.066483ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:52.441312Z","caller":"traceutil/trace.go:171","msg":"trace[1109676056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"174.51314ms","start":"2026-06-22T15:44:52.266761Z","end":"2026-06-22T15:44:52.441275Z","steps":["trace[1109676056] 'range keys from in-memory index tree' (duration: 174.022854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:52.952143Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727127701359448,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-22T15:44:53.197068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:52.443581Z","time spent":"753.482872ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-22T15:44:53.868225Z","caller":"traceutil/trace.go:171","msg":"trace[791354744] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"1.421105303s","start":"2026-06-22T15:44:52.447089Z","end":"2026-06-22T15:44:53.868194Z","steps":["trace[791354744] 'process raft request' (duration: 1.420689179s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:53.868265Z","caller":"traceutil/trace.go:171","msg":"trace[333496201] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"1.420376879s","start":"2026-06-22T15:44:52.447859Z","end":"2026-06-22T15:44:53.868236Z","steps":["trace[333496201] 'process raft request' (duration: 1.420138072s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:53.868434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:52.447847Z","time spent":"1.420498243s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:44:53.868495Z","caller":"traceutil/trace.go:171","msg":"trace[1325220528] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.418723565s","start":"2026-06-22T15:44:52.449751Z","end":"2026-06-22T15:44:53.868475Z","steps":["trace[1325220528] 'process raft request' (duration: 1.418429805s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:53.868426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:52.447043Z","time spent":"1.421265178s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:53.868594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:52.449744Z","time spent":"1.418803287s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:44:53.868554Z","caller":"traceutil/trace.go:171","msg":"trace[1078435049] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.418930442s","start":"2026-06-22T15:44:52.449603Z","end":"2026-06-22T15:44:53.868533Z","steps":["trace[1078435049] 'process raft request' (duration: 1.418523889s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:53.869016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:52.449593Z","time spent":"1.419362865s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:44:53.869216Z","caller":"traceutil/trace.go:171","msg":"trace[567436775] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.411327423s","start":"2026-06-22T15:44:52.457864Z","end":"2026-06-22T15:44:53.869192Z","steps":["trace[567436775] 'process raft request' (duration: 1.411045734s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:53.869326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:52.457844Z","time spent":"1.411425177s","remote":"127.0.0.1:60180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:53.869357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.417460414s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:53.869434Z","caller":"traceutil/trace.go:171","msg":"trace[1417955542] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:669; }","duration":"1.417186774s","start":"2026-06-22T15:44:52.45189Z","end":"2026-06-22T15:44:53.869077Z","steps":["trace[1417955542] 'read index received' (duration: 745.197172ms)","trace[1417955542] 'applied index is now lower than readState.Index' (duration: 671.988722ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:53.869478Z","caller":"traceutil/trace.go:171","msg":"trace[1668582018] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"1.417608499s","start":"2026-06-22T15:44:52.451852Z","end":"2026-06-22T15:44:53.869461Z","steps":["trace[1668582018] 'agreement among raft nodes before linearized reading' (duration: 1.417454344s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:53.869538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:52.451841Z","time spent":"1.417682061s","remote":"127.0.0.1:60004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-22T15:44:53.918092Z","caller":"traceutil/trace.go:171","msg":"trace[726950454] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"719.955242ms","start":"2026-06-22T15:44:53.19811Z","end":"2026-06-22T15:44:53.918066Z","steps":["trace[726950454] 'process raft request' (duration: 719.821998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:53.918232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:53.198097Z","time spent":"720.060586ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:44:57.862861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.979461054s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-22T15:44:57.862936Z","caller":"traceutil/trace.go:171","msg":"trace[2125662400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"1.979573567s","start":"2026-06-22T15:44:55.883334Z","end":"2026-06-22T15:44:57.862908Z","steps":["trace[2125662400] 'range keys from in-memory index tree' (duration: 1.979342151s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:57.862936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.935952853s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T15:44:57.862934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.978228085s","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-06-22T15:44:57.862967Z","caller":"traceutil/trace.go:171","msg":"trace[2017182198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"1.936027756s","start":"2026-06-22T15:44:55.92693Z","end":"2026-06-22T15:44:57.862958Z","steps":["trace[2017182198] 'range keys from in-memory index tree' (duration: 1.935862811s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:57.862968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:55.88331Z","time spent":"1.97964919s","remote":"127.0.0.1:60244","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-06-22T15:44:57.862987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:55.92691Z","time spent":"1.936071828s","remote":"127.0.0.1:60016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-22T15:44:57.862988Z","caller":"traceutil/trace.go:171","msg":"trace[315005434] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"1.978295537s","start":"2026-06-22T15:44:55.884677Z","end":"2026-06-22T15:44:57.862973Z","steps":["trace[315005434] 'range keys from in-memory index tree' (duration: 1.978185194s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:57.863031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:55.884672Z","time spent":"1.978347079s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-22T15:44:57.863031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.978791143s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-22T15:44:57.86308Z","caller":"traceutil/trace.go:171","msg":"trace[2017744043] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"1.978881845s","start":"2026-06-22T15:44:55.884184Z","end":"2026-06-22T15:44:57.863065Z","steps":["trace[2017744043] 'range keys from in-memory index tree' (duration: 1.9787008s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:57.863055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.978870436s","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-06-22T15:44:57.863123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:55.884159Z","time spent":"1.978953038s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-22T15:44:57.863464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.942786098s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-22T15:44:57.863488Z","caller":"traceutil/trace.go:171","msg":"trace[766449693] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:648; }","duration":"3.94284086s","start":"2026-06-22T15:44:53.92064Z","end":"2026-06-22T15:44:57.863481Z","steps":["trace[766449693] 'range keys from in-memory index tree' (duration: 3.942713347s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:57.863506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:53.920622Z","time spent":"3.942878902s","remote":"127.0.0.1:60168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-06-22T15:44:57.863868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.474036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:57.863889Z","caller":"traceutil/trace.go:171","msg":"trace[1322384735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"307.523208ms","start":"2026-06-22T15:44:57.556359Z","end":"2026-06-22T15:44:57.863883Z","steps":["trace[1322384735] 'range keys from in-memory index tree' (duration: 307.416344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:57.863909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:57.556344Z","time spent":"307.558208ms","remote":"127.0.0.1:60004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T15:44:57.864022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.93659956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:57.864046Z","caller":"traceutil/trace.go:171","msg":"trace[1624424615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"3.9379179s","start":"2026-06-22T15:44:53.926121Z","end":"2026-06-22T15:44:57.864038Z","steps":["trace[1624424615] 'range keys from in-memory index tree' (duration: 3.936546378s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:57.864124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:53.926109Z","time spent":"3.938008014s","remote":"127.0.0.1:60004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-22T15:44:57.864857Z","caller":"traceutil/trace.go:171","msg":"trace[140787780] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"1.979006239s","start":"2026-06-22T15:44:55.884125Z","end":"2026-06-22T15:44:57.863131Z","steps":["trace[140787780] 'range keys from in-memory index tree' (duration: 1.978803823s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:57.864906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:55.884118Z","time spent":"1.980775204s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-22T15:44:58.007278Z","caller":"traceutil/trace.go:171","msg":"trace[1060660702] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"138.785097ms","start":"2026-06-22T15:44:57.868475Z","end":"2026-06-22T15:44:58.00726Z","steps":["trace[1060660702] 'process raft request' (duration: 138.727875ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:58.007538Z","caller":"traceutil/trace.go:171","msg":"trace[2094585978] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:677; }","duration":"135.66525ms","start":"2026-06-22T15:44:57.871832Z","end":"2026-06-22T15:44:58.007497Z","steps":["trace[2094585978] 'read index received' (duration: 69.356343ms)","trace[2094585978] 'applied index is now lower than readState.Index' (duration: 66.305507ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:58.007297Z","caller":"traceutil/trace.go:171","msg":"trace[701153114] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"139.128817ms","start":"2026-06-22T15:44:57.868152Z","end":"2026-06-22T15:44:58.007281Z","steps":["trace[701153114] 'process raft request' (duration: 110.01726ms)","trace[701153114] 'compare' (duration: 28.88428ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:58.007757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.881587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:44:58.007809Z","caller":"traceutil/trace.go:171","msg":"trace[209360135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"135.986719ms","start":"2026-06-22T15:44:57.871806Z","end":"2026-06-22T15:44:58.007793Z","steps":["trace[209360135] 'agreement among raft nodes before linearized reading' (duration: 135.842005ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:58.00784Z","caller":"traceutil/trace.go:171","msg":"trace[1433032198] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"139.307503ms","start":"2026-06-22T15:44:57.868516Z","end":"2026-06-22T15:44:58.007824Z","steps":["trace[1433032198] 'process raft request' (duration: 138.719225ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:58.007338Z","caller":"traceutil/trace.go:171","msg":"trace[1967309717] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"139.128348ms","start":"2026-06-22T15:44:57.868204Z","end":"2026-06-22T15:44:58.007333Z","steps":["trace[1967309717] 'process raft request' (duration: 138.972283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:00.836717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.160137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T15:45:00.836846Z","caller":"traceutil/trace.go:171","msg":"trace[732466827] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"348.778527ms","start":"2026-06-22T15:45:00.488044Z","end":"2026-06-22T15:45:00.836822Z","steps":["trace[732466827] 'process raft request' (duration: 61.414934ms)","trace[732466827] 'compare' (duration: 286.941951ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:45:00.837169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:00.488013Z","time spent":"349.019855ms","remote":"127.0.0.1:60068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:45:00.837661Z","caller":"traceutil/trace.go:171","msg":"trace[1235015667] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"156.449208ms","start":"2026-06-22T15:45:00.681194Z","end":"2026-06-22T15:45:00.837643Z","steps":["trace[1235015667] 'process raft request' (duration: 156.355935ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:02.773135Z","caller":"traceutil/trace.go:171","msg":"trace[1595439747] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"102.314265ms","start":"2026-06-22T15:45:02.670796Z","end":"2026-06-22T15:45:02.77311Z","steps":["trace[1595439747] 'process raft request' (duration: 102.1656ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:11.603381Z","caller":"traceutil/trace.go:171","msg":"trace[832756250] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:822; }","duration":"486.403446ms","start":"2026-06-22T15:45:11.116963Z","end":"2026-06-22T15:45:11.603366Z","steps":["trace[832756250] 'read index received' (duration: 486.249151ms)","trace[832756250] 'applied index is now lower than readState.Index' (duration: 153.745µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:45:11.603793Z","caller":"traceutil/trace.go:171","msg":"trace[1330667745] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"588.699049ms","start":"2026-06-22T15:45:11.015087Z","end":"2026-06-22T15:45:11.603786Z","steps":["trace[1330667745] 'process raft request' (duration: 588.167845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.603866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.015062Z","time spent":"588.753201ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:45:11.603978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.011503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.603995Z","caller":"traceutil/trace.go:171","msg":"trace[1540672274] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:790; }","duration":"487.050364ms","start":"2026-06-22T15:45:11.116939Z","end":"2026-06-22T15:45:11.60399Z","steps":["trace[1540672274] 'agreement among raft nodes before linearized reading' (duration: 487.020383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.604009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.116924Z","time spent":"487.081534ms","remote":"127.0.0.1:48338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-22T15:45:11.604083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.128636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.604095Z","caller":"traceutil/trace.go:171","msg":"trace[1287878088] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:790; }","duration":"487.165337ms","start":"2026-06-22T15:45:11.116926Z","end":"2026-06-22T15:45:11.604091Z","steps":["trace[1287878088] 'agreement among raft nodes before linearized reading' (duration: 487.146146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.604107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.11691Z","time spent":"487.193588ms","remote":"127.0.0.1:48338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-06-22T15:45:11.604173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.740722ms","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-06-22T15:45:11.604188Z","caller":"traceutil/trace.go:171","msg":"trace[1427217781] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:790; }","duration":"457.791193ms","start":"2026-06-22T15:45:11.146393Z","end":"2026-06-22T15:45:11.604184Z","steps":["trace[1427217781] 'agreement among raft nodes before linearized reading' (duration: 457.769503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.6042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.146379Z","time spent":"457.817664ms","remote":"127.0.0.1:48354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-22T15:45:11.604757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.56724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.604772Z","caller":"traceutil/trace.go:171","msg":"trace[1216133812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:790; }","duration":"168.601992ms","start":"2026-06-22T15:45:11.436166Z","end":"2026-06-22T15:45:11.604768Z","steps":["trace[1216133812] 'agreement among raft nodes before linearized reading' (duration: 168.579931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.604834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.761625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.604848Z","caller":"traceutil/trace.go:171","msg":"trace[541991738] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:790; }","duration":"168.793727ms","start":"2026-06-22T15:45:11.436049Z","end":"2026-06-22T15:45:11.604842Z","steps":["trace[541991738] 'agreement among raft nodes before linearized reading' (duration: 168.775256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.604899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.869658ms","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-06-22T15:45:11.60491Z","caller":"traceutil/trace.go:171","msg":"trace[599717830] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:790; }","duration":"168.90367ms","start":"2026-06-22T15:45:11.436003Z","end":"2026-06-22T15:45:11.604907Z","steps":["trace[599717830] 'agreement among raft nodes before linearized reading' (duration: 168.885739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.604962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.365522ms","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-06-22T15:45:11.604975Z","caller":"traceutil/trace.go:171","msg":"trace[1191310164] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:790; }","duration":"191.379282ms","start":"2026-06-22T15:45:11.413592Z","end":"2026-06-22T15:45:11.604972Z","steps":["trace[1191310164] 'agreement among raft nodes before linearized reading' (duration: 191.359002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.773633ms","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-06-22T15:45:11.605049Z","caller":"traceutil/trace.go:171","msg":"trace[699919744] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:790; }","duration":"191.793704ms","start":"2026-06-22T15:45:11.413251Z","end":"2026-06-22T15:45:11.605045Z","steps":["trace[699919744] 'agreement among raft nodes before linearized reading' (duration: 191.775644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.878346ms","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-06-22T15:45:11.605126Z","caller":"traceutil/trace.go:171","msg":"trace[89231704] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:790; }","duration":"191.911688ms","start":"2026-06-22T15:45:11.413211Z","end":"2026-06-22T15:45:11.605123Z","steps":["trace[89231704] 'agreement among raft nodes before linearized reading' (duration: 191.893157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.185124ms","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-06-22T15:45:11.605199Z","caller":"traceutil/trace.go:171","msg":"trace[1203874433] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:790; }","duration":"432.211255ms","start":"2026-06-22T15:45:11.172984Z","end":"2026-06-22T15:45:11.605195Z","steps":["trace[1203874433] 'agreement among raft nodes before linearized reading' (duration: 432.190254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.172976Z","time spent":"432.232845ms","remote":"127.0.0.1:48360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-22T15:45:11.605289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.780281ms","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-06-22T15:45:11.605301Z","caller":"traceutil/trace.go:171","msg":"trace[1593884648] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:790; }","duration":"458.838402ms","start":"2026-06-22T15:45:11.146459Z","end":"2026-06-22T15:45:11.605297Z","steps":["trace[1593884648] 'agreement among raft nodes before linearized reading' (duration: 458.815802ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.146436Z","time spent":"458.873314ms","remote":"127.0.0.1:48354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-22T15:45:11.605375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.337406ms","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-06-22T15:45:11.605433Z","caller":"traceutil/trace.go:171","msg":"trace[1451838411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:790; }","duration":"346.405488ms","start":"2026-06-22T15:45:11.259012Z","end":"2026-06-22T15:45:11.605417Z","steps":["trace[1451838411] 'agreement among raft nodes before linearized reading' (duration: 346.328786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.607651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T15:45:11.605466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.259005Z","time spent":"346.452189ms","remote":"127.0.0.1:44888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-22T15:45:11.605404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.834276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.605492Z","caller":"traceutil/trace.go:171","msg":"trace[770910259] 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:790; }","duration":"404.95608ms","start":"2026-06-22T15:45:11.20053Z","end":"2026-06-22T15:45:11.605486Z","steps":["trace[770910259] 'agreement among raft nodes before linearized reading' (duration: 404.825176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.480359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T15:45:11.605553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.56993ms","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-06-22T15:45:11.605554Z","caller":"traceutil/trace.go:171","msg":"trace[736704016] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:790; }","duration":"346.577562ms","start":"2026-06-22T15:45:11.258962Z","end":"2026-06-22T15:45:11.60554Z","steps":["trace[736704016] 'agreement among raft nodes before linearized reading' (duration: 346.49592ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:11.605576Z","caller":"traceutil/trace.go:171","msg":"trace[2095414261] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:790; }","duration":"229.613842ms","start":"2026-06-22T15:45:11.375957Z","end":"2026-06-22T15:45:11.605571Z","steps":["trace[2095414261] 'agreement among raft nodes before linearized reading' (duration: 229.577931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.888729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.605655Z","caller":"traceutil/trace.go:171","msg":"trace[693349952] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:790; }","duration":"299.94196ms","start":"2026-06-22T15:45:11.305703Z","end":"2026-06-22T15:45:11.605645Z","steps":["trace[693349952] 'agreement among raft nodes before linearized reading' (duration: 299.898289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.9821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.605733Z","caller":"traceutil/trace.go:171","msg":"trace[187664946] 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:790; }","duration":"405.066872ms","start":"2026-06-22T15:45:11.20065Z","end":"2026-06-22T15:45:11.605717Z","steps":["trace[187664946] 'agreement among raft nodes before linearized reading' (duration: 404.97659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.20064Z","time spent":"405.110544ms","remote":"127.0.0.1:48366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-06-22T15:45:11.605771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.787267ms","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-06-22T15:45:11.605795Z","caller":"traceutil/trace.go:171","msg":"trace[631568715] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:790; }","duration":"320.838219ms","start":"2026-06-22T15:45:11.28495Z","end":"2026-06-22T15:45:11.605789Z","steps":["trace[631568715] 'agreement among raft nodes before linearized reading' (duration: 320.800968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.284934Z","time spent":"320.878671ms","remote":"127.0.0.1:44896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-06-22T15:45:11.60585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.220256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-22T15:45:11.605876Z","caller":"traceutil/trace.go:171","msg":"trace[2114184865] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:790; }","duration":"275.287937ms","start":"2026-06-22T15:45:11.330582Z","end":"2026-06-22T15:45:11.60587Z","steps":["trace[2114184865] 'agreement among raft nodes before linearized reading' (duration: 275.205605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.93737ms","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-06-22T15:45:11.605925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.486997ms","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-06-22T15:45:11.60595Z","caller":"traceutil/trace.go:171","msg":"trace[2035741089] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:790; }","duration":"321.526128ms","start":"2026-06-22T15:45:11.284418Z","end":"2026-06-22T15:45:11.605945Z","steps":["trace[2035741089] 'agreement among raft nodes before linearized reading' (duration: 321.489087ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:11.605966Z","caller":"traceutil/trace.go:171","msg":"trace[1648058393] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:790; }","duration":"230.168367ms","start":"2026-06-22T15:45:11.37573Z","end":"2026-06-22T15:45:11.605898Z","steps":["trace[1648058393] 'agreement among raft nodes before linearized reading' (duration: 229.950281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.284362Z","time spent":"321.6055ms","remote":"127.0.0.1:44896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-22T15:45:11.605993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.679662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.60602Z","caller":"traceutil/trace.go:171","msg":"trace[817477663] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:790; }","duration":"286.720854ms","start":"2026-06-22T15:45:11.319293Z","end":"2026-06-22T15:45:11.606013Z","steps":["trace[817477663] 'agreement among raft nodes before linearized reading' (duration: 286.681033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.605621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.258945Z","time spent":"346.666355ms","remote":"127.0.0.1:44888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-06-22T15:45:11.60607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.661212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T15:45:11.605733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.069643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.60611Z","caller":"traceutil/trace.go:171","msg":"trace[691370554] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:790; }","duration":"321.738134ms","start":"2026-06-22T15:45:11.284366Z","end":"2026-06-22T15:45:11.606104Z","steps":["trace[691370554] 'agreement among raft nodes before linearized reading' (duration: 321.679622ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:11.606125Z","caller":"traceutil/trace.go:171","msg":"trace[1035696602] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:790; }","duration":"274.473824ms","start":"2026-06-22T15:45:11.331645Z","end":"2026-06-22T15:45:11.606119Z","steps":["trace[1035696602] 'agreement among raft nodes before linearized reading' (duration: 274.069863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.28434Z","time spent":"321.784645ms","remote":"127.0.0.1:44896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-06-22T15:45:11.606136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.110184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.606161Z","caller":"traceutil/trace.go:171","msg":"trace[195067808] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:790; }","duration":"287.147386ms","start":"2026-06-22T15:45:11.319007Z","end":"2026-06-22T15:45:11.606155Z","steps":["trace[195067808] 'agreement among raft nodes before linearized reading' (duration: 287.111045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.578047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.606254Z","caller":"traceutil/trace.go:171","msg":"trace[98698185] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"322.623709ms","start":"2026-06-22T15:45:11.283623Z","end":"2026-06-22T15:45:11.606247Z","steps":["trace[98698185] 'agreement among raft nodes before linearized reading' (duration: 322.584408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.283613Z","time spent":"322.655399ms","remote":"127.0.0.1:60004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T15:45:11.605756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.439014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.60547Z","caller":"traceutil/trace.go:171","msg":"trace[1552818935] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:790; }","duration":"299.773276ms","start":"2026-06-22T15:45:11.305687Z","end":"2026-06-22T15:45:11.605461Z","steps":["trace[1552818935] 'agreement among raft nodes before linearized reading' (duration: 299.607151ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:11.606364Z","caller":"traceutil/trace.go:171","msg":"trace[2086527882] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:790; }","duration":"275.057831ms","start":"2026-06-22T15:45:11.3313Z","end":"2026-06-22T15:45:11.606357Z","steps":["trace[2086527882] 'agreement among raft nodes before linearized reading' (duration: 274.444884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.305665Z","time spent":"300.698191ms","remote":"127.0.0.1:44904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-22T15:45:11.606404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.010349ms","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-06-22T15:45:11.606425Z","caller":"traceutil/trace.go:171","msg":"trace[764803873] 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:790; }","duration":"406.03356ms","start":"2026-06-22T15:45:11.200386Z","end":"2026-06-22T15:45:11.60642Z","steps":["trace[764803873] 'agreement among raft nodes before linearized reading' (duration: 406.001989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.200349Z","time spent":"406.085581ms","remote":"127.0.0.1:48366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-06-22T15:45:11.606445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.686898ms","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":"warn","ts":"2026-06-22T15:45:11.605524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.200519Z","time spent":"404.99551ms","remote":"127.0.0.1:48366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-06-22T15:45:11.606467Z","caller":"traceutil/trace.go:171","msg":"trace[1714172606] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:790; }","duration":"432.712509ms","start":"2026-06-22T15:45:11.173748Z","end":"2026-06-22T15:45:11.60646Z","steps":["trace[1714172606] 'agreement among raft nodes before linearized reading' (duration: 432.673648ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.173698Z","time spent":"432.78149ms","remote":"127.0.0.1:48354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-22T15:45:11.605778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.551617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.606542Z","caller":"traceutil/trace.go:171","msg":"trace[647994091] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:790; }","duration":"275.329859ms","start":"2026-06-22T15:45:11.331205Z","end":"2026-06-22T15:45:11.606535Z","steps":["trace[647994091] 'agreement among raft nodes before linearized reading' (duration: 274.561577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.706663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:45:11.606661Z","caller":"traceutil/trace.go:171","msg":"trace[1641978245] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:790; }","duration":"300.108075ms","start":"2026-06-22T15:45:11.306547Z","end":"2026-06-22T15:45:11.606655Z","steps":["trace[1641978245] 'agreement among raft nodes before linearized reading' (duration: 299.718864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.306535Z","time spent":"300.142206ms","remote":"127.0.0.1:44904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-22T15:45:11.606254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.256349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T15:45:11.606734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.686636ms","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-06-22T15:45:11.606741Z","caller":"traceutil/trace.go:171","msg":"trace[1236218902] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:790; }","duration":"287.763213ms","start":"2026-06-22T15:45:11.318972Z","end":"2026-06-22T15:45:11.606736Z","steps":["trace[1236218902] 'agreement among raft nodes before linearized reading' (duration: 287.264049ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:11.606765Z","caller":"traceutil/trace.go:171","msg":"trace[189036579] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:790; }","duration":"433.729077ms","start":"2026-06-22T15:45:11.173027Z","end":"2026-06-22T15:45:11.606756Z","steps":["trace[189036579] 'agreement among raft nodes before linearized reading' (duration: 432.167744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:11.606795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:11.173022Z","time spent":"433.764908ms","remote":"127.0.0.1:48360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-22T15:45:16.515863Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727127701359829,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-22T15:45:17.016647Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727127701359829,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-22T15:45:17.517409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727127701359829,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-22T15:45:17.985564Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.49400891s","expected-duration":"1s"} {"level":"info","ts":"2026-06-22T15:45:17.985874Z","caller":"traceutil/trace.go:171","msg":"trace[873306337] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"2.494441442s","start":"2026-06-22T15:45:15.491413Z","end":"2026-06-22T15:45:17.985854Z","steps":["trace[873306337] 'process raft request' (duration: 2.494292418s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:17.986158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:15.491395Z","time spent":"2.494534815s","remote":"127.0.0.1:60214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:45:18.003164Z","caller":"traceutil/trace.go:171","msg":"trace[1012991186] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:845; }","duration":"1.987973989s","start":"2026-06-22T15:45:16.015162Z","end":"2026-06-22T15:45:18.003136Z","steps":["trace[1012991186] 'read index received' (duration: 1.970543258s)","trace[1012991186] 'applied index is now lower than readState.Index' (duration: 17.42911ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:45:18.003427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.988242936s","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-06-22T15:45:18.003469Z","caller":"traceutil/trace.go:171","msg":"trace[2199818] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:812; }","duration":"1.988318887s","start":"2026-06-22T15:45:16.015135Z","end":"2026-06-22T15:45:18.003454Z","steps":["trace[2199818] 'agreement among raft nodes before linearized reading' (duration: 1.988111011s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:18.003474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.723631386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T15:45:18.003495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:16.015121Z","time spent":"1.988367189s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-22T15:45:18.00351Z","caller":"traceutil/trace.go:171","msg":"trace[116385476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"1.723685208s","start":"2026-06-22T15:45:16.279812Z","end":"2026-06-22T15:45:18.003498Z","steps":["trace[116385476] 'agreement among raft nodes before linearized reading' (duration: 1.723639577s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:18.003544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:16.279794Z","time spent":"1.723742119s","remote":"127.0.0.1:60004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T15:45:18.003427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.906342314s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-22T15:45:18.003628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.642146286s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-22T15:45:18.003721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.847903387s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-06-22T15:45:18.003742Z","caller":"traceutil/trace.go:171","msg":"trace[924525012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:812; }","duration":"1.847955928s","start":"2026-06-22T15:45:16.155781Z","end":"2026-06-22T15:45:18.003736Z","steps":["trace[924525012] 'agreement among raft nodes before linearized reading' (duration: 1.847904327s)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:18.003739Z","caller":"traceutil/trace.go:171","msg":"trace[1261598289] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:812; }","duration":"1.642294649s","start":"2026-06-22T15:45:16.361416Z","end":"2026-06-22T15:45:18.003711Z","steps":["trace[1261598289] 'agreement among raft nodes before linearized reading' (duration: 1.64195206s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:18.003778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:16.155764Z","time spent":"1.848006899s","remote":"127.0.0.1:60244","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-06-22T15:45:18.003809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:16.361397Z","time spent":"1.642398212s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-22T15:45:18.003723Z","caller":"traceutil/trace.go:171","msg":"trace[378029658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:812; }","duration":"1.906667712s","start":"2026-06-22T15:45:16.097Z","end":"2026-06-22T15:45:18.003668Z","steps":["trace[378029658] 'agreement among raft nodes before linearized reading' (duration: 1.906306062s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:18.003863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:16.096981Z","time spent":"1.906877378s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-22T15:45:18.003906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.213220459s","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":"info","ts":"2026-06-22T15:45:18.003949Z","caller":"traceutil/trace.go:171","msg":"trace[648137159] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:812; }","duration":"1.213287661s","start":"2026-06-22T15:45:16.790651Z","end":"2026-06-22T15:45:18.003939Z","steps":["trace[648137159] 'agreement among raft nodes before linearized reading' (duration: 1.213213339s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:18.003938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.680553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-22T15:45:18.003999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:16.790636Z","time spent":"1.213344472s","remote":"127.0.0.1:60310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-06-22T15:45:18.00401Z","caller":"traceutil/trace.go:171","msg":"trace[1629047093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"428.814527ms","start":"2026-06-22T15:45:17.575176Z","end":"2026-06-22T15:45:18.00399Z","steps":["trace[1629047093] 'agreement among raft nodes before linearized reading' (duration: 428.644223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:18.004075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:17.57516Z","time spent":"428.899979ms","remote":"127.0.0.1:60004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T15:45:18.004573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.848666457s","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-06-22T15:45:18.005441Z","caller":"traceutil/trace.go:171","msg":"trace[1815270407] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:812; }","duration":"1.849570531s","start":"2026-06-22T15:45:16.155855Z","end":"2026-06-22T15:45:18.005425Z","steps":["trace[1815270407] 'agreement among raft nodes before linearized reading' (duration: 1.848125673s)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:18.005501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:16.15584Z","time spent":"1.849650253s","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-22T15:45:20.65987Z","caller":"traceutil/trace.go:171","msg":"trace[1686613408] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"147.949064ms","start":"2026-06-22T15:45:20.511899Z","end":"2026-06-22T15:45:20.659848Z","steps":["trace[1686613408] 'process raft request' (duration: 147.77771ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:25.680962Z","caller":"traceutil/trace.go:171","msg":"trace[1979729586] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"222.409074ms","start":"2026-06-22T15:45:25.458532Z","end":"2026-06-22T15:45:25.680941Z","steps":["trace[1979729586] 'process raft request' (duration: 222.24403ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:25.68482Z","caller":"traceutil/trace.go:171","msg":"trace[63416969] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"182.118899ms","start":"2026-06-22T15:45:25.502685Z","end":"2026-06-22T15:45:25.684804Z","steps":["trace[63416969] 'process raft request' (duration: 182.029707ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:25.882812Z","caller":"traceutil/trace.go:171","msg":"trace[1617496978] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:921; }","duration":"139.479867ms","start":"2026-06-22T15:45:25.743312Z","end":"2026-06-22T15:45:25.882792Z","steps":["trace[1617496978] 'read index received' (duration: 129.294814ms)","trace[1617496978] 'applied index is now lower than readState.Index' (duration: 10.183913ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:45:25.883004Z","caller":"traceutil/trace.go:171","msg":"trace[1741923310] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"196.15835ms","start":"2026-06-22T15:45:25.686833Z","end":"2026-06-22T15:45:25.882991Z","steps":["trace[1741923310] 'process raft request' (duration: 185.763661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:25.882985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.655703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-l845d\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-06-22T15:45:25.883051Z","caller":"traceutil/trace.go:171","msg":"trace[501423098] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-l845d; range_end:; response_count:1; response_revision:887; }","duration":"139.732105ms","start":"2026-06-22T15:45:25.743305Z","end":"2026-06-22T15:45:25.883037Z","steps":["trace[501423098] 'agreement among raft nodes before linearized reading' (duration: 139.575101ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:25.883092Z","caller":"traceutil/trace.go:171","msg":"trace[440307921] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"191.456543ms","start":"2026-06-22T15:45:25.691606Z","end":"2026-06-22T15:45:25.883063Z","steps":["trace[440307921] 'process raft request' (duration: 191.109895ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:25.885972Z","caller":"traceutil/trace.go:171","msg":"trace[1185416154] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"141.256042ms","start":"2026-06-22T15:45:25.744703Z","end":"2026-06-22T15:45:25.885959Z","steps":["trace[1185416154] 'process raft request' (duration: 141.16057ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:26.723748Z","caller":"traceutil/trace.go:171","msg":"trace[674184841] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"194.881643ms","start":"2026-06-22T15:45:26.528845Z","end":"2026-06-22T15:45:26.723726Z","steps":["trace[674184841] 'process raft request' (duration: 194.76134ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:26.758285Z","caller":"traceutil/trace.go:171","msg":"trace[16981193] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"224.614339ms","start":"2026-06-22T15:45:26.533295Z","end":"2026-06-22T15:45:26.75791Z","steps":["trace[16981193] 'process raft request' (duration: 224.425655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:31.821525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.683263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T15:45:31.821828Z","caller":"traceutil/trace.go:171","msg":"trace[1751598727] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"195.881703ms","start":"2026-06-22T15:45:31.625914Z","end":"2026-06-22T15:45:31.821796Z","steps":["trace[1751598727] 'process raft request' (duration: 72.834791ms)","trace[1751598727] 'compare' (duration: 122.55026ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:45:31.822223Z","caller":"traceutil/trace.go:171","msg":"trace[913450791] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"118.303889ms","start":"2026-06-22T15:45:31.703901Z","end":"2026-06-22T15:45:31.822205Z","steps":["trace[913450791] 'process raft request' (duration: 117.752926ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:36.349878Z","caller":"traceutil/trace.go:171","msg":"trace[1785309952] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"208.304349ms","start":"2026-06-22T15:45:36.141553Z","end":"2026-06-22T15:45:36.349858Z","steps":["trace[1785309952] 'process raft request' (duration: 208.244888ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:36.349905Z","caller":"traceutil/trace.go:171","msg":"trace[1103934836] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"208.36357ms","start":"2026-06-22T15:45:36.141497Z","end":"2026-06-22T15:45:36.349861Z","steps":["trace[1103934836] 'process raft request' (duration: 186.823672ms)","trace[1103934836] 'compare' (duration: 21.401745ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:45:36.350088Z","caller":"traceutil/trace.go:171","msg":"trace[845108389] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"205.691709ms","start":"2026-06-22T15:45:36.144361Z","end":"2026-06-22T15:45:36.350053Z","steps":["trace[845108389] 'process raft request' (duration: 205.466503ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:46:38.620273Z","caller":"traceutil/trace.go:171","msg":"trace[646838242] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"128.173728ms","start":"2026-06-22T15:46:38.492073Z","end":"2026-06-22T15:46:38.620247Z","steps":["trace[646838242] 'process raft request' (duration: 127.72164ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:46:40.24049Z","caller":"traceutil/trace.go:171","msg":"trace[1045808652] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"113.019884ms","start":"2026-06-22T15:46:40.127452Z","end":"2026-06-22T15:46:40.240472Z","steps":["trace[1045808652] 'process raft request' (duration: 112.900512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:42.762025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.016918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T15:46:42.762166Z","caller":"traceutil/trace.go:171","msg":"trace[766035006] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1224; }","duration":"128.19311ms","start":"2026-06-22T15:46:42.633951Z","end":"2026-06-22T15:46:42.762144Z","steps":["trace[766035006] 'range keys from in-memory index tree' (duration: 127.890836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:42.762306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.450729ms","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-06-22T15:46:42.762378Z","caller":"traceutil/trace.go:171","msg":"trace[60279109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1224; }","duration":"110.572201ms","start":"2026-06-22T15:46:42.651788Z","end":"2026-06-22T15:46:42.762361Z","steps":["trace[60279109] 'range keys from in-memory index tree' (duration: 110.318246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:42.762589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.477007ms","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-06-22T15:46:42.762689Z","caller":"traceutil/trace.go:171","msg":"trace[185109002] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1224; }","duration":"131.600708ms","start":"2026-06-22T15:46:42.631073Z","end":"2026-06-22T15:46:42.762674Z","steps":["trace[185109002] 'range keys from in-memory index tree' (duration: 131.360204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:42.762736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.887985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T15:46:42.762781Z","caller":"traceutil/trace.go:171","msg":"trace[1922109919] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1224; }","duration":"107.946796ms","start":"2026-06-22T15:46:42.654822Z","end":"2026-06-22T15:46:42.762768Z","steps":["trace[1922109919] 'range keys from in-memory index tree' (duration: 107.798983ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:46:43.145784Z","caller":"traceutil/trace.go:171","msg":"trace[33832500] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"376.054097ms","start":"2026-06-22T15:46:42.769711Z","end":"2026-06-22T15:46:43.145765Z","steps":["trace[33832500] 'process raft request' (duration: 374.382148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:43.145897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:46:42.769706Z","time spent":"376.131598ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:46:43.145922Z","caller":"traceutil/trace.go:171","msg":"trace[1892031272] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"373.266469ms","start":"2026-06-22T15:46:42.772637Z","end":"2026-06-22T15:46:43.145903Z","steps":["trace[1892031272] 'process raft request' (duration: 373.152057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:43.146041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:46:42.772624Z","time spent":"373.356641ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:46:58.982638Z","caller":"traceutil/trace.go:171","msg":"trace[496789146] linearizableReadLoop","detail":"{readStateIndex:1333; appliedIndex:1332; }","duration":"126.102591ms","start":"2026-06-22T15:46:58.856517Z","end":"2026-06-22T15:46:58.98262Z","steps":["trace[496789146] 'read index received' (duration: 125.894857ms)","trace[496789146] 'applied index is now lower than readState.Index' (duration: 206.844µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:46:58.982706Z","caller":"traceutil/trace.go:171","msg":"trace[445358983] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"129.75788ms","start":"2026-06-22T15:46:58.852919Z","end":"2026-06-22T15:46:58.982676Z","steps":["trace[445358983] 'process raft request' (duration: 129.570787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:58.982825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.290204ms","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-06-22T15:46:58.982854Z","caller":"traceutil/trace.go:171","msg":"trace[628109045] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1278; }","duration":"126.365835ms","start":"2026-06-22T15:46:58.85648Z","end":"2026-06-22T15:46:58.982845Z","steps":["trace[628109045] 'agreement among raft nodes before linearized reading' (duration: 126.242263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:58.982933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.100234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T15:46:58.983007Z","caller":"traceutil/trace.go:171","msg":"trace[1526201222] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1278; }","duration":"125.169046ms","start":"2026-06-22T15:46:58.857818Z","end":"2026-06-22T15:46:58.982987Z","steps":["trace[1526201222] 'agreement among raft nodes before linearized reading' (duration: 125.034793ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:01.751093Z","caller":"traceutil/trace.go:171","msg":"trace[433912798] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"211.28344ms","start":"2026-06-22T15:47:01.539791Z","end":"2026-06-22T15:47:01.751074Z","steps":["trace[433912798] 'process raft request' (duration: 211.180548ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:02.399222Z","caller":"traceutil/trace.go:171","msg":"trace[1544125389] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"130.634993ms","start":"2026-06-22T15:47:02.268562Z","end":"2026-06-22T15:47:02.399197Z","steps":["trace[1544125389] 'process raft request' (duration: 72.090571ms)","trace[1544125389] 'compare' (duration: 58.37409ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:47:02.399386Z","caller":"traceutil/trace.go:171","msg":"trace[460594442] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1349; }","duration":"129.491285ms","start":"2026-06-22T15:47:02.269885Z","end":"2026-06-22T15:47:02.399377Z","steps":["trace[460594442] 'read index received' (duration: 70.78029ms)","trace[460594442] 'applied index is now lower than readState.Index' (duration: 58.709935ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:47:02.399659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.226193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:47:02.399721Z","caller":"traceutil/trace.go:171","msg":"trace[810911180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1294; }","duration":"118.320385ms","start":"2026-06-22T15:47:02.281384Z","end":"2026-06-22T15:47:02.399705Z","steps":["trace[810911180] 'agreement among raft nodes before linearized reading' (duration: 118.163402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:02.399799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.882272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1490"} {"level":"info","ts":"2026-06-22T15:47:02.399879Z","caller":"traceutil/trace.go:171","msg":"trace[120099564] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1294; }","duration":"129.997593ms","start":"2026-06-22T15:47:02.269851Z","end":"2026-06-22T15:47:02.399849Z","steps":["trace[120099564] 'agreement among raft nodes before linearized reading' (duration: 129.619787ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:02.524425Z","caller":"traceutil/trace.go:171","msg":"trace[1634966293] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"120.787944ms","start":"2026-06-22T15:47:02.403618Z","end":"2026-06-22T15:47:02.524406Z","steps":["trace[1634966293] 'process raft request' (duration: 119.989981ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:02.723319Z","caller":"traceutil/trace.go:171","msg":"trace[1446427797] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"126.223353ms","start":"2026-06-22T15:47:02.597074Z","end":"2026-06-22T15:47:02.723298Z","steps":["trace[1446427797] 'read index received' (duration: 116.229092ms)","trace[1446427797] 'applied index is now lower than readState.Index' (duration: 9.99318ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:47:02.723488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.380435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:47:02.723548Z","caller":"traceutil/trace.go:171","msg":"trace[1720042411] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:1297; }","duration":"126.482766ms","start":"2026-06-22T15:47:02.597049Z","end":"2026-06-22T15:47:02.723532Z","steps":["trace[1720042411] 'agreement among raft nodes before linearized reading' (duration: 126.323364ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:02.723757Z","caller":"traceutil/trace.go:171","msg":"trace[887437074] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"127.147797ms","start":"2026-06-22T15:47:02.596552Z","end":"2026-06-22T15:47:02.7237Z","steps":["trace[887437074] 'process raft request' (duration: 116.826561ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:05.26439Z","caller":"traceutil/trace.go:171","msg":"trace[1589442959] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"129.538011ms","start":"2026-06-22T15:47:05.134822Z","end":"2026-06-22T15:47:05.26436Z","steps":["trace[1589442959] 'process raft request' (duration: 110.810861ms)","trace[1589442959] 'compare' (duration: 18.593288ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:47:06.98751Z","caller":"traceutil/trace.go:171","msg":"trace[1972559019] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"131.01686ms","start":"2026-06-22T15:47:06.856476Z","end":"2026-06-22T15:47:06.987492Z","steps":["trace[1972559019] 'process raft request' (duration: 130.896628ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:09.436952Z","caller":"traceutil/trace.go:171","msg":"trace[317825995] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"115.214006ms","start":"2026-06-22T15:47:09.321717Z","end":"2026-06-22T15:47:09.436931Z","steps":["trace[317825995] 'process raft request' (duration: 113.848614ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:10.252605Z","caller":"traceutil/trace.go:171","msg":"trace[1031685906] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1334; }","duration":"378.170224ms","start":"2026-06-22T15:47:09.87436Z","end":"2026-06-22T15:47:10.25253Z","steps":["trace[1031685906] 'process raft request' (duration: 289.271918ms)","trace[1031685906] 'compare' (duration: 88.768954ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:47:10.252838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:47:09.874342Z","time spent":"378.339916ms","remote":"127.0.0.1:60180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":96,"response count":0,"response size":3934,"request content":"compare: success: > failure: >"} {"level":"warn","ts":"2026-06-22T15:47:19.782729Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471727127701361193,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-22T15:47:19.783613Z","caller":"traceutil/trace.go:171","msg":"trace[1981515852] linearizableReadLoop","detail":"{readStateIndex:1443; appliedIndex:1442; }","duration":"501.070229ms","start":"2026-06-22T15:47:19.282524Z","end":"2026-06-22T15:47:19.783594Z","steps":["trace[1981515852] 'read index received' (duration: 500.899086ms)","trace[1981515852] 'applied index is now lower than readState.Index' (duration: 170.503µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:47:19.783844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.294312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:47:19.784195Z","caller":"traceutil/trace.go:171","msg":"trace[1636070361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1382; }","duration":"501.665779ms","start":"2026-06-22T15:47:19.282505Z","end":"2026-06-22T15:47:19.784171Z","steps":["trace[1636070361] 'agreement among raft nodes before linearized reading' (duration: 501.259412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:19.784336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:47:19.282498Z","time spent":"501.822131ms","remote":"127.0.0.1:60004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-22T15:47:19.783927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.487294ms","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-06-22T15:47:19.78451Z","caller":"traceutil/trace.go:171","msg":"trace[273228943] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1382; }","duration":"460.119114ms","start":"2026-06-22T15:47:19.324383Z","end":"2026-06-22T15:47:19.784502Z","steps":["trace[273228943] 'agreement among raft nodes before linearized reading' (duration: 459.455064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:19.784541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:47:19.324366Z","time spent":"460.163584ms","remote":"127.0.0.1:60244","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-06-22T15:47:19.783976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.475538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-22T15:47:19.784622Z","caller":"traceutil/trace.go:171","msg":"trace[667792844] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1382; }","duration":"410.162569ms","start":"2026-06-22T15:47:19.374448Z","end":"2026-06-22T15:47:19.78461Z","steps":["trace[667792844] 'agreement among raft nodes before linearized reading' (duration: 409.500818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:19.784652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:47:19.374427Z","time spent":"410.216159ms","remote":"127.0.0.1:60404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-22T15:47:19.784002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.36494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:47:19.784698Z","caller":"traceutil/trace.go:171","msg":"trace[297289506] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1382; }","duration":"427.093681ms","start":"2026-06-22T15:47:19.357599Z","end":"2026-06-22T15:47:19.784693Z","steps":["trace[297289506] 'agreement among raft nodes before linearized reading' (duration: 426.38756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:19.78472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:47:19.357582Z","time spent":"427.132051ms","remote":"127.0.0.1:60268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":0,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-22T15:47:19.784051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.148647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-22T15:47:19.784828Z","caller":"traceutil/trace.go:171","msg":"trace[196849070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1382; }","duration":"142.949329ms","start":"2026-06-22T15:47:19.64187Z","end":"2026-06-22T15:47:19.784819Z","steps":["trace[196849070] 'agreement among raft nodes before linearized reading' (duration: 142.147616ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:19.784036Z","caller":"traceutil/trace.go:171","msg":"trace[2066854672] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"522.364909ms","start":"2026-06-22T15:47:19.261643Z","end":"2026-06-22T15:47:19.784008Z","steps":["trace[2066854672] 'process raft request' (duration: 521.825161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:19.784978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:47:19.261625Z","time spent":"523.310785ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:47:19.784098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.198072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-22T15:47:19.785043Z","caller":"traceutil/trace.go:171","msg":"trace[1605725] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1382; }","duration":"274.169816ms","start":"2026-06-22T15:47:19.510866Z","end":"2026-06-22T15:47:19.785036Z","steps":["trace[1605725] 'agreement among raft nodes before linearized reading' (duration: 273.200171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:19.784104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.236092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-22T15:47:19.785127Z","caller":"traceutil/trace.go:171","msg":"trace[1874857190] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1382; }","duration":"303.331319ms","start":"2026-06-22T15:47:19.481785Z","end":"2026-06-22T15:47:19.785116Z","steps":["trace[1874857190] 'agreement among raft nodes before linearized reading' (duration: 302.174611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:19.785163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:47:19.481693Z","time spent":"303.459071ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-22T15:47:32.082848Z","caller":"traceutil/trace.go:171","msg":"trace[1158460306] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"120.46101ms","start":"2026-06-22T15:47:31.962365Z","end":"2026-06-22T15:47:32.082826Z","steps":["trace[1158460306] 'process raft request' (duration: 120.439939ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:32.082939Z","caller":"traceutil/trace.go:171","msg":"trace[702729615] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"121.347803ms","start":"2026-06-22T15:47:31.961544Z","end":"2026-06-22T15:47:32.082891Z","steps":["trace[702729615] 'process raft request' (duration: 77.607559ms)","trace[702729615] 'compare' (duration: 43.205196ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:47:32.083022Z","caller":"traceutil/trace.go:171","msg":"trace[1658305495] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"120.748874ms","start":"2026-06-22T15:47:31.962267Z","end":"2026-06-22T15:47:32.083016Z","steps":["trace[1658305495] 'process raft request' (duration: 120.458029ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:32.083093Z","caller":"traceutil/trace.go:171","msg":"trace[650056088] transaction","detail":"{read_only:false; response_revision:1429; number_of_response:1; }","duration":"120.727334ms","start":"2026-06-22T15:47:31.96236Z","end":"2026-06-22T15:47:32.083088Z","steps":["trace[650056088] 'process raft request' (duration: 120.427329ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:51.081808Z","caller":"traceutil/trace.go:171","msg":"trace[1628150158] linearizableReadLoop","detail":"{readStateIndex:1559; appliedIndex:1558; }","duration":"190.073742ms","start":"2026-06-22T15:47:50.891714Z","end":"2026-06-22T15:47:51.081787Z","steps":["trace[1628150158] 'read index received' (duration: 189.885599ms)","trace[1628150158] 'applied index is now lower than readState.Index' (duration: 187.243µs)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:47:51.081869Z","caller":"traceutil/trace.go:171","msg":"trace[1993316819] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"191.95921ms","start":"2026-06-22T15:47:50.889887Z","end":"2026-06-22T15:47:51.081846Z","steps":["trace[1993316819] 'process raft request' (duration: 191.780617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:47:51.082113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.383036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329964"} {"level":"warn","ts":"2026-06-22T15:47:51.082138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.459975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-dns\" ","response":"range_response_count:1 size:1211"} {"level":"info","ts":"2026-06-22T15:47:51.082154Z","caller":"traceutil/trace.go:171","msg":"trace[1354415708] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1491; }","duration":"190.451677ms","start":"2026-06-22T15:47:50.89169Z","end":"2026-06-22T15:47:51.082142Z","steps":["trace[1354415708] 'agreement among raft nodes before linearized reading' (duration: 190.217884ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:51.082187Z","caller":"traceutil/trace.go:171","msg":"trace[1208272227] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-dns; range_end:; response_count:1; response_revision:1491; }","duration":"125.539127ms","start":"2026-06-22T15:47:50.956633Z","end":"2026-06-22T15:47:51.082172Z","steps":["trace[1208272227] 'agreement among raft nodes before linearized reading' (duration: 125.445295ms)"],"step_count":1}